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/26 14:05:37 UTC

[JENKINS] Lucene-Solr-6.x-MacOSX (64bit/jdk1.8.0) - Build # 495 - Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-MacOSX/495/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseSerialGC

6 tests failed.
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([5406614593851AC3:88C6C833FE04BE09]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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(Thread.java:745)


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([5406614593851AC3:88C6C833FE04BE09]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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(Thread.java:745)


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([5406614593851AC3:88C6C833FE04BE09]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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(Thread.java:745)


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([5406614593851AC3:88C6C833FE04BE09]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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(Thread.java:745)


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([5406614593851AC3:88C6C833FE04BE09]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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(Thread.java:745)


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([5406614593851AC3:88C6C833FE04BE09]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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(Thread.java:745)




Build Log:
[...truncated 11374 lines...]
   [junit4] Suite: org.apache.solr.search.facet.TestJsonFacets
   [junit4]   2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_5406614593851AC3-001/init-core-data-001
   [junit4]   2> 1271475 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None) w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 1271556 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1271556 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/src/test-files/solr/collection1/lib, /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1271608 WARN  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1271609 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1271622 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=example
   [junit4]   2> 1271670 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 1271684 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1271687 INFO  (coreLoadExecutor-5114-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/src/test-files/solr/collection1/lib, /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1271705 WARN  (coreLoadExecutor-5114-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1271706 INFO  (coreLoadExecutor-5114-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 1271716 INFO  (coreLoadExecutor-5114-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 1271762 INFO  (coreLoadExecutor-5114-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id
   [junit4]   2> 1271772 INFO  (coreLoadExecutor-5114-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1271773 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/src/test-files/solr/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_5406614593851AC3-001/init-core-data-001/]
   [junit4]   2> 1271773 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@75a55be5
   [junit4]   2> 1271774 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=34, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=37.943359375, floorSegmentMB=1.3857421875, forceMergeDeletesPctAllowed=7.686628786268552, segmentsPerTier=4.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.34623968381682324
   [junit4]   2> 1271777 WARN  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
   [junit4]   2> 1271786 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1271786 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1271787 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1271787 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1271787 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=30, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.3212890625, noCFSRatio=0.0]
   [junit4]   2> 1271788 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7955c7d9[collection1] main]
   [junit4]   2> 1271788 WARN  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 1271788 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1271789 INFO  (searcherExecutor-5115-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7955c7d9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1271789 INFO  (coreLoadExecutor-5114-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1549257184833961984
   [junit4]   2> 1271792 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1271795 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStats {p0=SMART}
   [junit4]   2> 1271802 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1549257184845496320)} 0 1
   [junit4]   2> 1271804 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1 (1549257184848642048)]} 0 0
   [junit4]   2> 1271804 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1 (1549257184849690624)]} 0 0
   [junit4]   2> 1271804 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1 (1549257184849690625)]} 0 0
   [junit4]   2> 1271805 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2 (1549257184849690626)]} 0 0
   [junit4]   2> 1271805 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3 (1549257184850739200)]} 0 0
   [junit4]   2> 1271805 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1271805 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1dc6de35
   [junit4]   2> 1271809 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f724006[collection1] main]
   [junit4]   2> 1271809 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1271810 INFO  (searcherExecutor-5115-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f724006[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.3.0):c5/2:delGen=1)))}
   [junit4]   2> 1271810 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 5
   [junit4]   2> 1271812 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4 (1549257184857030656)]} 0 1
   [junit4]   2> 1271813 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5 (1549257184858079232)]} 0 0
   [junit4]   2> 1271813 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1271813 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1dc6de35
   [junit4]   2> 1271816 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@395ae713[collection1] main]
   [junit4]   2> 1271816 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1271817 INFO  (searcherExecutor-5115-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@395ae713[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.3.0):c5/2:delGen=1) Uninverting(_1(6.3.0):c2)))}
   [junit4]   2> 1271817 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 4
   [junit4]   2> 1271819 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6 (1549257184863322112)]} 0 1
   [junit4]   2> 1271819 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1271819 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1dc6de35
   [junit4]   2> 1271821 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7fb3f2b5[collection1] main]
   [junit4]   2> 1271822 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1271823 INFO  (searcherExecutor-5115-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7fb3f2b5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.3.0):c5/2:delGen=1) Uninverting(_1(6.3.0):c2) Uninverting(_2(6.3.0):c1)))}
   [junit4]   2> 1271823 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 4
   [junit4]   2> 1271855 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=true&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={catA:{query:{q:'${cat_s}:A'}},++catA2:{query:{query:'${cat_s}:A'}},++catA3:{query:'${cat_s}:A'}++++}&wt=json&indent=true} hits=6 status=0 QTime=31
   [junit4]   2> 1271862 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={catA:{query:{q:'${cat_s}:A'}},++catA2:{query:{query:'${cat_s}:A'}},++catA3:{query:'${cat_s}:A'}++++}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1271863 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+catB:{type:query,+q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1271866 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:(2+3)&json.facet={+catB:{query:{q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+}}}&wt=json&indent=true} hits=2 status=0 QTime=3
   [junit4]   2> 1271867 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+catB:{query:{q:'${cat_s}:B',+facet:{nj:{query:{q:'${where_s}:NJ'}},+ny:{query:'${where_s}:NY'}}+}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1271928 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={c1:{field:'${cat_s}'},+c2:{field:{field:'${cat_s}'}},+c3:{${terms}+type:terms,+field:'${cat_s}'}++}&wt=json&indent=true} hits=6 status=0 QTime=61
   [junit4]   2> 1271929 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:'${cat_s}',+mincount:3}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1271929 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:1&json.facet={f1:{terms:'${cat_s}'}}&wt=json&indent=true} hits=1 status=0 QTime=0
   [junit4]   2> 1271930 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:1&json.facet={processEmpty:true,+f1:{terms:{${terms}+field:'${cat_s}',+mincount:0}}}&wt=json&indent=true} hits=1 status=0 QTime=0
   [junit4]   2> 1271949 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:1&json.facet={processEmpty:true,+f1:{terms:{${terms}+field:'${cat_s}',+mincount:0,+allBuckets:true,+facet:{n1:'sum(${num_d})'}++}}}&wt=json&indent=true} hits=1 status=0 QTime=19
   [junit4]   2> 1271951 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:'${cat_s}',+sort:'n1+desc',+facet:{n1:'sum(${num_d})'}++}}+,+f2:{terms:{${terms}+field:'${cat_s}',+sort:'n1+asc',+facet:{n1:'sum(${num_d})'}++}}+}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1271989 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{${terms}+type:terms,+field:'${cat_s}',+sort:'x+desc',+facet:{x:'min(${num_d})'}++}+,+f2:{${terms}+type:terms,+field:'${cat_s}',+sort:'x+desc',+facet:{x:'max(${num_d})'}++}++,+f3:{${terms}+type:terms,+field:'${cat_s}',+sort:'x+desc',+facet:{x:'unique(${where_s})'}++}++,+f4:{${terms}+type:terms,+field:'${cat_s}',+sort:'x+desc',+facet:{x:'hll(${where_s})'}++}+}&wt=json&indent=true} hits=6 status=0 QTime=37
   [junit4]   2> 1271997 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:'${cat_s}',+sort:'n1+desc',+facet:{n1:'avg(add(${num_d},${num_d}))'}++}}+,+f2:{terms:{${terms}+field:'${cat_s}',+sort:'n1+asc',+facet:{n1:'avg(add(${num_d},${num_d}))'}++}}+}&wt=json&indent=true} hits=6 status=0 QTime=7
   [junit4]   2> 1272021 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:'${cat_s}',+sort:'n1+desc',+facet:{n1:'percentile(${num_d},50)'}++}}+,+f2:{terms:{${terms}+field:'${cat_s}',+sort:'n1+asc',+facet:{n1:'percentile(${num_d},50)'}++}}+}&wt=json&indent=true} hits=6 status=0 QTime=23
   [junit4]   2> 1272022 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${cat_s},+sort:'n1+desc',+facet:{n1:'percentile(${num_d},50,0,100)'}++}}+,+f2:{terms:{${terms}+field:${cat_s},+sort:'n1+asc',+facet:{n1:'percentile(${num_d},50,0,100)'}++}}+}&wt=json&indent=true} hits=6 status=0 QTime=1
   [junit4]   2> 1272023 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:'${cat_s}',+sort:'count+desc'+}++}+++++++++++,+f2:{terms:{${terms}+field:'${cat_s}',+sort:'count+asc'++}++}+++++++++++,+f3:{terms:{${terms}+field:'${cat_s}',+sort:'index+asc'++}++}+++++++++++,+f4:{terms:{${terms}+field:'${cat_s}',+sort:'index+desc'+}++}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272024 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:'${cat_s}',+sort:'count'+}++}+++++++++++,+f2:{terms:{${terms}+field:'${cat_s}',+sort:'count+asc'++}++}+++++++++++,+f3:{terms:{${terms}+field:'${cat_s}',+sort:'index'++}++}+++++++++++,+f4:{terms:{${terms}+field:'${cat_s}',+sort:'index+desc'+}++}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272025 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:1+id:6&json.facet={f1:{terms:{${terms}+field:'${cat_s}',+sort:'count+desc'+}++}+++++++++++,+f2:{terms:{${terms}+field:'${cat_s}',+sort:'count+asc'++}++}}&wt=json&indent=true} hits=2 status=0 QTime=0
   [junit4]   2> 1272025 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={cat:{terms:{${terms}+field:'${cat_s}',+facet:{nj:{query:'${where_s}:NJ'}}++++}+++}}+}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272026 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:(2+5+4)&json.facet={cat:{terms:{${terms}+field:'${cat_s}',+facet:{nj:{query:'${where_s}:NJ'}}++++}+++}}+}&wt=json&indent=true} hits=3 status=0 QTime=0
   [junit4]   2> 1272026 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${super_s},+prefix:s,+mincount:0+}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272027 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${super_s},+prefix:ttt,+mincount:0+}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272027 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${super_s},+prefix:aaaaaa,+mincount:0+}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272028 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${super_s},+prefix:zzzzzz,+mincount:0+}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272028 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+f1:{${terms}+type:terms,+field:${where_s},+prefix:N++},f2:{${terms}+type:terms,+field:${where_s},+prefix:NY+},f3:{${terms}+type:terms,+field:${where_s},+prefix:NJ+}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272040 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.f.UnInvertedField UnInverted multi-valued field {field=multi_ss,memSize=4515,tindexSize=41,time=2,phase1=2,nTerms=2,bigTerms=2,termInstances=0,uses=0}
   [junit4]   2> 1272041 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+f1:{${terms}+type:terms,+field:${multi_ss},+prefix:A++},f2:{${terms}+type:terms,+field:${multi_ss},+prefix:z+},f3:{${terms}+type:terms,+field:${multi_ss},+prefix:aa+},f4:{${terms}+type:terms,+field:${multi_ss},+prefix:bb+},f5:{${terms}+type:terms,+field:${multi_ss},+prefix:a+},f6:{${terms}+type:terms,+field:${multi_ss},+prefix:b+}}&wt=json&indent=true} hits=6 status=0 QTime=12
   [junit4]   2> 1272042 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${noexist},+missing:true}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272043 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${sparse_s},+missing:true+}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272043 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${sparse_s},+missing:true,+facet:{x:'sum(${num_d})'}+++}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272043 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${sparse_s},+missing:true,+prefix:on,+facet:{x:'sum(${num_d})'}+++}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272044 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f1:{terms:{${terms}+field:${sparse_s},+missing:true,+prefix:ppp,+facet:{x:'sum(${num_d})'}+++}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272044 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&facet=true&json.facet={f1:{terms:{${terms}+field:${cat_s},+numBuckets:true,+limit:1}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272045 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&facet=true&json.facet={f1:{terms:{${terms}+field:${cat_s},+numBuckets:true,+prefix:B}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272045 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&facet=true&json.facet={f1:{terms:{${terms}+field:${cat_s},+numBuckets:true,+mincount:3}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272117 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f:{type:range,+field:${num_d},+start:-5,+end:10,+gap:5}}&wt=json&indent=true} hits=6 status=0 QTime=71
   [junit4]   2> 1272118 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f:{type:range,+field:${date},+start:'2001-01-01T00:00:00Z',+end:'2003-01-01T00:00:00Z',+gap:'%2B1YEAR'}}&wt=json&indent=true} hits=6 status=0 QTime=1
   [junit4]   2> 1272119 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f:{type:range,+field:${date},+start:'2002-01-01T00:00:00Z',+end:'2005-01-01T00:00:00Z',+gap:'%2B1YEAR',+++other:all,+facet:{+x:'avg(${num_d})'+}+}+}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272120 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f:{range:{field:${num_d},+start:-5,+end:10,+gap:5,+include:upper}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272121 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f:{range:{field:${num_d},+start:-5,+end:10,+gap:5,+++facet:{+x:'sum(${num_i})',+ny:{query:'${where_s}:NY'}}+++}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272121 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f:{range:{field:${num_d},+start:-5,+end:10,+gap:5,+other:all,+++facet:{+x:'sum(${num_i})',+ny:{query:'${where_s}:NY'}}+++}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272121 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={f:{type:range,+field:${num_d},+start:-5,+end:10,+gap:5,+other:all,+mincount:2,++++facet:{+x:'sum(${num_i})',+ny:{query:'${where_s}:NY'}}+++}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272122 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:(3+4+6)&json.facet={f:{range:{field:${num_d},+start:-5,+end:10,+gap:5,+other:all,+++facet:{+x:'sum(${num_i})',+ny:{query:'${where_s}:NY'}}+++}}}&wt=json&indent=true} hits=3 status=0 QTime=0
   [junit4]   2> 1272182 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+sum1:'sum(${num_d})',+sumsq1:'sumsq(${num_d})',+avg1:'avg(${num_d})',+avg2:'avg(def(${num_d},0))',+min1:'min(${num_d})',+max1:'max(${num_d})',+numwhere:'unique(${where_s})',+unique_num_i:'unique(${num_i})',+unique_num_d:'unique(${num_d})',+unique_date:'unique(${date})',+where_hll:'hll(${where_s})',+hll_num_i:'hll(${num_i})',+hll_num_d:'hll(${num_d})',+hll_date:'hll(${date})',+med:'percentile(${num_d},50)',+perc:'percentile(${num_d},0,50.0,100)'+}&wt=json&indent=true} hits=6 status=0 QTime=59
   [junit4]   2> 1272183 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:DOESNOTEXIST&json.facet={+sum1:'sum(${num_d})',+sumsq1:'sumsq(${num_d})',+avg1:'avg(${num_d})',+min1:'min(${num_d})',+max1:'max(${num_d})',+numwhere:'unique(${where_s})',+unique_num_i:'unique(${num_i})',+unique_num_d:'unique(${num_d})',+unique_date:'unique(${date})',+where_hll:'hll(${where_s})',+hll_num_i:'hll(${num_i})',+hll_num_d:'hll(${num_d})',+hll_date:'hll(${date})',+med:'percentile(${num_d},50)',+perc:'percentile(${num_d},0,50.0,100)'+}&wt=json&indent=true} hits=0 status=0 QTime=0
   [junit4]   2> 1272183 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={cat:{terms:{${terms}+field:'${multi_ss}',+facet:{nj:{query:'${where_s}:NJ'}}++++}+++}}+}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272189 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={x:'unique(${multi_ss})',y:{query:{q:'id:2',+facet:{x:'unique(${multi_ss})'}+}}++,x2:'hll(${multi_ss})',y2:{query:{q:'id:2',+facet:{x:'hll(${multi_ss})'}+}}+++}&wt=json&indent=true} hits=6 status=0 QTime=5
   [junit4]   2> 1272190 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={x:{terms:{${terms}+field:'${multi_ss}',allBuckets:true}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272191 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+f0:{${terms}+type:terms,+field:${multi_ss},+allBuckets:true,+limit:0}+,f1:{${terms}+type:terms,+field:${multi_ss},+allBuckets:true,+limit:0,+offset:1}+,f2:{${terms}+type:terms,+field:${multi_ss},+allBuckets:true,+limit:0,+facet:{x:'sum(${num_d})'},+sort:'x+desc'+}+,f3:{${terms}+type:terms,+field:${multi_ss},+allBuckets:true,+limit:0,+missing:true,+facet:{x:'sum(${num_d})',+y:'avg(${num_d})'},+sort:'x+desc'+}+}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272200 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+f0:{${terms}+type:terms,+field:${num_i},+allBuckets:true,+limit:0}+,f1:{${terms}+type:terms,+field:${num_i},+allBuckets:true,+limit:0,+offset:1}+,f2:{${terms}+type:terms,+field:${num_i},+allBuckets:true,+limit:0,+facet:{x:'sum(${num_d})'},+sort:'x+desc'+}+}&wt=json&indent=true} hits=6 status=0 QTime=8
   [junit4]   2> 1272207 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&facet=true&facet.version=2&facet.field={!key%3Df1}${cat_s}&facet.mincount=3&wt=json&indent=true} hits=6 status=0 QTime=6
   [junit4]   2> 1272208 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&facet=true&facet.version=2&facet.field={!key%3Df1}${super_s}&facet.prefix=s&facet.mincount=0&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272212 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&facet=true&facet.version=2&facet.range={!key%3Df}${num_d}&facet.range.start=-5&facet.range.end=10&facet.range.gap=5&f.f.facet.stat=x:sum(${num_i})&subfacet.f.query={!key%3Dny}${where_s}:NY&wt=json&indent=true} hits=6 status=0 QTime=3
   [junit4]   2> 1272213 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&facet=true&facet.version=2&facet.field={!key%3Df1}${cat_s}&facet.field={!key%3Df2}${cat_s}&f.f1.facet.sort=n1+desc&f.f1.facet.sort=n1+asc&facet.stat=n1:sum(${num_d})&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272213 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=id:(3+4+6)&facet=true&facet.version=2&facet.range={!key%3Df}${num_d}&facet.range.start=-5&facet.range.end=10&facet.range.gap=5&f.f.facet.stat=x:sum(${num_i})&subfacet.f.query={!key%3Dny}${where_s}:NY&facet.range.other=all&wt=json&indent=true} hits=3 status=0 QTime=0
   [junit4]   2> 1272220 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q={!cache%3Dfalse}*:*&fq={!tag%3Ddoc3,allfilt}-id:3&json.facet={f1:{${terms}+type:terms,+field:${cat_s},+domain:{excludeTags:doc3}+}++}&wt=json&indent=true} hits=5 status=0 QTime=6
   [junit4]   2> 1272221 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&fq={!tag%3Dabc}id:(2+3)&json.facet={+processEmpty:true,+f1:{query:{q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+,+excludeTags:[xyz,qaz]}},f2:{query:{q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+,+excludeTags:abc+}},f3:{query:{q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+,+excludeTags:'xyz,abc,qaz'+}},f4:{query:{q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+,+excludeTags:[xyz+,+abc+,+qaz]+}},f5:{query:{q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+,+excludeTags:[xyz,qaz]}},f6:{query:{q:'${cat_s}:B',+facet:{processEmpty:true,+nj:{query:'${where_s}:NJ'},+ny:{+type:query,+q:'${where_s}:NY',+excludeTags:abc}}++}},f7:{query:{q:'${cat_s}:B',+facet:{processEmpty:true,+nj:{query:'${where_s}:NJ'},+ny:{+type:query,+q:'${where_s}:NY',+excludeTags:xyz}}++}}}&wt=json&indent=true} hits=2 status=0 QTime=1
   [junit4]   2> 1272222 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q={!cache%3Dfalse}*:*&fq={!tag%3Ddoc6,allfilt}-id:6&fq={!tag%3Ddoc3,allfilt}-id:3&json.facet={processEmpty:true,++f0:{${terms}+type:terms,+field:${cat_s},++++++++++++++++++++++++++++++++++++facet:{nj:{query:'${where_s}:NJ'}}+}++,f1:{${terms}+type:terms,+field:${cat_s},+domain:{excludeTags:doc3},+++missing:true,++facet:{nj:{query:'${where_s}:NJ'}}+}++,f2:{${terms}+type:terms,+field:${cat_s},+domain:{excludeTags:allfilt},missing:true,++facet:{nj:{query:'${where_s}:NJ'}}+}++,f3:{${terms}+type:terms,+field:${cat_s},+domain:{excludeTags:doc6},+++missing:true,++facet:{nj:{query:'${where_s}:NJ'}}+}++}&wt=json&indent=true} hits=4 status=0 QTime=1
   [junit4]   2> 1272223 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&fq={!tag%3Ddoc6,allfilt}-id:6&fq={!tag%3Ddoc3,allfilt}-id:3&json.facet={processEmpty:true+,+f1:{type:range,+field:${num_d},+start:-5,+end:10,+gap:5,+other:all,+++facet:{+x:'sum(${num_i})',+ny:{query:'${where_s}:NY'}}+,+domain:{excludeTags:allfilt}+},+f2:{type:range,+field:${num_d},+start:-5,+end:10,+gap:5,+other:all,+++facet:{+x:'sum(${num_i})',+ny:{query:'${where_s}:NY'}}++}}&wt=json&indent=true} hits=4 status=0 QTime=0
   [junit4]   2> 1272225 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+f1:{${terms}++type:field,+field:${num_i}+},f2:{${terms}++type:field,+field:${num_i},+sort:'count+asc'+},f3:{${terms}++type:field,+field:${num_i},+sort:'index+asc'+},f4:{${terms}++type:field,+field:${num_i},+sort:'index+desc'+},f5:{${terms}++type:field,+field:${num_i},+sort:'index+desc',+limit:1,+missing:true,+allBuckets:true,+numBuckets:true+},f6:{${terms}++type:field,+field:${num_i},+sort:'index+desc',+mincount:2,+numBuckets:true+},f7:{${terms}++type:field,+field:${num_i},+sort:'index+desc',+offset:2,+numBuckets:true+},f8:{${terms}++type:field,+field:${num_i},+sort:'index+desc',+offset:100,+numBuckets:true+},f9:{${terms}++type:field,+field:${num_i},+sort:'x+desc',+facet:{x:'avg(${num_d})'},+missing:true,+allBuckets:true,+numBuckets:true+},f10:{${terms}++type:field,+field:${num_i},+facet:{a:{query:'${cat_s}:A'}},+missing:true,+allBuckets:true,+numBuckets:true+},f11:{${terms}++type:field,+field:${num_i},+facet:{a:'unique(${num_d})'}+,missing:true,+allBuckets:true,+sort:'a+desc'+}}&wt=json&indent=true} hits=6 status=0 QTime=1
   [junit4]   2> 1272226 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+f1:{${terms}++type:field,+field:${num_d}+},f2:{${terms}++type:field,+field:${num_d},+sort:'index+desc'+}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272226 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={+u+:+'unique(${Z_num_i})',+f1:{${terms}++type:field,+field:${Z_num_i}+}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272227 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.f.UnInvertedField UnInverted multi-valued field {field=num_is,memSize=4562,tindexSize=46,time=0,phase1=0,nTerms=5,bigTerms=2,termInstances=6,uses=0}
   [junit4]   2> 1272227 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={++c1:'unique(${num_is})',+c2:'hll(${num_is})',f1:{${terms}+type:terms,+field:${num_is}+}++}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272228 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.f.UnInvertedField UnInverted multi-valued field {field=num_fs,memSize=4562,tindexSize=46,time=0,phase1=0,nTerms=5,bigTerms=2,termInstances=6,uses=0}
   [junit4]   2> 1272228 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&q=*:*&json.facet={++c1:'unique(${num_fs})',+c2:'hll(${num_fs})',f1:{${terms}+type:terms,+field:${num_fs}+}++}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272228 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&rows=0&noexist=noexist_s&cat_s=cat_s&where_s=where_s&num_d=num_d&num_i=num_i&super_s=super_s&val_b=val_b&date=date_dt&sparse_s=sparse_s&multi_ss=multi_ss&Z_num_i=Z_num_i&num_is=num_is&num_fs=num_fs&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}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272235 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6da2db6e[collection1] realtime]
   [junit4]   2> 1272235 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1549257185295335424)} 0 6
   [junit4]   2> 1272236 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1 (1549257185301626880)]} 0 0
   [junit4]   2> 1272236 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1 (1549257185302675456)]} 0 0
   [junit4]   2> 1272236 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[1 (1549257185302675457)]} 0 0
   [junit4]   2> 1272236 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[2 (1549257185302675458)]} 0 0
   [junit4]   2> 1272237 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[3 (1549257185302675459)]} 0 0
   [junit4]   2> 1272237 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1272237 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1dc6de35
   [junit4]   2> 1272240 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4b7a232b[collection1] main]
   [junit4]   2> 1272240 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1272241 INFO  (searcherExecutor-5115-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4b7a232b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.3.0):c5/2:delGen=1)))}
   [junit4]   2> 1272241 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 4
   [junit4]   2> 1272244 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[4 (1549257185308966912)]} 0 1
   [junit4]   2> 1272244 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[5 (1549257185311064064)]} 0 0
   [junit4]   2> 1272244 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1272244 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1dc6de35
   [junit4]   2> 1272247 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1bc28c89[collection1] main]
   [junit4]   2> 1272247 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1272248 INFO  (searcherExecutor-5115-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1bc28c89[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.3.0):c5/2:delGen=1) Uninverting(_4(6.3.0):c2)))}
   [junit4]   2> 1272248 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 3
   [junit4]   2> 1272249 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={versions=true&wt=json&indent=true}{add=[6 (1549257185315258368)]} 0 1
   [junit4]   2> 1272249 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1272249 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1dc6de35
   [junit4]   2> 1272252 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@78349a02[collection1] main]
   [junit4]   2> 1272252 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1272253 INFO  (searcherExecutor-5115-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@78349a02[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(6.3.0):c5/2:delGen=1) Uninverting(_4(6.3.0):c2) Uninverting(_5(6.3.0):c1)))}
   [junit4]   2> 1272253 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 3
   [junit4]   2> 1272254 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=true&facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_f&num_i=num_l&num_is=num_ls&num_fs=num_ds&super_s=super_ss&val_b=val_b&date=date_dt&sparse_s=sparse_ss&multi_ss=multi_ss&Z_num_i=Z_num_l&q=*:*&json.facet={catA:{query:{q:'${cat_s}:A'}},++catA2:{query:{query:'${cat_s}:A'}},++catA3:{query:'${cat_s}:A'}++++}&wt=json&indent=true} hits=6 status=0 QTime=1
   [junit4]   2> 1272255 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_f&num_i=num_l&num_is=num_ls&num_fs=num_ds&super_s=super_ss&val_b=val_b&date=date_dt&sparse_s=sparse_ss&multi_ss=multi_ss&Z_num_i=Z_num_l&q=*:*&json.facet={catA:{query:{q:'${cat_s}:A'}},++catA2:{query:{query:'${cat_s}:A'}},++catA3:{query:'${cat_s}:A'}++++}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272255 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_f&num_i=num_l&num_is=num_ls&num_fs=num_ds&super_s=super_ss&val_b=val_b&date=date_dt&sparse_s=sparse_ss&multi_ss=multi_ss&Z_num_i=Z_num_l&q=*:*&json.facet={+catB:{type:query,+q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272256 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_f&num_i=num_l&num_is=num_ls&num_fs=num_ds&super_s=super_ss&val_b=val_b&date=date_dt&sparse_s=sparse_ss&multi_ss=multi_ss&Z_num_i=Z_num_l&q=id:(2+3)&json.facet={+catB:{query:{q:'${cat_s}:B',+facet:{nj:{query:'${where_s}:NJ'},+ny:{query:'${where_s}:NY'}}+}}}&wt=json&indent=true} hits=2 status=0 QTime=0
   [junit4]   2> 1272256 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_f&num_i=num_l&num_is=num_ls&num_fs=num_ds&super_s=super_ss&val_b=val_b&date=date_dt&sparse_s=sparse_ss&multi_ss=multi_ss&Z_num_i=Z_num_l&q=*:*&json.facet={+catB:{query:{q:'${cat_s}:B',+facet:{nj:{query:{q:'${where_s}:NJ'}},+ny:{query:'${where_s}:NY'}}+}}}&wt=json&indent=true} hits=6 status=0 QTime=0
   [junit4]   2> 1272257 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.s.f.UnInvertedField UnInverted multi-valued field {field=cat_ss,memSize=4515,tindexSize=41,time=0,phase1=0,nTerms=2,bigTerms=2,termInstances=0,uses=0}
   [junit4]   2> 1272257 INFO  (TEST-TestJsonFacets.testStats-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={debugQuery=false&facet=true&rows=0&noexist=noexist_ss&cat_s=cat_ss&where_s=where_ss&num_d=num_f&num_i=num_l&num_is=num_ls&num_fs=num_ds&super_s=super_ss&val_b=val_b&date=date_dt&sparse_s=sparse_ss&multi_ss=multi_ss&Z_n

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

406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 4
   [junit4]   2> 1324807 INFO  (TEST-TestJsonFacets.testBlockJoin-seed#[5406614593851AC3]) [    ] o.a.s.s.f.UnInvertedField UnInverted multi-valued field {field=v_t,memSize=4741,tindexSize=41,time=0,phase1=0,nTerms=6,bigTerms=4,termInstances=4,uses=0}
   [junit4]   2> 1324807 INFO  (TEST-TestJsonFacets.testBlockJoin-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={rows=0&q=*:*&json.facet={+pages:{+type:query,+domain:{blockChildren:'type_s:book'}+,+facet:{+x:{field:v_t}+}+},pages2:{type:terms,+field:v_t,+domain:{blockChildren:'type_s:book'}+},books:{+type:query,+domain:{blockParent:'type_s:book'}++,+facet:{+x:{field:v_t}+}+},books2:{type:terms,+field:v_t,+domain:{blockParent:'type_s:book'}+},pageof3:{+type:query,+q:'id:3',+facet+:+{+x+:+{+type:terms,+field:page_s,+domain:{blockChildren:'type_s:book'}}}+},bookof22:{+type:query,+q:'id:2.2',+facet+:+{+x+:+{+type:terms,+field:book_s,+domain:{blockParent:'type_s:book'}}}+},missing_blockParent:{+type:query,+domain:{blockParent:'type_s:does_not_exist'}+},missing_blockChildren:{+type:query,+domain:{blockChildren:'type_s:does_not_exist'}+}}&wt=json&indent=true} hits=10 status=0 QTime=1
   [junit4]   2> 1324808 INFO  (TEST-TestJsonFacets.testBlockJoin-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=no_match_s:NO_MATCHES&json.facet={+processEmpty:true,pages:{+type:query,+domain:{blockChildren:'type_s:book'}+},books:{+type:query,+domain:{blockParent:'type_s:book'}+}}&wt=json&indent=true} hits=0 status=0 QTime=0
   [junit4]   2> 1324808 INFO  (TEST-TestJsonFacets.testBlockJoin-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={q=*:*&json.facet={books:{+type:terms,+field:book_s,+facet:{+pages:{type:terms,+field:v_t,+domain:{blockChildren:'type_s:book'}}+}+}}&wt=json&indent=true} hits=10 status=0 QTime=0
   [junit4]   2> 1324809 INFO  (TEST-TestJsonFacets.testBlockJoin-seed#[5406614593851AC3]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testBlockJoin {p0=DVHASH}
   [junit4]   2> 1324825 INFO  (TEST-TestJsonFacets.testErrors-seed#[5406614593851AC3]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testErrors {p0=DVHASH}
   [junit4]   2> 1324826 INFO  (TEST-TestJsonFacets.testErrors-seed#[5406614593851AC3]) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@37c022b[collection1] realtime]
   [junit4]   2> 1324827 INFO  (TEST-TestJsonFacets.testErrors-seed#[5406614593851AC3]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:* (-1549257240446238720)} 0 1
   [junit4]   2> 1324827 INFO  (TEST-TestJsonFacets.testErrors-seed#[5406614593851AC3]) [    ] o.a.s.h.RequestHandlerBase Ignoring exception matching ignore_exception
   [junit4]   2> 1324827 INFO  (TEST-TestJsonFacets.testErrors-seed#[5406614593851AC3]) [    ] o.a.s.c.S.Request [collection1]  webapp=null path=null params={ignore_exception=true&q=*:*&json.facet={f:{type:ignore_exception_aaa,+field:bbbbbb}}&wt=json&indent=true} status=400 QTime=0
   [junit4]   2> 1324827 INFO  (TEST-TestJsonFacets.testErrors-seed#[5406614593851AC3]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testErrors {p0=DVHASH}
   [junit4]   2> 1324829 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@60f24276{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1324829 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1806643517
   [junit4]   2> 1324830 INFO  (coreCloseExecutor-5153-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6373f3a6
   [junit4]   2> 1324855 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7103907d{/solr,null,UNAVAILABLE}
   [junit4]   2> 1324863 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@27558b64{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1324863 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1529180633
   [junit4]   2> 1324864 INFO  (coreCloseExecutor-5155-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@60d5a106
   [junit4]   2> 1324880 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@38a8206f{/solr,null,UNAVAILABLE}
   [junit4]   2> 1324882 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.e.j.s.ServerConnector Stopped ServerConnector@1a39fa94{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1324882 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1073384496
   [junit4]   2> 1324883 INFO  (coreCloseExecutor-5157-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@77aae4e
   [junit4]   2> 1324894 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2430f3f{/solr,null,UNAVAILABLE}
   [junit4]   2> 1324896 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1324896 INFO  (SUITE-TestJsonFacets-seed#[5406614593851AC3]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1242614826
   [junit4]   2> 1324896 INFO  (coreCloseExecutor-5159-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@527a82c7
   [junit4]   2> 1324897 INFO  (coreCloseExecutor-5159-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
   [junit4]   2> 1324897 INFO  (coreCloseExecutor-5159-thread-1) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1dc6de35
   [junit4]   2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.search.facet.TestJsonFacets_5406614593851AC3-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62), sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=sr-BA, timezone=Asia/Chita
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_102 (64-bit)/cpus=3,threads=1,free=344407112,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [URLClassifyProcessorTest, TestCodecSupport, PKIAuthenticationIntegrationTest, MBeansHandlerTest, TestRTimerTree, TestIndexSearcher, TestDocSet, AsyncCallRequestStatusResponseTest, DistributedFacetExistsSmallTest, LukeRequestHandlerTest, TestSearchPerf, WrapperMergePolicyFactoryTest, TestConfigSetImmutable, TestNumericTerms32, TestLRUStatsCache, JsonLoaderTest, TestTolerantUpdateProcessorCloud, ShardSplitTest, SolrXmlInZkTest, DirectUpdateHandlerOptimizeTest, TestRealTimeGet, ClusterStateTest, TestTestInjection, DistributedSuggestComponentTest, TestCloudDeleteByQuery, TestRestoreCore, TestSha256AuthenticationProvider, DeleteNodeTest, LeaderFailoverAfterPartitionTest, CollectionReloadTest, DataDrivenBlockJoinTest, CollectionsAPIDistributedZkTest, OutOfBoxZkACLAndCredentialsProvidersTest, TestLMJelinekMercerSimilarityFactory, CleanupOldIndexTest, TestDefaultSearchFieldResource, TestManagedResource, TestOrdValues, TestReversedWildcardFilterFactory, TestClusterStateMutator, EchoParamsTest, BasicFunctionalityTest, TestGraphTermsQParserPlugin, TestFiltering, DistributedDebugComponentTest, TestDynamicLoading, BitVectorTest, TestHdfsUpdateLog, CloudMLTQParserTest, TestNRTOpen, TestConfigReload, TestBinaryResponseWriter, TestIndexingPerformance, DefaultValueUpdateProcessorTest, DistanceUnitsTest, SegmentsInfoRequestHandlerTest, TestPHPSerializedResponseWriter, TestJmxMonitoredMap, TestLeaderElectionWithEmptyReplica, TestFastWriter, TestZkChroot, NoCacheHeaderTest, BasicZkTest, TestManagedSchemaAPI, RequestHandlersTest, TestSolrCloudSnapshots, SolrCoreCheckLockOnStartupTest, TestMergePolicyConfig, SolrIndexConfigTest, SuggestComponentTest, TestStandardQParsers, DistributedFacetPivotLongTailTest, TestDistributedMissingSort, ZkStateWriterTest, TestBadConfig, TestSchemaManager, DocExpirationUpdateProcessorFactoryTest, TestSubQueryTransformerCrossCore, DistributedFacetPivotSmallTest, ResourceLoaderTest, TestExactSharedStatsCache, CdcrBootstrapTest, SortByFunctionTest, SolrCLIZkUtilsTest, UUIDFieldTest, TestUniqueKeyFieldResource, SolrIndexSplitterTest, ScriptEngineTest, TestFoldingMultitermQuery, RequestLoggingTest, IndexSchemaTest, HLLUtilTest, TestDefaultStatsCache, TestDFRSimilarityFactory, CopyFieldTest, HdfsNNFailoverTest, TestReload, TestSolrQueryParserDefaultOperatorResource, DistributedTermsComponentTest, ChaosMonkeySafeLeaderTest, CdcrVersionReplicationTest, TestFreeTextSuggestions, TolerantUpdateProcessorTest, CoreAdminRequestStatusTest, TestXmlQParserPlugin, SpellingQueryConverterTest, TlogReplayBufferedWhileIndexingTest, BufferStoreTest, TestRangeQuery, TestSolr4Spatial2, TestLMDirichletSimilarityFactory, TestSimpleQParserPlugin, TestOmitPositions, ShowFileRequestHandlerTest, HdfsWriteToMultipleCollectionsTest, DateMathParserTest, TestCoreDiscovery, DistributedIntervalFacetingTest, TestAtomicUpdateErrorCases, AnalysisErrorHandlingTest, SuggesterTSTTest, TestBackupRepositoryFactory, DirectoryFactoryTest, TestReloadDeadlock, TestMacroExpander, InfoHandlerTest, TestRandomCollapseQParserPlugin, SSLMigrationTest, TestClassicSimilarityFactory, TestJsonFacets]
   [junit4] Completed [256/645 (1!)] on J1 in 53.44s, 48 tests, 6 errors <<< FAILURES!

[...truncated 61683 lines...]