[JENKINS] Lucene-Solr-Tests-master - Build # 1502 - Still Unstable

[Apache Jenkins Server]

Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1502/

5 tests failed.
FAILED:  org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingSorting

Error Message:
Documents in wrong order for field: stringGSF expected:<[2]> but was:<[3]>

Stack Trace:
org.junit.ComparisonFailure: Documents in wrong order for field: stringGSF 
expected:<[2]> but was:<[3]>
        at 
__randomizedtesting.SeedInfo.seed([71022A804FE0F7AD:6F3A2288334B4D2D]:0)
        at org.junit.Assert.assertEquals(Assert.java:125)
        at 
org.apache.solr.cloud.DocValuesNotIndexedTest.checkSortOrder(DocValuesNotIndexedTest.java:247)
        at 
org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingSorting(DocValuesNotIndexedTest.java:227)
        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.uima.processor.UIMAUpdateRequestProcessorTest.testErrorHandling

Error Message:
unknown UpdateRequestProcessorChain: <add><doc><field 
name="id">2312312321312</field><field name="text">SpellCheckComponent got 
improvement related to recent Lucene changes.    Add support for specifying 
Spelling SuggestWord Comparator to Lucene spell checkers for 
SpellCheckComponent. Issue SOLR-2053 is already fixed, patch is attached if you 
need it, but it is also committed to trunk and 3_x branch. Last Lucene European 
Conference has been held in Prague.</field></doc></add>

Stack Trace:
org.apache.solr.common.SolrException: unknown UpdateRequestProcessorChain: 
<add><doc><field name="id">2312312321312</field><field 
name="text">SpellCheckComponent got improvement related to recent Lucene 
changes. 
  Add support for specifying Spelling SuggestWord Comparator to Lucene spell 
checkers for SpellCheckComponent. Issue SOLR-2053 is already fixed, patch is 
attached if you need it, but it is also committed to trunk and 3_x branch. Last 
Lucene European Conference has been held in Prague.</field></doc></add>
        at 
__randomizedtesting.SeedInfo.seed([1213318AB190297F:27E74FB4E746A8AB]:0)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessingChain(SolrCore.java:1214)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1222)
        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:52)
        at org.apache.solr.SolrTestCaseJ4.addDoc(SolrTestCaseJ4.java:1031)
        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testErrorHandling(UIMAUpdateRequestProcessorTest.java:137)
        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.uima.processor.UIMAUpdateRequestProcessorTest.testTwoUpdates

Error Message:
unknown UpdateRequestProcessorChain: <add><doc><field name="id">1</field><field 
name="text">The Apache Software Foundation is happy to announce BarCampApache 
Sydney, Australia, the first ASF-backed event in the Southern 
Hemisphere!</field></doc></add>

Stack Trace:
org.apache.solr.common.SolrException: unknown UpdateRequestProcessorChain: 
<add><doc><field name="id">1</field><field name="text">The Apache Software 
Foundation is happy to announce BarCampApache Sydney, Australia, the first 
ASF-backed event in the Southern Hemisphere!</field></doc></add>
        at 
__randomizedtesting.SeedInfo.seed([1213318AB190297F:1F5966D5A9BF4BD1]:0)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessingChain(SolrCore.java:1214)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1222)
        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:52)
        at org.apache.solr.SolrTestCaseJ4.addDoc(SolrTestCaseJ4.java:1031)
        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testTwoUpdates(UIMAUpdateRequestProcessorTest.java:101)
        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.uima.processor.UIMAUpdateRequestProcessorTest.testMultiplierProcessing

Error Message:
unknown UpdateRequestProcessorChain: <add><doc><field 
name="id">2312312321312</field><field name="text">SpellCheckComponent got 
improvement related to recent Lucene changes.    Add support for specifying 
Spelling SuggestWord Comparator to Lucene spell checkers for 
SpellCheckComponent. Issue SOLR-2053 is already fixed, patch is attached if you 
need it, but it is also committed to trunk and 3_x branch. Last Lucene European 
Conference has been held in Prague.</field></doc></add>

Stack Trace:
org.apache.solr.common.SolrException: unknown UpdateRequestProcessorChain: 
<add><doc><field name="id">2312312321312</field><field 
name="text">SpellCheckComponent got improvement related to recent Lucene 
changes. 
  Add support for specifying Spelling SuggestWord Comparator to Lucene spell 
checkers for SpellCheckComponent. Issue SOLR-2053 is already fixed, patch is 
attached if you need it, but it is also committed to trunk and 3_x branch. Last 
Lucene European Conference has been held in Prague.</field></doc></add>
        at 
__randomizedtesting.SeedInfo.seed([1213318AB190297F:2912FB27B6C4058B]:0)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessingChain(SolrCore.java:1214)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1222)
        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:52)
        at org.apache.solr.SolrTestCaseJ4.addDoc(SolrTestCaseJ4.java:1031)
        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testProcessing(UIMAUpdateRequestProcessorTest.java:83)
        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testMultiplierProcessing(UIMAUpdateRequestProcessorTest.java:177)
        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.uima.processor.UIMAUpdateRequestProcessorTest.testProcessing

Error Message:
unknown UpdateRequestProcessorChain: <add><doc><field 
name="id">2312312321312</field><field name="text">SpellCheckComponent got 
improvement related to recent Lucene changes.    Add support for specifying 
Spelling SuggestWord Comparator to Lucene spell checkers for 
SpellCheckComponent. Issue SOLR-2053 is already fixed, patch is attached if you 
need it, but it is also committed to trunk and 3_x branch. Last Lucene European 
Conference has been held in Prague.</field></doc></add>

