Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18387/ Java: 32bit/jdk1.8.0_102 -server -XX:+UseSerialGC
5 tests failed. FAILED: org.apache.solr.TestDistributedSearch.test Error Message: Expected to find shardAddress in the up shard info: {error=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request,trace=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:416) at org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:228) at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:199) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) ,time=2} Stack Trace: java.lang.AssertionError: Expected to find shardAddress in the up shard info: {error=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request,trace=org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:416) at org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:228) at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:199) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) ,time=2} at __randomizedtesting.SeedInfo.seed([739505FFE6DE33B4:FBC13A2548225E4C]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1172) at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:1113) at org.apache.solr.TestDistributedSearch.test(TestDistributedSearch.java:973) 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 org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1011) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(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([BC54C64C05E23FB:184B481687ADA251]: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) 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([BC54C64C05E23FB:30C486C9C70A0F0F]: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.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([BC54C64C05E23FB:3E31325A9688A22F]: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([BC54C64C05E23FB:68F1B3BD8714155]: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) Build Log: [...truncated 11624 lines...] [junit4] Suite: org.apache.solr.TestDistributedSearch [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/init-core-data-001 [junit4] 2> 1036092 INFO (SUITE-TestDistributedSearch-seed#[739505FFE6DE33B4]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9061) [junit4] 2> 1036092 INFO (SUITE-TestDistributedSearch-seed#[739505FFE6DE33B4]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /e_/w [junit4] 2> 1036177 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/control/cores/collection1 [junit4] 2> 1036178 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 1036179 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1dce327{/e_/w,null,AVAILABLE} [junit4] 2> 1036180 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@14642e5{HTTP/1.1,[http/1.1]}{127.0.0.1:39963} [junit4] 2> 1036180 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.e.j.s.Server Started @1038221ms [junit4] 2> 1036180 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/e_/w, hostPort=39963, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/control/cores} [junit4] 2> 1036181 ERROR (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1036181 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 1036181 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1036181 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1036181 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-27T18:12:10.288Z [junit4] 2> 1036181 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/control/solr.xml [junit4] 2> 1036187 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/control/cores [junit4] 2> 1036187 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1036188 INFO (coreLoadExecutor-5258-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1036209 INFO (coreLoadExecutor-5258-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 1036228 INFO (coreLoadExecutor-5258-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1036317 WARN (coreLoadExecutor-5258-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead. [junit4] 2> 1036318 INFO (coreLoadExecutor-5258-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1036324 INFO (coreLoadExecutor-5258-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1 [junit4] 2> 1036324 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 1036324 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@91509b [junit4] 2> 1036325 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=0.783203125, floorSegmentMB=1.388671875, forceMergeDeletesPctAllowed=7.212349156881349, segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1036334 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1036334 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1036335 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1036335 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1036335 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=80.3583984375, floorSegmentMB=0.65625, forceMergeDeletesPctAllowed=15.108360051468974, segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1036335 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@f41a5e[collection1] main] [junit4] 2> 1036335 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1036358 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1036464 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1036465 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1036465 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1036465 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1036465 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1036465 INFO (coreLoadExecutor-5258-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1552175942149865472 [junit4] 2> 1036465 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1036466 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1036466 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1036466 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1036466 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1036467 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f41a5e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1036770 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 1036771 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 1036772 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@82e6d1{/e_/w,null,AVAILABLE} [junit4] 2> 1036772 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1040c97{HTTP/1.1,[http/1.1]}{127.0.0.1:38254} [junit4] 2> 1036772 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.e.j.s.Server Started @1038813ms [junit4] 2> 1036772 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/e_/w, hostPort=38254, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/shard0/cores} [junit4] 2> 1036772 ERROR (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1036772 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 1036772 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1036773 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1036773 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-27T18:12:10.880Z [junit4] 2> 1036773 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/shard0/solr.xml [junit4] 2> 1036779 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/shard0/cores [junit4] 2> 1036779 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1036779 INFO (coreLoadExecutor-5269-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1036800 INFO (coreLoadExecutor-5269-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 1036830 INFO (coreLoadExecutor-5269-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1036907 WARN (coreLoadExecutor-5269-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead. [junit4] 2> 1036909 INFO (coreLoadExecutor-5269-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1036913 INFO (coreLoadExecutor-5269-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1 [junit4] 2> 1036913 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.TestDistributedSearch_739505FFE6DE33B4-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 1036913 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@91509b [junit4] 2> 1036914 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=0.783203125, floorSegmentMB=1.388671875, forceMergeDeletesPctAllowed=7.212349156881349, segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1036939 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1036939 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1036940 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1036940 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1036940 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3, maxMergeAtOnceExplicit=3, maxMergedSegmentMB=80.3583984375, floorSegmentMB=0.65625, forceMergeDeletesPctAllowed=15.108360051468974, segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1036940 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1667363[collection1] main] [junit4] 2> 1036940 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1036974 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1037083 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1037083 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1037083 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1037083 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1037083 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1037083 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1037084 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1037084 INFO (coreLoadExecutor-5269-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1552175942798934016 [junit4] 2> 1037084 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1037084 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1037084 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1037084 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1667363[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1037284 INFO (TEST-TestDistributedSearch.test-seed#[739505FFE6DE33B4]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 1037287 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1552175943009697792)} 0 1 [junit4] 2> 1037288 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1552175943011794944)} 0 0 [junit4] 2> 1037290 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[1 (1552175943013892096)]} 0 1 [junit4] 2> 1037291 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[1 (1552175943014940672)]} 0 0 [junit4] 2> 1037291 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[2 (1552175943015989248)]} 0 0 [junit4] 2> 1037292 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[2 (1552175943015989248)]} 0 0 [junit4] 2> 1037292 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[3 (1552175943017037824)]} 0 0 [junit4] 2> 1037293 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[3 (1552175943018086400)]} 0 0 [junit4] 2> 1037294 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[4 (1552175943018086400)]} 0 0 [junit4] 2> 1037294 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[4 (1552175943019134976)]} 0 0 [junit4] 2> 1037295 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[5 (1552175943019134976)]} 0 0 [junit4] 2> 1037295 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[5 (1552175943020183552)]} 0 0 [junit4] 2> 1037296 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[6 (1552175943020183552)]} 0 0 [junit4] 2> 1037296 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[6 (1552175943021232128)]} 0 0 [junit4] 2> 1037296 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[7 (1552175943021232128)]} 0 0 [junit4] 2> 1037297 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[7 (1552175943022280704)]} 0 0 [junit4] 2> 1037299 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[8 (1552175943022280704)]} 0 1 [junit4] 2> 1037299 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[8 (1552175943024377856)]} 0 0 [junit4] 2> 1037300 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[9 (1552175943024377856)]} 0 0 [junit4] 2> 1037300 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[9 (1552175943025426432)]} 0 0 [junit4] 2> 1037300 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1037300 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1071373 [junit4] 2> 1037306 INFO (qtp11700716-10633) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ed0d9f[collection1] main] [junit4] 2> 1037306 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1037307 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ed0d9f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))} [junit4] 2> 1037307 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 7 [junit4] 2> 1037308 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1037308 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c2eaa5 [junit4] 2> 1037312 INFO (qtp1642174-10650) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@9d6cf6[collection1] main] [junit4] 2> 1037312 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1037313 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@9d6cf6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9)))} [junit4] 2> 1037313 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 5 [junit4] 2> 1037315 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[10 (1552175943039057920)]} 0 1 [junit4] 2> 1037317 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[10 (1552175943041155072)]} 0 1 [junit4] 2> 1037317 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[11 (1552175943043252224)]} 0 0 [junit4] 2> 1037318 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[11 (1552175943044300800)]} 0 0 [junit4] 2> 1037318 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[12 (1552175943044300800)]} 0 0 [junit4] 2> 1037319 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[12 (1552175943045349376)]} 0 0 [junit4] 2> 1037319 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[13 (1552175943045349376)]} 0 0 [junit4] 2> 1037320 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[13 (1552175943046397952)]} 0 0 [junit4] 2> 1037320 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[1001 (1552175943046397952)]} 0 0 [junit4] 2> 1037321 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[1001 (1552175943047446528)]} 0 0 [junit4] 2> 1037322 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[14 (1552175943048495104)]} 0 0 [junit4] 2> 1037323 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[14 (1552175943049543680)]} 0 0 [junit4] 2> 1037323 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[15 (1552175943049543680)]} 0 0 [junit4] 2> 1037324 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[15 (1552175943050592256)]} 0 0 [junit4] 2> 1037324 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[16 (1552175943050592256)]} 0 0 [junit4] 2> 1037324 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[16 (1552175943050592257)]} 0 0 [junit4] 2> 1037325 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[17 (1552175943051640832)]} 0 0 [junit4] 2> 1037326 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[17 (1552175943051640832)]} 0 0 [junit4] 2> 1037326 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[100 (1552175943052689408)]} 0 0 [junit4] 2> 1037326 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[100 (1552175943052689408)]} 0 0 [junit4] 2> 1037327 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[101 (1552175943053737984)]} 0 0 [junit4] 2> 1037327 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[101 (1552175943053737984)]} 0 0 [junit4] 2> 1037328 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[102 (1552175943053737985)]} 0 0 [junit4] 2> 1037328 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[102 (1552175943054786560)]} 0 0 [junit4] 2> 1037328 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[103 (1552175943054786560)]} 0 0 [junit4] 2> 1037329 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[103 (1552175943055835136)]} 0 0 [junit4] 2> 1037329 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[104 (1552175943055835136)]} 0 0 [junit4] 2> 1037330 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[104 (1552175943055835137)]} 0 0 [junit4] 2> 1037330 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[105 (1552175943056883712)]} 0 0 [junit4] 2> 1037330 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[105 (1552175943056883712)]} 0 0 [junit4] 2> 1037331 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[106 (1552175943057932288)]} 0 0 [junit4] 2> 1037331 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[106 (1552175943057932288)]} 0 0 [junit4] 2> 1037332 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[107 (1552175943057932289)]} 0 0 [junit4] 2> 1037332 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[107 (1552175943058980864)]} 0 0 [junit4] 2> 1037332 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[108 (1552175943058980864)]} 0 0 [junit4] 2> 1037333 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[108 (1552175943060029440)]} 0 0 [junit4] 2> 1037333 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[109 (1552175943060029440)]} 0 0 [junit4] 2> 1037334 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[109 (1552175943061078016)]} 0 0 [junit4] 2> 1037335 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[110 (1552175943062126592)]} 0 0 [junit4] 2> 1037335 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[110 (1552175943062126592)]} 0 0 [junit4] 2> 1037335 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[111 (1552175943062126593)]} 0 0 [junit4] 2> 1037336 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[111 (1552175943063175168)]} 0 0 [junit4] 2> 1037336 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[112 (1552175943063175168)]} 0 0 [junit4] 2> 1037337 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[112 (1552175943064223744)]} 0 0 [junit4] 2> 1037337 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[113 (1552175943064223744)]} 0 0 [junit4] 2> 1037338 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[113 (1552175943064223745)]} 0 0 [junit4] 2> 1037338 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[114 (1552175943065272320)]} 0 0 [junit4] 2> 1037338 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[114 (1552175943065272320)]} 0 0 [junit4] 2> 1037339 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[115 (1552175943066320896)]} 0 0 [junit4] 2> 1037339 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[115 (1552175943066320896)]} 0 0 [junit4] 2> 1037340 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[116 (1552175943067369472)]} 0 0 [junit4] 2> 1037340 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[116 (1552175943067369472)]} 0 0 [junit4] 2> 1037341 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[117 (1552175943067369473)]} 0 0 [junit4] 2> 1037341 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[117 (1552175943068418048)]} 0 0 [junit4] 2> 1037341 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[118 (1552175943068418048)]} 0 0 [junit4] 2> 1037342 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[118 (1552175943069466624)]} 0 0 [junit4] 2> 1037342 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[119 (1552175943069466624)]} 0 0 [junit4] 2> 1037342 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[119 (1552175943069466625)]} 0 0 [junit4] 2> 1037343 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[120 (1552175943070515200)]} 0 0 [junit4] 2> 1037343 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[120 (1552175943070515200)]} 0 0 [junit4] 2> 1037344 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[121 (1552175943070515201)]} 0 0 [junit4] 2> 1037344 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[121 (1552175943071563776)]} 0 0 [junit4] 2> 1037345 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[122 (1552175943071563776)]} 0 0 [junit4] 2> 1037345 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[122 (1552175943072612352)]} 0 0 [junit4] 2> 1037346 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[123 (1552175943072612352)]} 0 1 [junit4] 2> 1037347 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[123 (1552175943074709504)]} 0 0 [junit4] 2> 1037347 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[124 (1552175943074709504)]} 0 0 [junit4] 2> 1037348 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[124 (1552175943075758080)]} 0 0 [junit4] 2> 1037348 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[125 (1552175943075758080)]} 0 0 [junit4] 2> 1037349 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[125 (1552175943075758081)]} 0 0 [junit4] 2> 1037349 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[126 (1552175943076806656)]} 0 0 [junit4] 2> 1037350 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[126 (1552175943076806656)]} 0 0 [junit4] 2> 1037350 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[127 (1552175943077855232)]} 0 0 [junit4] 2> 1037351 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[127 (1552175943077855232)]} 0 0 [junit4] 2> 1037351 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[128 (1552175943078903808)]} 0 0 [junit4] 2> 1037352 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[128 (1552175943078903808)]} 0 0 [junit4] 2> 1037352 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[129 (1552175943079952384)]} 0 0 [junit4] 2> 1037352 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[129 (1552175943079952384)]} 0 0 [junit4] 2> 1037353 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[130 (1552175943081000960)]} 0 0 [junit4] 2> 1037353 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[130 (1552175943081000960)]} 0 0 [junit4] 2> 1037354 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[131 (1552175943081000961)]} 0 0 [junit4] 2> 1037354 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[131 (1552175943082049536)]} 0 0 [junit4] 2> 1037354 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[132 (1552175943082049536)]} 0 0 [junit4] 2> 1037355 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[132 (1552175943083098112)]} 0 0 [junit4] 2> 1037355 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[133 (1552175943083098112)]} 0 0 [junit4] 2> 1037355 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[133 (1552175943083098113)]} 0 0 [junit4] 2> 1037356 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[134 (1552175943084146688)]} 0 0 [junit4] 2> 1037356 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[134 (1552175943084146688)]} 0 0 [junit4] 2> 1037357 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[135 (1552175943084146689)]} 0 0 [junit4] 2> 1037357 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[135 (1552175943085195264)]} 0 0 [junit4] 2> 1037357 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[136 (1552175943085195264)]} 0 0 [junit4] 2> 1037359 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[136 (1552175943086243840)]} 0 0 [junit4] 2> 1037359 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[137 (1552175943087292416)]} 0 0 [junit4] 2> 1037359 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[137 (1552175943087292416)]} 0 0 [junit4] 2> 1037360 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[138 (1552175943088340992)]} 0 0 [junit4] 2> 1037360 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[138 (1552175943088340992)]} 0 0 [junit4] 2> 1037360 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[139 (1552175943088340993)]} 0 0 [junit4] 2> 1037361 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[139 (1552175943089389568)]} 0 0 [junit4] 2> 1037361 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[140 (1552175943089389568)]} 0 0 [junit4] 2> 1037362 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[140 (1552175943089389569)]} 0 0 [junit4] 2> 1037362 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[141 (1552175943090438144)]} 0 0 [junit4] 2> 1037363 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[141 (1552175943090438144)]} 0 0 [junit4] 2> 1037363 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[142 (1552175943091486720)]} 0 0 [junit4] 2> 1037363 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[142 (1552175943091486720)]} 0 0 [junit4] 2> 1037364 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[143 (1552175943092535296)]} 0 0 [junit4] 2> 1037364 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[143 (1552175943092535296)]} 0 0 [junit4] 2> 1037365 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[144 (1552175943092535297)]} 0 0 [junit4] 2> 1037365 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[144 (1552175943093583872)]} 0 0 [junit4] 2> 1037365 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[145 (1552175943093583872)]} 0 0 [junit4] 2> 1037366 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[145 (1552175943093583873)]} 0 0 [junit4] 2> 1037366 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[146 (1552175943094632448)]} 0 0 [junit4] 2> 1037366 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[146 (1552175943094632448)]} 0 0 [junit4] 2> 1037367 INFO (qtp11700716-10626) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[147 (1552175943095681024)]} 0 0 [junit4] 2> 1037367 INFO (qtp1642174-10643) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[147 (1552175943095681024)]} 0 0 [junit4] 2> 1037368 INFO (qtp11700716-10631) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[148 (1552175943095681025)]} 0 0 [junit4] 2> 1037368 INFO (qtp1642174-10648) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[148 (1552175943096729600)]} 0 0 [junit4] 2> 1037368 INFO (qtp11700716-10632) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[149 (1552175943096729600)]} 0 0 [junit4] 2> 1037369 INFO (qtp1642174-10649) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={wt=javabin&version=2}{add=[149 (1552175943097778176)]} 0 0 [junit4] 2> 1037369 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1037369 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1071373 [junit4] 2> 1037375 INFO (qtp11700716-10633) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@950acb[collection1] main] [junit4] 2> 1037375 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1037376 INFO (searcherExecutor-5259-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@950acb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9) Uninverting(_1(7.0.0):C59)))} [junit4] 2> 1037376 INFO (qtp11700716-10633) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 7 [junit4] 2> 1037377 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1037377 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c2eaa5 [junit4] 2> 1037382 INFO (qtp1642174-10650) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1938061[collection1] main] [junit4] 2> 1037382 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1037383 INFO (searcherExecutor-5270-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1938061[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C9) Uninverting(_1(7.0.0):C59)))} [junit4] 2> 1037383 INFO (qtp1642174-10650) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/e_/w path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 6 [junit4] 2> 1037384 INFO (qtp11700716-10626) [ x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative [junit4] 2> 1037384 INFO (qtp11700716-10626) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*&distrib=false&start=-1&wt=javabin&version=2} status=400 QTime=0 [junit4] 2> 1037385 INFO (qtp11700716-10631) [ x:collection1] o.a.s.h.RequestHandlerBase Ignoring exception matching parameter cannot be negative [junit4] 2> 1037385 INFO (qtp11700716-10631) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*&distrib=false&start=0&rows=-1&wt=javabin&version=2} status=400 QTime=0 [junit4] 2> 1037385 INFO (qtp11700716-10632) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1037390 INFO (qtp1642174-10649) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+desc&shard.url=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1|[ff01::213]:33332/e_/w&rows=10&version=2&q=*:*&NOW=1480270331494&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1037391 INFO (qtp1642174-10650) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1480270331494&ids=132,112,148,116,6,129,108,140,130,142&isShard=true&shard.url=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1|[ff01::213]:33332/e_/w&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1037396 INFO (qtp1642174-10643) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&shards=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1|[ff01::213]:33332/e_/w&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=9 [junit4] 2> 1037397 INFO (qtp11700716-10633) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1037399 INFO (qtp1642174-10644) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_ti1+asc&shard.url=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&rows=10&version=2&q=*:*&NOW=1480270331505&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1037400 INFO (qtp1642174-10650) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1480270331505&ids=113,3,4,137,127,105,107,118,141,10&isShard=true&shard.url=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1037404 INFO (qtp1642174-10648) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&shards=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=5 [junit4] 2> 1037405 INFO (qtp11700716-10626) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1037408 INFO (qtp1642174-10643) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+desc&shard.url=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1|[ff01::213]:33332/e_/w&rows=10&version=2&q=*:*&NOW=1480270331514&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1037409 INFO (qtp1642174-10650) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1480270331514&ids=132,112,2,146,103,104,16,117,140,141&isShard=true&shard.url=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1|[ff01::213]:33332/e_/w&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1037412 INFO (qtp1642174-10649) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&shards=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1|[ff01::213]:33332/e_/w&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=4 [junit4] 2> 1037413 INFO (qtp11700716-10631) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1037415 INFO (qtp1642174-10648) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_f1+asc&shard.url=http://127.0.0.1:38254/e_/w/collection1&rows=10&version=2&q=*:*&NOW=1480270331521&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1037416 INFO (qtp1642174-10650) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1480270331521&ids=122,100,101,102,14,125,4,148,138,131&isShard=true&shard.url=http://127.0.0.1:38254/e_/w/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1037419 INFO (qtp1642174-10644) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&shards=http://127.0.0.1:38254/e_/w/collection1&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=5 [junit4] 2> 1037420 INFO (qtp11700716-10632) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1037422 INFO (qtp1642174-10649) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+desc&shard.url=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&rows=10&version=2&q=*:*&NOW=1480270331528&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1037422 INFO (qtp1642174-10650) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1480270331528&ids=143,132,1,102,126,116,105,117,118,10&isShard=true&shard.url=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1037424 INFO (qtp1642174-10643) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&shards=[ff01::114]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=3 [junit4] 2> 1037425 INFO (qtp11700716-10633) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 [junit4] 2> 1037429 INFO (qtp1642174-10644) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={distrib=false&fl=id&shards.purpose=4&start=0&fsv=true&sort=n_tf1+asc&shard.url=[ff01::213]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&rows=10&version=2&q=*:*&NOW=1480270331533&isShard=true&wt=javabin} hits=68 status=0 QTime=0 [junit4] 2> 1037433 INFO (qtp1642174-10644) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&shards.purpose=64&NOW=1480270331533&ids=12,4,137,5,16,129,107,9,109,131&isShard=true&shard.url=[ff01::213]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 1037434 INFO (qtp1642174-10648) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&shards=[ff01::213]:33332/e_/w|http://127.0.0.1:38254/e_/w/collection1&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=8 [junit4] 2> 1037436 INFO (qtp11700716-10626) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/e_/w path=/select params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} [...truncated too long message...] ExplicitHLLTest, TestSolrCLIRunExample, TestSystemIdResolver, SSLMigrationTest, TestManagedSchema, SolrIndexSplitterTest, DistanceUnitsTest, BigEndianAscendingWordDeserializerTest, DeleteStatusTest, TestExclusionRuleCollectionAccess, TestFieldCacheSortRandom, TestFilteredDocIdSet, HdfsRecoverLeaseTest, SpatialRPTFieldTypeTest, TermVectorComponentTest, MoreLikeThisHandlerTest, BooleanFieldTest, SolrCLIZkUtilsTest, DocValuesTest, OverseerStatusTest, TestSchemaManager, TestFieldTypeResource, TestRequestForwarding, SecurityConfHandlerTest, DistributedQueryComponentOptimizationTest, LoggingHandlerTest, TestDeleteCollectionOnDownNodes, DOMUtilTest, TestCharFilters, AlternateDirectoryTest, OpenCloseCoreStressTest, TestStressVersions, HdfsSyncSliceTest, TestFuzzyAnalyzedSuggestions, TestLeaderElectionZkExpiry, QueryParsingTest, TestNamedUpdateProcessors, TestElisionMultitermQuery, SpellCheckComponentTest, TestSlowCompositeReaderWrapper, IndexBasedSpellCheckerTest, HdfsDirectoryFactoryTest, TestManagedResource, DocumentBuilderTest, MultiThreadedOCPTest, SolrInfoMBeanTest, TestHdfsBackupRestoreCore, BlockJoinFacetSimpleTest, DirectSolrSpellCheckerTest, TestSubQueryTransformer, TestSimpleTrackingShardHandler, TestFiltering, ClassificationUpdateProcessorFactoryTest, ReplicationFactorTest, HLLUtilTest, ConvertedLegacyTest, TestAuthenticationFramework, TestSweetSpotSimilarityFactory, CollectionReloadTest, TestDocBasedVersionConstraints, CSVRequestHandlerTest, LeaderInitiatedRecoveryOnCommitTest, TermsComponentTest, ChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest, OverseerTest, LeaderElectionIntegrationTest, ShardRoutingTest, BasicZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, TestRandomFaceting, ZkSolrClientTest, TestZkChroot, ZkCLITest, ShardRoutingCustomTest, TestDistributedSearch] [junit4] Completed [312/658 (1!)] on J1 in 23.40s, 1 test, 1 failure <<< FAILURES! [...truncated 12308 lines...] [junit4] Suite: org.apache.solr.uima.processor.UIMAUpdateRequestProcessorTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/contrib/solr-uima/test/J0/temp/solr.uima.processor.UIMAUpdateRequestProcessorTest_BC54C64C05E23FB-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> nov 27, 2016 8:29:57 PM WhitespaceTokenizer initialize [junit4] 2> INFO: "Whitespace tokenizer successfully initialized" [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=UIMAUpdateRequestProcessorTest -Dtests.method=testProcessing -Dtests.seed=BC54C64C05E23FB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=et -Dtests.timezone=Asia/Tel_Aviv -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 4.07s 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([BC54C64C05E23FB:184B481687ADA251]: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: reproduce with: ant test -Dtestcase=UIMAUpdateRequestProcessorTest -Dtests.method=testMultiplierProcessing -Dtests.seed=BC54C64C05E23FB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=et -Dtests.timezone=Asia/Tel_Aviv -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.21s 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([BC54C64C05E23FB:30C486C9C70A0F0F]: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=testErrorHandling -Dtests.seed=BC54C64C05E23FB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=et -Dtests.timezone=Asia/Tel_Aviv -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.01s 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([BC54C64C05E23FB:3E31325A9688A22F]: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=BC54C64C05E23FB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=et -Dtests.timezone=Asia/Tel_Aviv -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([BC54C64C05E23FB:68F1B3BD8714155]: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> nov 27, 2016 8:30:00 PM WhitespaceTokenizer initialize [junit4] 2> INFO: "Whitespace tokenizer successfully initialized" [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/contrib/solr-uima/test/J0/temp/solr.uima.processor.UIMAUpdateRequestProcessorTest_BC54C64C05E23FB-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1677, maxMBSortInHeap=6.688179782743978, sim=RandomSimilarity(queryNorm=true): {}, locale=et, timezone=Asia/Tel_Aviv [junit4] 2> NOTE: Linux 4.4.0-47-generic i386/Oracle Corporation 1.8.0_102 (32-bit)/cpus=12,threads=1,free=179540848,total=344043520 [junit4] 2> NOTE: All tests run in this JVM: [UIMAUpdateRequestProcessorTest] [junit4] Completed [2/2 (1!)] on J0 in 9.65s, 6 tests, 4 errors <<< FAILURES! [...truncated 43379 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org