Stack Trace:
org.apache.solr.common.SolrException: unknown UpdateRequestProcessorChain: 
<add><doc><field name="id">2312312321312</field><field 
name="text">SpellCheckComponent got improvement related to recent Lucene 
changes. 
  Add support for specifying Spelling SuggestWord Comparator to Lucene spell 
checkers for SpellCheckComponent. Issue SOLR-2053 is already fixed, patch is 
attached if you need it, but it is also committed to trunk and 3_x branch. Last 
Lucene European Conference has been held in Prague.</field></doc></add>
        at 
__randomizedtesting.SeedInfo.seed([1213318AB190297F:19D35F8F663A8D5]:0)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessingChain(SolrCore.java:1214)
        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1222)
        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:52)
        at org.apache.solr.SolrTestCaseJ4.addDoc(SolrTestCaseJ4.java:1031)
        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testProcessing(UIMAUpdateRequestProcessorTest.java:83)
        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 12098 lines...]
   [junit4] Suite: org.apache.solr.cloud.DocValuesNotIndexedTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/init-core-data-001
   [junit4]   2> 1273035 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[71022A804FE0F7AD]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1273036 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[71022A804FE0F7AD]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001
   [junit4]   2> 1273036 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[71022A804FE0F7AD]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1273036 INFO  (Thread-5403) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1273036 INFO  (Thread-5403) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1273136 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[71022A804FE0F7AD]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:54936
   [junit4]   2> 1273141 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1273141 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1273142 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@611aeeae{/solr,null,AVAILABLE}
   [junit4]   2> 1273142 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@19cf17c3{HTTP/1.1,[http/1.1]}{127.0.0.1:42975}
   [junit4]   2> 1273142 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.e.j.s.Server Started @1276994ms
   [junit4]   2> 1273142 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=42975}
   [junit4]   2> 1273143 ERROR (jetty-launcher-1972-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1273143 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1273143 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1273143 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1273143 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-11-26T23:14:19.386Z
   [junit4]   2> 1273143 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@477d3072{/solr,null,AVAILABLE}
   [junit4]   2> 1273143 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3c4ec033{HTTP/1.1,[http/1.1]}{127.0.0.1:43301}
   [junit4]   2> 1273144 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.e.j.s.Server Started @1276996ms
   [junit4]   2> 1273144 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43301}
   [junit4]   2> 1273144 ERROR (jetty-launcher-1972-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1273144 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 1273144 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1273144 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1273144 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-11-26T23:14:19.387Z
   [junit4]   2> 1273150 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1273150 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1273155 INFO  (jetty-launcher-1972-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54936/solr
   [junit4]   2> 1273158 INFO  (jetty-launcher-1972-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54936/solr
   [junit4]   2> 1273174 INFO  (jetty-launcher-1972-thread-1) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:43301_solr
   [junit4]   2> 1273175 INFO  (jetty-launcher-1972-thread-2) 
[n:127.0.0.1:42975_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42975_solr
   [junit4]   2> 1273175 INFO  (jetty-launcher-1972-thread-1) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.Overseer Overseer 
(id=97006522156974086-127.0.0.1:43301_solr-n_0000000000) starting
   [junit4]   2> 1273176 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1273182 INFO  
(zkCallback-1983-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1273190 INFO  (jetty-launcher-1972-thread-1) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43301_solr
   [junit4]   2> 1273191 INFO  
(zkCallback-1983-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1273191 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1273240 INFO  (jetty-launcher-1972-thread-1) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node1/.
   [junit4]   2> 1273264 INFO  (jetty-launcher-1972-thread-2) 
[n:127.0.0.1:42975_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node2/.
   [junit4]   2> 1273268 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[71022A804FE0F7AD]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1273269 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[71022A804FE0F7AD]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:54936/solr ready
   [junit4]   2> 1273284 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&maxShardsPerNode=2&name=dv_coll&action=CREATE&numShards=4&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1273285 INFO  
(OverseerThreadFactory-5207-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
dv_coll
   [junit4]   2> 1273391 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica1&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2
   [junit4]   2> 1273392 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica1&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2
   [junit4]   2> 1273392 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=dv_coll_shard3_replica1&action=CREATE&numShards=4&collection=dv_coll&shard=shard3&wt=javabin&version=2
   [junit4]   2> 1273397 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2
   [junit4]   2> 1273500 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1273500 INFO  
(zkCallback-1983-thread-3-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1274406 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2  x:dv_coll_shard2_replica1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.0.0
   [junit4]   2> 1274408 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3  x:dv_coll_shard3_replica1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.0.0
   [junit4]   2> 1274408 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4  x:dv_coll_shard4_replica1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.0.0
   [junit4]   2> 1274413 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1  x:dv_coll_shard1_replica1] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 7.0.0
   [junit4]   2> 1274429 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4  x:dv_coll_shard4_replica1] o.a.s.s.IndexSchema 
[dv_coll_shard4_replica1] Schema name=minimal
   [junit4]   2> 1274430 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2  x:dv_coll_shard2_replica1] o.a.s.s.IndexSchema 
[dv_coll_shard2_replica1] Schema name=minimal
   [junit4]   2> 1274430 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1  x:dv_coll_shard1_replica1] o.a.s.s.IndexSchema 
[dv_coll_shard1_replica1] Schema name=minimal
   [junit4]   2> 1274432 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4  x:dv_coll_shard4_replica1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1274432 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2  x:dv_coll_shard2_replica1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1274432 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1  x:dv_coll_shard1_replica1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1274433 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4  x:dv_coll_shard4_replica1] o.a.s.c.CoreContainer Creating 
SolrCore 'dv_coll_shard4_replica1' using configuration from collection dv_coll
   [junit4]   2> 1274434 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1  x:dv_coll_shard1_replica1] o.a.s.c.CoreContainer Creating 
SolrCore 'dv_coll_shard1_replica1' using configuration from collection dv_coll
   [junit4]   2> 1274434 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2  x:dv_coll_shard2_replica1] o.a.s.c.CoreContainer Creating 
SolrCore 'dv_coll_shard2_replica1' using configuration from collection dv_coll
   [junit4]   2> 1274434 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.SolrCore 
[[dv_coll_shard1_replica1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node1/dv_coll_shard1_replica1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node1/./dv_coll_shard1_replica1/data/]
   [junit4]   2> 1274434 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3  x:dv_coll_shard3_replica1] o.a.s.s.IndexSchema 
[dv_coll_shard3_replica1] Schema name=minimal
   [junit4]   2> 1274435 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.c.SolrCore 
[[dv_coll_shard4_replica1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node2/dv_coll_shard4_replica1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node2/./dv_coll_shard4_replica1/data/]
   [junit4]   2> 1274438 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.c.SolrCore 
[[dv_coll_shard2_replica1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node2/dv_coll_shard2_replica1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node2/./dv_coll_shard2_replica1/data/]
   [junit4]   2> 1274438 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3  x:dv_coll_shard3_replica1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1274439 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3  x:dv_coll_shard3_replica1] o.a.s.c.CoreContainer Creating 
SolrCore 'dv_coll_shard3_replica1' using configuration from collection dv_coll
   [junit4]   2> 1274442 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.c.SolrCore 
[[dv_coll_shard3_replica1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node1/dv_coll_shard3_replica1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node1/./dv_coll_shard3_replica1/data/]
   [junit4]   2> 1274453 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1274453 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1274453 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1274453 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1274454 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1274454 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1274454 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1274454 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1274454 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1274454 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1274455 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1274455 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1274455 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1274455 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1274456 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1274456 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1274459 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@75a54f48[dv_coll_shard2_replica1] 
main]
   [junit4]   2> 1274459 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@49720998[dv_coll_shard4_replica1] 
main]
   [junit4]   2> 1274459 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2915f2b1[dv_coll_shard3_replica1] 
main]
   [junit4]   2> 1274459 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@110b1111[dv_coll_shard1_replica1] 
main]
   [junit4]   2> 1274459 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1274460 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1274460 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1274460 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1274460 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1274460 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1274460 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1274460 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1274460 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1274460 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1274460 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1552104356003708928
   [junit4]   2> 1274460 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1552104356003708928
   [junit4]   2> 1274463 INFO  
(searcherExecutor-5215-thread-1-processing-n:127.0.0.1:43301_solr 
x:dv_coll_shard3_replica1 s:shard3 c:dv_coll r:core_node3) 
[n:127.0.0.1:43301_solr c:dv_coll s:shard3 r:core_node3 
x:dv_coll_shard3_replica1] o.a.s.c.SolrCore [dv_coll_shard3_replica1] 
Registered new searcher Searcher@2915f2b1[dv_coll_shard3_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1274463 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1274463 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1274463 INFO  
(searcherExecutor-5212-thread-1-processing-n:127.0.0.1:42975_solr 
x:dv_coll_shard4_replica1 s:shard4 c:dv_coll r:core_node1) 
[n:127.0.0.1:42975_solr c:dv_coll s:shard4 r:core_node1 
x:dv_coll_shard4_replica1] o.a.s.c.SolrCore [dv_coll_shard4_replica1] 
Registered new searcher Searcher@49720998[dv_coll_shard4_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1274463 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1274463 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1552104356006854656
   [junit4]   2> 1274464 INFO  
(searcherExecutor-5214-thread-1-processing-n:127.0.0.1:42975_solr 
x:dv_coll_shard2_replica1 s:shard2 c:dv_coll r:core_node2) 
[n:127.0.0.1:42975_solr c:dv_coll s:shard2 r:core_node2 
x:dv_coll_shard2_replica1] o.a.s.c.SolrCore [dv_coll_shard2_replica1] 
Registered new searcher Searcher@75a54f48[dv_coll_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1274463 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1274465 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1274466 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1274467 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1552104356011048960
   [junit4]   2> 1274469 INFO  
(searcherExecutor-5213-thread-1-processing-n:127.0.0.1:43301_solr 
x:dv_coll_shard1_replica1 s:shard1 c:dv_coll r:core_node4) 
[n:127.0.0.1:43301_solr c:dv_coll s:shard1 r:core_node4 
x:dv_coll_shard1_replica1] o.a.s.c.SolrCore [dv_coll_shard1_replica1] 
Registered new searcher Searcher@110b1111[dv_coll_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1274474 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1274475 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1274475 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:42975/solr/dv_coll_shard4_replica1/
   [junit4]   2> 1274475 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1274475 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.c.SyncStrategy 
http://127.0.0.1:42975/solr/dv_coll_shard4_replica1/ has no replicas
   [junit4]   2> 1274476 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1274476 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1274476 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:42975/solr/dv_coll_shard2_replica1/
   [junit4]   2> 1274476 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1274476 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.c.SyncStrategy 
http://127.0.0.1:42975/solr/dv_coll_shard2_replica1/ has no replicas
   [junit4]   2> 1274477 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1274477 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1274477 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/
   [junit4]   2> 1274477 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1274477 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.c.SyncStrategy 
http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/ has no replicas
   [junit4]   2> 1274478 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1274478 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1274479 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:43301/solr/dv_coll_shard1_replica1/
   [junit4]   2> 1274479 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1274479 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.SyncStrategy 
http://127.0.0.1:43301/solr/dv_coll_shard1_replica1/ has no replicas
   [junit4]   2> 1274479 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:42975/solr/dv_coll_shard4_replica1/ shard4
   [junit4]   2> 1274480 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:42975/solr/dv_coll_shard2_replica1/ shard2
   [junit4]   2> 1274481 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:43301/solr/dv_coll_shard1_replica1/ shard1
   [junit4]   2> 1274482 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/ shard3
   [junit4]   2> 1274585 INFO  
(zkCallback-1983-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1274585 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1274630 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1274630 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1274632 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1274632 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica1&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2}
 status=0 QTime=1240
   [junit4]   2> 1274632 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica1&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2}
 status=0 QTime=1240
   [junit4]   2> 1274633 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1274635 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2}
 status=0 QTime=1238
   [junit4]   2> 1274637 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=dv_coll_shard3_replica1&action=CREATE&numShards=4&collection=dv_coll&shard=shard3&wt=javabin&version=2}
 status=0 QTime=1245
   [junit4]   2> 1274641 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1274744 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1274744 INFO  
(zkCallback-1983-thread-3-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/dv_coll/state.json] for collection [dv_coll] has occurred - 
updating... (live nodes size: [2])
   [junit4]   2> 1275287 INFO  
(OverseerCollectionConfigSetProcessor-97006522156974086-127.0.0.1:43301_solr-n_0000000000)
 [n:127.0.0.1:43301_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1275641 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&maxShardsPerNode=2&name=dv_coll&action=CREATE&numShards=4&wt=javabin&version=2}
 status=0 QTime=2357
   [junit4]   2> 1275646 INFO  (qtp1211681484-14294) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.s.SchemaManager managed schema loaded . version : 0 
   [junit4]   2> 1275647 INFO  (qtp1211681484-14294) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.s.IndexSchema 
[dv_coll_shard1_replica1] Schema name=minimal
   [junit4]   2> 1275649 INFO  (qtp1211681484-14294) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1275659 INFO  
(zkCallback-1983-thread-3-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.ZkIndexSchemaReader A schema change: 
WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/configs/conf1/managed-schema, has occurred - updating schema from 
ZooKeeper ...
   [junit4]   2> 1275659 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.ZkIndexSchemaReader A schema change: 
WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/configs/conf1/managed-schema, has occurred - updating schema from 
ZooKeeper ...
   [junit4]   2> 1275659 INFO  
(zkCallback-1983-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.ZkIndexSchemaReader A schema change: 
WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/configs/conf1/managed-schema, has occurred - updating schema from 
ZooKeeper ...
   [junit4]   2> 1275659 INFO  (qtp1211681484-14294) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.ZkController 
Persisted config data to node /configs/conf1/managed-schema 
   [junit4]   2> 1275659 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.ZkIndexSchemaReader Retrieved schema 
version 1 from ZooKeeper
   [junit4]   2> 1275659 INFO  
(zkCallback-1981-thread-2-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.ZkIndexSchemaReader A schema change: 
WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/configs/conf1/managed-schema, has occurred - updating schema from 
ZooKeeper ...
   [junit4]   2> 1275661 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.IndexSchema [dv_coll_shard2_replica1] 
Schema name=minimal
   [junit4]   2> 1275659 INFO  
(zkCallback-1983-thread-3-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.ZkIndexSchemaReader Retrieved schema 
version 1 from ZooKeeper
   [junit4]   2> 1275664 INFO  
(zkCallback-1983-thread-3-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.IndexSchema [dv_coll_shard3_replica1] 
Schema name=minimal
   [junit4]   2> 1275672 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with 
uniqueid field id
   [junit4]   2> 1275672 INFO  
(zkCallback-1981-thread-1-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.ZkIndexSchemaReader Finished refreshing 
schema in 12 ms
   [junit4]   2> 1275674 INFO  
(zkCallback-1983-thread-3-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with 
uniqueid field id
   [junit4]   2> 1275675 INFO  
(zkCallback-1983-thread-3-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.ZkIndexSchemaReader Finished refreshing 
schema in 11 ms
   [junit4]   2> 1275675 INFO  
(zkCallback-1981-thread-2-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.ZkIndexSchemaReader Retrieved schema 
version 1 from ZooKeeper
   [junit4]   2> 1275677 INFO  
(zkCallback-1981-thread-2-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.IndexSchema [dv_coll_shard4_replica1] 
Schema name=minimal
   [junit4]   2> 1275692 INFO  
(zkCallback-1981-thread-2-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with 
uniqueid field id
   [junit4]   2> 1275692 INFO  
(zkCallback-1981-thread-2-processing-n:127.0.0.1:42975_solr) 
[n:127.0.0.1:42975_solr    ] o.a.s.s.ZkIndexSchemaReader Finished refreshing 
schema in 17 ms
   [junit4]   2> 1275693 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.c.SolrCore config update listener called for core dv_coll_shard1_replica1
   [junit4]   2> 1275694 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.s.SchemaManager managed schema loaded . version : 1 
   [junit4]   2> 1275696 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.s.IndexSchema [dv_coll_shard1_replica1] Schema name=minimal
   [junit4]   2> 1275700 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1275701 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.c.SolrCore core reload dv_coll_shard1_replica1
   [junit4]   2> 1275701 INFO  (Thread-5423) [n:127.0.0.1:42975_solr    ] 
o.a.s.c.SolrCore config update listener called for core dv_coll_shard2_replica1
   [junit4]   2> 1275701 INFO  (qtp1211681484-14294) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.s.ManagedIndexSchema Waiting up to 599 secs for 3 replicas to apply 
schema update version 1 for collection dv_coll
   [junit4]   2> 1275702 INFO  (Thread-5423) [n:127.0.0.1:42975_solr    ] 
o.a.s.c.SolrCore config update listener called for core dv_coll_shard4_replica1
   [junit4]   2> 1275708 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1275716 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.s.IndexSchema [dv_coll_shard1_replica1] Schema name=minimal
   [junit4]   2> 1275721 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1275723 INFO  (Thread-5422) [n:127.0.0.1:43301_solr    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'dv_coll_shard1_replica1' using 
configuration from collection dv_coll
   [junit4]   2> 1275766 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.SolrCore 
[[dv_coll_shard1_replica1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node1/dv_coll_shard1_replica1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_71022A804FE0F7AD-001/tempDir-001/node1/./dv_coll_shard1_replica1/data/]
   [junit4]   2> 1275806 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1275806 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1275830 INFO  (qtp295632187-14288) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] o.a.s.c.S.Request 
[dv_coll_shard2_replica1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=1&wt=javabin&version=2} status=0 QTime=9
   [junit4]   2> 1275830 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1d3e8f9[dv_coll_shard1_replica1] main]
   [junit4]   2> 1275830 INFO  (qtp1211681484-14298) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] o.a.s.c.S.Request 
[dv_coll_shard3_replica1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1275831 INFO  (qtp295632187-14290) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] o.a.s.c.S.Request 
[dv_coll_shard4_replica1]  webapp=/solr path=/schema/zkversion 
params={refreshIfBelowVersion=1&wt=javabin&version=2} status=0 QTime=9
   [junit4]   2> 1275831 INFO  (qtp1211681484-14294) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.s.ManagedIndexSchema Took 129.0ms for 3 replicas to apply schema update 
version 1 for collection dv_coll
   [junit4]   2> 1275831 INFO  (qtp1211681484-14294) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.S.Request 
[dv_coll_shard1_replica1]  webapp=/solr path=/schema 
params={wt=javabin&version=2} status=0 QTime=185
   [junit4]   2> 1275831 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1275832 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1275832 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.s.ZkIndexSchemaReader 
Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
   [junit4]   2> 1275832 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.h.ReplicationHandler 
Commits will be reserved for  10000
   [junit4]   2> 1275832 INFO  
(searcherExecutor-5233-thread-1-processing-n:127.0.0.1:43301_solr 
x:dv_coll_shard1_replica1 s:shard1 c:dv_coll r:core_node4) 
[n:127.0.0.1:43301_solr c:dv_coll s:shard1 r:core_node4 
x:dv_coll_shard1_replica1] o.a.s.c.SolrCore [dv_coll_shard1_replica1] 
Registered new searcher Searcher@1d3e8f9[dv_coll_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1275833 INFO  
(zkCallback-1983-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.ZkIndexSchemaReader Retrieved schema 
version 1 from ZooKeeper
   [junit4]   2> 1275836 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1552104357446549504
   [junit4]   2> 1275839 INFO  
(zkCallback-1983-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.IndexSchema [dv_coll_shard1_replica1] 
Schema name=minimal
   [junit4]   2> 1275848 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.u.DefaultSolrCoreState 
New IndexWriter is ready to be used.
   [junit4]   2> 1275850 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@7394a0a7[dv_coll_shard1_replica1] main]
   [junit4]   2> 1275854 INFO  
(searcherExecutor-5233-thread-1-processing-n:127.0.0.1:43301_solr 
x:dv_coll_shard1_replica1 s:shard1 c:dv_coll r:core_node4) 
[n:127.0.0.1:43301_solr c:dv_coll s:shard1 r:core_node4 
x:dv_coll_shard1_replica1] o.a.s.c.SolrCore [dv_coll_shard1_replica1] 
Registered new searcher Searcher@7394a0a7[dv_coll_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1275857 INFO  
(TEST-DocValuesNotIndexedTest.testGroupingDVOnly-seed#[71022A804FE0F7AD]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testGroupingDVOnly
   [junit4]   2> 1275870 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.SolrCore 
[dv_coll_shard1_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@59a37a22
   [junit4]   2> 1275870 INFO  
(zkCallback-1983-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with 
uniqueid field id
   [junit4]   2> 1275871 INFO  
(zkCallback-1983-thread-1-processing-n:127.0.0.1:43301_solr) 
[n:127.0.0.1:43301_solr    ] o.a.s.s.ZkIndexSchemaReader Finished refreshing 
schema in 37 ms
   [junit4]   2> 1275871 INFO  (Thread-5422) [n:127.0.0.1:43301_solr c:dv_coll 
s:shard1 r:core_node4 x:dv_coll_shard1_replica1] o.a.s.c.SolrCore config update 
listener called for core dv_coll_shard3_replica1
   [junit4]   2> 1275885 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard1_replica1]  webapp=/solr 
path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:42975/solr/dv_coll_shard2_replica1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1552104357483249664)} 0 14
   [junit4]   2> 1275886 INFO  (qtp295632187-14293) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard4_replica1]  webapp=/solr 
path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:42975/solr/dv_coll_shard2_replica1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1552104357484298240)} 0 14
   [junit4]   2> 1275886 INFO  (qtp1211681484-14295) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica1]  webapp=/solr 
path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:42975/solr/dv_coll_shard2_replica1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1552104357490589696)} 0 8
   [junit4]   2> 1275887 INFO  (qtp295632187-14288) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard2_replica1]  webapp=/solr 
path=/update params={wt=javabin&version=2}{deleteByQuery=*:* 
(-1552104357481152512)} 0 28
   [junit4]   2> 1275888 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1275888 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1275889 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1275889 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1275901 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1275901 INFO  (qtp1211681484-14297) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard1_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 13
   [junit4]   2> 1275901 INFO  (qtp295632187-14287) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1275901 INFO  (qtp295632187-14287) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1275901 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@65f3da2b[dv_coll_shard3_replica1] 
main]
   [junit4]   2> 1275904 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1275904 INFO  
(searcherExecutor-5215-thread-1-processing-n:127.0.0.1:43301_solr 
x:dv_coll_shard3_replica1 s:shard3 c:dv_coll r:core_node3) 
[n:127.0.0.1:43301_solr c:dv_coll s:shard3 r:core_node3 
x:dv_coll_shard3_replica1] o.a.s.c.SolrCore [dv_coll_shard3_replica1] 
Registered new searcher Searcher@65f3da2b[dv_coll_shard3_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1275904 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1275904 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 15
   [junit4]   2> 1275904 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1275904 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@657a74d3[dv_coll_shard4_replica1] 
main]
   [junit4]   2> 1275905 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1275905 INFO  
(searcherExecutor-5212-thread-1-processing-n:127.0.0.1:42975_solr 
x:dv_coll_shard4_replica1 s:shard4 c:dv_coll r:core_node1) 
[n:127.0.0.1:42975_solr c:dv_coll s:shard4 r:core_node1 
x:dv_coll_shard4_replica1] o.a.s.c.SolrCore [dv_coll_shard4_replica1] 
Registered new searcher Searcher@657a74d3[dv_coll_shard4_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1275905 INFO  (qtp295632187-14284) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard4_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 1275905 INFO  (qtp295632187-14287) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1db65dc[dv_coll_shard2_replica1] 
main]
   [junit4]   2> 1275905 INFO  (qtp295632187-14287) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1275905 INFO  
(searcherExecutor-5214-thread-1-processing-n:127.0.0.1:42975_solr 
x:dv_coll_shard2_replica1 s:shard2 c:dv_coll r:core_node2) 
[n:127.0.0.1:42975_solr c:dv_coll s:shard2 r:core_node2 
x:dv_coll_shard2_replica1] o.a.s.c.SolrCore [dv_coll_shard2_replica1] 
Registered new searcher Searcher@1db65dc[dv_coll_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1275905 INFO  (qtp295632187-14287) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard2_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 4
   [junit4]   2> 1275905 INFO  (qtp1211681484-14298) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=dv_coll:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 18
   [junit4]   2> 1275910 INFO  (qtp1211681484-14294) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica1]  webapp=/solr 
path=/update params={_stateVer_=dv_coll:3&wt=javabin&version=2}{add=[2 
(1552104357523095552), 3 (1552104357524144128), 105 (1552104357524144129), 6 
(1552104357524144130), 7 (1552104357524144131), 9 (1552104357524144132), 115 
(1552104357524144133), 18 (1552104357524144134), 120 (1552104357524144135), 26 
(1552104357524144136), ... (15 adds)]} 0 1
   [junit4]   2> 1275912 INFO  (qtp1211681484-14295) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard1_replica1]  webapp=/solr 
path=/update params={_stateVer_=dv_coll:3&wt=javabin&version=2}{add=[1 
(1552104357525192704), 8 (1552104357525192705), 10 (1552104357525192706), 110 
(1552104357525192707), 11 (1552104357526241280), 13 (1552104357526241281), 14 
(1552104357526241282), 24 (1552104357526241283), 27 (1552104357526241284), 28 
(1552104357526241285), ... (15 adds)]} 0 1
   [junit4]   2> 1275912 INFO  (qtp295632187-14282) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard4_replica1]  webapp=/solr 
path=/update params={_stateVer_=dv_coll:3&wt=javabin&version=2}{add=[5 
(1552104357525192704), 17 (1552104357526241280), 19 (1552104357526241281), 21 
(1552104357526241282), 23 (1552104357526241283), 25 (1552104357526241284), 29 
(1552104357526241285), 33 (1552104357526241286), 37 (1552104357526241287), 45 
(1552104357526241288), ... (11 adds)]} 0 0
   [junit4]   2> 1275914 INFO  (qtp295632187-14293) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard2_replica1]  webapp=/solr 
path=/update params={_stateVer_=dv_coll:3&wt=javabin&version=2}{add=[0 
(1552104357527289856), 100 (1552104357528338432), 4 (1552104357528338433), 12 
(1552104357528338434), 15 (1552104357528338435), 16 (1552104357528338436), 20 
(1552104357528338437), 22 (1552104357528338438), 125 (1552104357528338439), 34 
(1552104357528338440), ... (18 adds)]} 0 1
   [junit4]   2> 1275915 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1275915 INFO  (qtp295632187-14291) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1275915 INFO  (qtp1211681484-14286) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard1 r:core_node4 x:dv_coll_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@23c8ca
   [junit4]   2> 1275916 INFO  (qtp295632187-14291) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@260c3034
   [junit4]   2> 1275916 INFO  (qtp295632187-14288) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1275916 INFO  (qtp295632187-14288) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@81eec86
   [junit4]   2> 1275916 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1275916 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6c03587
   [junit4]   2> 1275926 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@338da681[dv_coll_shard3_replica1] 
main]
   [junit4]   2> 1275926 INFO  (qtp295632187-14288) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@563cda64[dv_coll_shard2_replica1] 
main]
   [junit4]   2> 1275926 INFO  
(searcherExecutor-5214-thread-1-processing-n:127.0.0.1:42975_solr 
x:dv_coll_shard2_replica1 s:shard2 c:dv_coll r:core_node2) 
[n:127.0.0.1:42975_solr c:dv_coll s:shard2 r:core_node2 
x:dv_coll_shard2_replica1] o.a.s.c.SolrCore [dv_coll_shard2_replica1] 
Registered new searcher Searcher@563cda64[dv_coll_shard2_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C18)))}
   [junit4]   2> 1275926 INFO  
(searcherExecutor-5215-thread-1-processing-n:127.0.0.1:43301_solr 
x:dv_coll_shard3_replica1 s:shard3 c:dv_coll r:core_node3) 
[n:127.0.0.1:43301_solr c:dv_coll s:shard3 r:core_node3 
x:dv_coll_shard3_replica1] o.a.s.c.SolrCore [dv_coll_shard3_replica1] 
Registered new searcher Searcher@338da681[dv_coll_shard3_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C15)))}
   [junit4]   2> 1275926 INFO  (qtp295632187-14288) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1275926 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1275926 INFO  (qtp295632187-14288) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard2 r:core_node2 x:dv_coll_shard2_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard2_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 10
   [junit4]   2> 1275926 INFO  (qtp1211681484-14292) [n:127.0.0.1:43301_solr 
c:dv_coll s:shard3 r:core_node3 x:dv_coll_shard3_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [dv_coll_shard3_replica1]  webapp=/solr 
path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:43301/solr/dv_coll_shard3_replica1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 9
   [junit4]   2> 1275927 INFO  (qtp295632187-14291) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@62713a9e[dv_coll_shard4_replica1] 
main]
   [junit4]   2> 1275927 INFO  (qtp295632187-14291) [n:127.0.0.1:42975_solr 
c:dv_coll s:shard4 r:core_node1 x:dv_coll_shard4_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1275927 INFO  
(searcherExecutor-5212-thread-1-processing-n:127.0.0.1:42975_solr 
x:dv_coll_shard4_replica1 s:shard4 c:dv_coll r:core_node1) 
[n:127.0.0.1:42975_solr c:dv_coll s:shard4 r:core_node1 
x:dv_coll_shard4_replica1] o.a.s.c.SolrCore [dv_coll_shard4_replica1] 
Registered new searcher Searcher@62713a9e[dv_coll_shard4_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C11)))}
   [junit4]   2> 1275927 INFO  (qtp295

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

d, HdfsRecoveryZkTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
RestartWhileUpdatingTest, TestDocTermOrds, DateFieldTest, AssignTest, 
TestRecovery, TestTrieFacet, TestSolrQueryResponse, PrimUtilsTest, 
ForceLeaderTest, DirectUpdateHandlerTest, PrimitiveFieldTypeTest, 
TestCloudSchemaless, TestQuerySenderNoQuery, 
DocExpirationUpdateProcessorFactoryTest, RuleEngineTest, 
TestSimpleQParserPlugin, TestFieldCacheSanityChecker, TestGroupingSearch, 
TestLRUStatsCache, TestIndexingPerformance, BufferStoreTest, 
TestJsonFacetRefinement, SolrIndexConfigTest, TestNoOpRegenerator, 
UnloadDistributedZkTest, TestFieldCacheVsDocValues, 
XmlUpdateRequestHandlerTest, EnumFieldTest, OverseerModifyCollectionTest, 
DeleteReplicaTest, BinaryUpdateRequestHandlerTest, TestGraphTermsQParserPlugin, 
TestCustomSort, TestWriterPerf, TestManagedSchemaAPI, 
TestLMDirichletSimilarityFactory, TestReload, TestRangeQuery, SolrCoreTest, 
TestFiltering, DistributedQueryElevationComponentTest, 
TestFoldingMultitermQuery, TestStressLucene, SuggesterWFSTTest, 
NoCacheHeaderTest, TestUpdate, SortByFunctionTest, DebugComponentTest, 
DisMaxRequestHandlerTest, StandardRequestHandlerTest, TestQueryTypes, 
TermsComponentTest, MoreLikeThisHandlerTest, FieldAnalysisRequestHandlerTest, 
MBeansHandlerTest, HighlighterConfigTest, UpdateParamsTest, 
ResponseLogComponentTest, TestSolrDeletionPolicy2, NumericFieldsTest, 
MinimalSchemaTest, OutputWriterTest, TestLuceneMatchVersion, 
TestLMJelinekMercerSimilarityFactory, TestJmxMonitoredMap, PluginInfoTest, 
SpellingQueryConverterTest, SystemInfoHandlerTest, 
DistributedIntervalFacetingTest, BaseCdcrDistributedZkTest, 
CdcrReplicationDistributedZkTest, CdcrReplicationHandlerTest, 
CdcrRequestHandlerTest, CleanupOldIndexTest, CollectionsAPISolrJTest, 
DocValuesNotIndexedTest]
   [junit4] Completed [470/658 (1!)] on J2 in 5.92s, 4 tests, 1 failure <<< 
FAILURES!

[...truncated 11786 lines...]
   [junit4] Suite: org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/contrib/solr-uima/test/J0/temp/solr.uima.processor.UIMAUpdateRequestProcessorTest_1213318AB190297F-001/init-core-data-001
   [junit4]   2> log4j:WARN No appenders could be found for logger 
(org.eclipse.jetty.util.log).
   [junit4]   2> log4j:WARN Please initialize the log4j system properly.
   [junit4]   2> log4j:WARN See 
http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
   [junit4]   2> 11월 26, 2016 4:39:42 오후 WhitespaceTokenizer initialize
   [junit4]   2> 정보: "Whitespace tokenizer successfully initialized"
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=UIMAUpdateRequestProcessorTest -Dtests.method=testErrorHandling 
-Dtests.seed=1213318AB190297F -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=ko-KR -Dtests.timezone=America/Boise -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   5.59s J0 | UIMAUpdateRequestProcessorTest.testErrorHandling 
<<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: unknown 
UpdateRequestProcessorChain: <add><doc><field 
name="id">2312312321312</field><field name="text">SpellCheckComponent got 
improvement related to recent Lucene changes. 
   [junit4]    >   Add support for specifying Spelling SuggestWord Comparator 
to Lucene spell checkers for SpellCheckComponent. Issue SOLR-2053 is already 
fixed, patch is attached if you need it, but it is also committed to trunk and 
3_x branch. Last Lucene European Conference has been held in 
Prague.</field></doc></add>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1213318AB190297F:27E74FB4E746A8AB]:0)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getUpdateProcessingChain(SolrCore.java:1214)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1222)
   [junit4]    >        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:52)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.addDoc(SolrTestCaseJ4.java:1031)
   [junit4]    >        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testErrorHandling(UIMAUpdateRequestProcessorTest.java:137)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=UIMAUpdateRequestProcessorTest -Dtests.method=testTwoUpdates 
-Dtests.seed=1213318AB190297F -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=ko-KR -Dtests.timezone=America/Boise -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.01s J0 | UIMAUpdateRequestProcessorTest.testTwoUpdates <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: unknown 
UpdateRequestProcessorChain: <add><doc><field name="id">1</field><field 
name="text">The Apache Software Foundation is happy to announce BarCampApache 
Sydney, Australia, the first ASF-backed event in the Southern 
Hemisphere!</field></doc></add>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1213318AB190297F:1F5966D5A9BF4BD1]:0)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getUpdateProcessingChain(SolrCore.java:1214)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1222)
   [junit4]    >        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:52)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.addDoc(SolrTestCaseJ4.java:1031)
   [junit4]    >        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testTwoUpdates(UIMAUpdateRequestProcessorTest.java:101)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 11월 26, 2016 4:39:46 오후 WhitespaceTokenizer initialize
   [junit4]   2> 정보: "Whitespace tokenizer successfully initialized"
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=UIMAUpdateRequestProcessorTest 
-Dtests.method=testMultiplierProcessing -Dtests.seed=1213318AB190297F 
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ko-KR 
-Dtests.timezone=America/Boise -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.01s J0 | 
UIMAUpdateRequestProcessorTest.testMultiplierProcessing <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: unknown 
UpdateRequestProcessorChain: <add><doc><field 
name="id">2312312321312</field><field name="text">SpellCheckComponent got 
improvement related to recent Lucene changes. 
   [junit4]    >   Add support for specifying Spelling SuggestWord Comparator 
to Lucene spell checkers for SpellCheckComponent. Issue SOLR-2053 is already 
fixed, patch is attached if you need it, but it is also committed to trunk and 
3_x branch. Last Lucene European Conference has been held in 
Prague.</field></doc></add>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1213318AB190297F:2912FB27B6C4058B]:0)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getUpdateProcessingChain(SolrCore.java:1214)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1222)
   [junit4]    >        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:52)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.addDoc(SolrTestCaseJ4.java:1031)
   [junit4]    >        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testProcessing(UIMAUpdateRequestProcessorTest.java:83)
   [junit4]    >        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testMultiplierProcessing(UIMAUpdateRequestProcessorTest.java:177)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=UIMAUpdateRequestProcessorTest -Dtests.method=testProcessing 
-Dtests.seed=1213318AB190297F -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=ko-KR -Dtests.timezone=America/Boise -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.01s J0 | UIMAUpdateRequestProcessorTest.testProcessing <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: unknown 
UpdateRequestProcessorChain: <add><doc><field 
name="id">2312312321312</field><field name="text">SpellCheckComponent got 
improvement related to recent Lucene changes. 
   [junit4]    >   Add support for specifying Spelling SuggestWord Comparator 
to Lucene spell checkers for SpellCheckComponent. Issue SOLR-2053 is already 
fixed, patch is attached if you need it, but it is also committed to trunk and 
3_x branch. Last Lucene European Conference has been held in 
Prague.</field></doc></add>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1213318AB190297F:19D35F8F663A8D5]:0)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getUpdateProcessingChain(SolrCore.java:1214)
   [junit4]    >        at 
org.apache.solr.core.SolrCore.getUpdateProcessorChain(SolrCore.java:1222)
   [junit4]    >        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:52)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.addDoc(SolrTestCaseJ4.java:1031)
   [junit4]    >        at 
org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest.testProcessing(UIMAUpdateRequestProcessorTest.java:83)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/contrib/solr-uima/test/J0/temp/solr.uima.processor.UIMAUpdateRequestProcessorTest_1213318AB190297F-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1543, maxMBSortInHeap=5.709335914606576, 
sim=RandomSimilarity(queryNorm=true): {}, locale=ko-KR, timezone=America/Boise
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_102 (64-bit)/cpus=4,threads=1,free=129871600,total=363331584
   [junit4]   2> NOTE: All tests run in this JVM: 
[UIMAUpdateRequestProcessorTest]
   [junit4] Completed [2/2 (1!)] on J0 in 12.82s, 6 tests, 4 errors <<< 
FAILURES!

[...truncated 51198 lines...]



---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org