Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7099/ Java: 32bit/jdk1.8.0_144 -client -XX:+UseConcMarkSweepGC
4 tests failed. FAILED: org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testNodeMarkersRegistration Error Message: Path /autoscaling/nodeAdded/127.0.0.1:10156_solr should have been deleted Stack Trace: java.lang.AssertionError: Path /autoscaling/nodeAdded/127.0.0.1:10156_solr should have been deleted at __randomizedtesting.SeedInfo.seed([5EED086FD68E3C60:46578063D8BBF18F]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertFalse(Assert.java:68) at org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testNodeMarkersRegistration(TestTriggerIntegration.java:842) 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:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) 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:368) at java.lang.Thread.run(Thread.java:748) FAILED: junit.framework.TestSuite.org.apache.solr.handler.component.DistributedDebugComponentTest Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data\spellcheckerFQCN: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data\spellcheckerFQCN C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data\spellcheckerFQCN: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data\spellcheckerFQCN C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001 at __randomizedtesting.SeedInfo.seed([5EED086FD68E3C60]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) 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:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeLost Error Message: Trigger was not fired even after 10 seconds Stack Trace: java.lang.AssertionError: Trigger was not fired even after 10 seconds at __randomizedtesting.SeedInfo.seed([5EED086FD68E3C60:E1F8C691556459E6]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeLost(ComputePlanActionTest.java:209) 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:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) 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:368) at java.lang.Thread.run(Thread.java:748) FAILED: junit.framework.TestSuite.org.apache.solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-ner-person.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-ner-person.bin C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-tokenizer.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-tokenizer.bin C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-sent.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-sent.bin C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-ner-person.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-ner-person.bin C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-tokenizer.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-tokenizer.bin C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-sent.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-sent.bin C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001 at __randomizedtesting.SeedInfo.seed([D7E02347457CD7C4]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) 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:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 11653 lines...] [junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\init-core-data-001 [junit4] 2> 33471 WARN (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1 [junit4] 2> 33471 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 33477 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 33478 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 33523 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 33525 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 33525 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core [junit4] 2> 33529 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 33529 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@e265af{/solr,null,AVAILABLE} [junit4] 2> 33533 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1513da0{HTTP/1.1,[http/1.1]}{127.0.0.1:49158} [junit4] 2> 33533 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.e.j.s.Server Started @40915ms [junit4] 2> 33533 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=49158, configSetBaseDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-001, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores} [junit4] 2> 33534 ERROR (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 33534 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0 [junit4] 2> 33534 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 33534 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 33534 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-07T13:33:26.223Z [junit4] 2> 33534 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-001\solr.xml [junit4] 2> 33555 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 33555 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 33567 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1f73ee7, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 33767 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f73ee7 [junit4] 2> 33795 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f73ee7 [junit4] 2> 33795 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f73ee7 [junit4] 2> 33803 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores [junit4] 2> 33804 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 33855 INFO (coreLoadExecutor-88-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 33943 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 34001 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 34281 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 34317 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-001\collection1, trusted=true [junit4] 2> 34318 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f73ee7 [junit4] 2> 34318 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 34318 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\core\data\] [junit4] 2> 34322 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=92.22265625, floorSegmentMB=1.5986328125, forceMergeDeletesPctAllowed=15.392835035285179, segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 34563 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 34565 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 34567 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 34567 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 34598 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=14, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=60.2099609375, floorSegmentMB=1.5263671875, forceMergeDeletesPctAllowed=20.461857226793303, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48099760355451915 [junit4] 2> 34599 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@193a217[collection1] main] [junit4] 2> 34602 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 34617 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 34681 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 34682 INFO (coreLoadExecutor-88-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1588940774961053696 [junit4] 2> 34683 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 34684 INFO (SUITE-DistributedDebugComponentTest-seed#[5EED086FD68E3C60]-worker) [ ] o.a.s.SolrJettyTestBase Jetty Assigned Port#49158 [junit4] 2> 34684 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 34684 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 34684 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 34685 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 34687 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 34688 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 34692 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 34693 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 34699 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@193a217[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 34717 INFO (qtp20683723-222) [ ] o.a.s.h.a.CoreAdminOperation core create command name=collection2&action=CREATE&configSet=collection1&wt=javabin&version=2 [junit4] 2> 34769 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 34806 INFO (qtp20683723-222) [ x:collection2] o.a.s.s.IndexSchema [collection2] Schema name=test [junit4] 2> 34986 INFO (qtp20683723-222) [ x:collection2] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 35027 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-001\collection1, trusted=true [junit4] 2> 35027 INFO (qtp20683723-222) [ x:collection2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection2' (registry 'solr.core.collection2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f73ee7 [junit4] 2> 35027 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 35032 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.handler.component.DistributedDebugComponentTest_5EED086FD68E3C60-001\tempDir-002\cores\collection2\data\] [junit4] 2> 35041 INFO (qtp20683723-222) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=92.22265625, floorSegmentMB=1.5986328125, forceMergeDeletesPctAllowed=15.392835035285179, segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 35300 INFO (qtp20683723-222) [ x:collection2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 35300 INFO (qtp20683723-222) [ x:collection2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 35302 INFO (qtp20683723-222) [ x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 35302 INFO (qtp20683723-222) [ x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 35327 INFO (qtp20683723-222) [ x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=14, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=60.2099609375, floorSegmentMB=1.5263671875, forceMergeDeletesPctAllowed=20.461857226793303, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.48099760355451915 [junit4] 2> 35331 INFO (qtp20683723-222) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@a99e62[collection2] main] [junit4] 2> 35340 INFO (qtp20683723-222) [ x:collection2] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 35364 INFO (qtp20683723-222) [ x:collection2] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 35436 INFO (qtp20683723-222) [ x:collection2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 35437 INFO (qtp20683723-222) [ x:collection2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1588940775752728576 [junit4] 2> 35437 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 35438 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 35438 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 35438 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 35439 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 35439 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 35440 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 35440 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 35441 INFO (qtp20683723-222) [ x:collection2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={name=collection2&action=CREATE&configSet=collection1&wt=javabin&version=2} status=0 QTime=728 [junit4] 2> 35443 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 35453 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@a99e62[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 35460 INFO (qtp20683723-221) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1 (1588940775762165760)]} 0 15 [junit4] 2> 35462 INFO (qtp20683723-220) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1588940775778942976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 35462 INFO (qtp20683723-220) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@f4236d commitCommandVersion:1588940775778942976 [junit4] 2> 35591 INFO (qtp20683723-220) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c5e031[collection1] main] [junit4] 2> 35597 INFO (qtp20683723-220) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 35603 INFO (searcherExecutor-89-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c5e031[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)))} [junit4] 2> 35604 INFO (qtp20683723-220) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 141 [junit4] 2> 35627 INFO (qtp20683723-218) [ x:collection2] o.a.s.u.p.LogUpdateProcessorFactory [collection2] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2 (1588940775935180800)]} 0 20 [junit4] 2> 35630 INFO (qtp20683723-218) [ x:collection2] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1588940775955103744,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 35631 INFO (qtp20683723-218) [ x:collection2] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1fd3bbf commitCommandVersion:1588940775955103744 [junit4] 2> 35657 INFO (qtp20683723-218) [ x:collection2] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d46907[collection2] main] [junit4] 2> 35663 INFO (qtp20683723-218) [ x:collection2] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 35667 INFO (searcherExecutor-94-thread-1-processing-x:collection2) [ x:collection2] o.a.s.c.SolrCore [collection2] Registered new searcher Searcher@1d46907[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c1)))} [junit4] 2> 35667 INFO (qtp20683723-218) [ x:collection2] o.a.s.u.p.LogUpdateProcessorFactory [collection2] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 36 [junit4] 2> 35674 INFO (TEST-DistributedDebugComponentTest.testRandom-seed#[5EED086FD68E3C60]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRandom [junit4] 2> 35739 INFO (qtp20683723-228) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008382-0&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008381&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=32 [junit4] 2> 35742 INFO (qtp20683723-225) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008382-0&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008381&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35754 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=true&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008382-0 hits=0 status=0 QTime=61 [junit4] 2> 35775 INFO (qtp20683723-221) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection1-1515332008462-1&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008461&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35776 INFO (qtp20683723-219) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008462-1 hits=0 status=0 QTime=3 [junit4] 2> 35780 INFO (qtp20683723-218) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008467-2&rows=10&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_TOP_IDS&NOW=1515332008466&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35781 INFO (qtp20683723-220) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008467-2 hits=0 status=0 QTime=3 [junit4] 2> 35789 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008471-3&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008471&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=4 [junit4] 2> 35808 INFO (qtp20683723-228) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008471-3&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008471&ids=2&isShard=true&wt=javabin} status=0 QTime=7 [junit4] 2> 35809 INFO (qtp20683723-218) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008471-3 hits=1 status=0 QTime=26 [junit4] 2> 35813 INFO (qtp20683723-229) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008500&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1 [junit4] 2> 35815 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008500&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35816 INFO (qtp20683723-225) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=query&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=5 [junit4] 2> 35820 INFO (qtp20683723-219) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008507&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35821 INFO (qtp20683723-221) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=timing&debug=query&debug=results&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=2 [junit4] 2> 35825 INFO (qtp20683723-219) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008512-4&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008512&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35827 INFO (qtp20683723-219) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection1-1515332008512-4&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008512&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35829 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=query&debug=track&debug=query&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008512-4&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008512&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 35830 INFO (qtp20683723-220) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008512-4 hits=1 status=0 QTime=7 [junit4] 2> 35832 INFO (qtp20683723-218) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008521-5&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008521&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35834 INFO (qtp20683723-228) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008521-5 hits=0 status=0 QTime=2 [junit4] 2> 35838 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008525&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35838 INFO (qtp20683723-225) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=2 [junit4] 2> 35842 INFO (qtp20683723-219) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1515332008529&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35842 INFO (qtp20683723-222) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1515332008529&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35846 INFO (qtp20683723-227) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&df=text&debug=timing&debug=query&debug=results&debug=query&debug=results&debug=timing&fl=id,text&shards.purpose=320&NOW=1515332008529&ids=1&isShard=true&shard.url=127.0.0.1:49158/solr/collection1&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 35848 INFO (qtp20683723-221) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=query&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=8 [junit4] 2> 35856 INFO (qtp20683723-218) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection1-1515332008542-6&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008541&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35856 INFO (qtp20683723-220) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008542-6 hits=0 status=0 QTime=4 [junit4] 2> 35861 INFO (qtp20683723-229) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection1-1515332008548-7&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008548&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35862 INFO (qtp20683723-228) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008548-7 hits=0 status=0 QTime=2 [junit4] 2> 35865 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008551-8&rows=10&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_TOP_IDS&NOW=1515332008551&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35865 INFO (qtp20683723-228) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008551-8 hits=0 status=0 QTime=2 [junit4] 2> 35870 INFO (qtp20683723-219) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008557-9&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008556&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35876 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=query&debug=results&debug=track&debug=query&debug=results&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008557-9&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008556&ids=2&isShard=true&wt=javabin} status=0 QTime=1 [junit4] 2> 35877 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008557-9 hits=1 status=0 QTime=9 [junit4] 2> 35880 INFO (qtp20683723-218) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008566&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35881 INFO (qtp20683723-221) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=2 [junit4] 2> 35885 INFO (qtp20683723-225) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1515332008572&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35888 INFO (qtp20683723-229) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&df=text&debug=timing&debug=query&debug=results&debug=query&debug=results&debug=timing&fl=id,text&shards.purpose=320&NOW=1515332008572&ids=1&isShard=true&shard.url=127.0.0.1:49158/solr/collection1&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 35888 INFO (qtp20683723-220) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=timing&debug=query&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=5 [junit4] 2> 35894 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008579-10&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008579&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1 [junit4] 2> 35894 INFO (qtp20683723-219) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008579-10&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008579&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2 [junit4] 2> 35897 INFO (qtp20683723-218) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=query&debug=results&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008579-10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008579&ids=1&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=1 [junit4] 2> 35898 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=query&debug=results&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008579-10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008579&ids=2&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=1 [junit4] 2> 35899 INFO (qtp20683723-228) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008579-10 hits=2 status=0 QTime=8 [junit4] 2> 35902 INFO (qtp20683723-225) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1515332008589&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35905 INFO (qtp20683723-229) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&df=text&debug=results&debug=results&fl=id,text&shards.purpose=320&NOW=1515332008589&ids=1&isShard=true&shard.url=127.0.0.1:49158/solr/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 35905 INFO (qtp20683723-221) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=5 [junit4] 2> 35911 INFO (qtp20683723-227) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008598-11&rows=10&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_TOP_IDS&NOW=1515332008596&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35913 INFO (qtp20683723-219) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008598-11&rows=10&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_TOP_IDS&NOW=1515332008596&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1 [junit4] 2> 35915 INFO (qtp20683723-218) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=query&debug=results&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008598-11&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008596&ids=1&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=0 [junit4] 2> 35916 INFO (qtp20683723-220) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008598-11 hits=1 status=0 QTime=9 [junit4] 2> 35919 INFO (qtp20683723-228) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1515332008607&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35922 INFO (qtp20683723-225) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&df=text&debug=timing&debug=results&debug=results&debug=timing&fl=id,text&shards.purpose=320&NOW=1515332008607&ids=2&isShard=true&shard.url=127.0.0.1:49158/solr/collection2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 35923 INFO (qtp20683723-222) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=5 [junit4] 2> 35926 INFO (qtp20683723-221) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1515332008613&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35928 INFO (qtp20683723-227) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&df=text&debug=timing&debug=query&debug=query&debug=timing&fl=id,text&shards.purpose=320&NOW=1515332008613&ids=1&isShard=true&shard.url=127.0.0.1:49158/solr/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 35929 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=timing&debug=query&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=5 [junit4] 2> 35933 INFO (qtp20683723-218) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008620-12&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008620&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35935 INFO (qtp20683723-220) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008620-12&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008620&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 35936 INFO (qtp20683723-219) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008620-12 hits=1 status=0 QTime=5 [junit4] 2> 35939 INFO (qtp20683723-225) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008627-13&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008627&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35940 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008627-13&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008627&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35943 INFO (qtp20683723-228) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008627-13 hits=0 status=0 QTime=5 [junit4] 2> 35946 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008633&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35947 INFO (qtp20683723-225) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=2 [junit4] 2> 35952 INFO (qtp20683723-218) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008637-14&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008637&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2 [junit4] 2> 35955 INFO (qtp20683723-220) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=query&debug=results&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008637-14&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008637&ids=1&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=1 [junit4] 2> 35956 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=timing&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008637-14 hits=1 status=0 QTime=7 [junit4] 2> 35961 INFO (qtp20683723-221) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection1-1515332008647-15&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008646&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35962 INFO (qtp20683723-219) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008647-15 hits=0 status=0 QTime=4 [junit4] 2> 35965 INFO (qtp20683723-228) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008653-16&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008652&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35966 INFO (qtp20683723-222) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008653-16 hits=0 status=0 QTime=2 [junit4] 2> 35969 INFO (qtp20683723-225) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1515332008656&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35972 INFO (qtp20683723-218) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&df=text&debug=timing&debug=results&debug=results&debug=timing&fl=id,text&shards.purpose=320&NOW=1515332008656&ids=2&isShard=true&shard.url=127.0.0.1:49158/solr/collection2&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 35973 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=5 [junit4] 2> 35976 INFO (qtp20683723-229) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1515332008663&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35976 INFO (qtp20683723-221) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1515332008663&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35978 INFO (qtp20683723-219) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&df=text&debug=timing&debug=timing&fl=id,text&shards.purpose=320&NOW=1515332008663&ids=1&isShard=true&shard.url=127.0.0.1:49158/solr/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 35979 INFO (qtp20683723-220) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=5 [junit4] 2> 35982 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008669&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35982 INFO (qtp20683723-225) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008669&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35982 INFO (qtp20683723-228) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=2 [junit4] 2> 35985 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008673-17&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008672&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 35987 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=results&debug=track&debug=results&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection1-1515332008673-17&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008672&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 35988 INFO (qtp20683723-218) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008673-17 hits=1 status=0 QTime=4 [junit4] 2> 35991 INFO (qtp20683723-219) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1515332008678&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35992 INFO (qtp20683723-221) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=2 [junit4] 2> 35995 INFO (qtp20683723-222) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection2-1515332008682-18&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008682&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35995 INFO (qtp20683723-225) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008682-18&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008682&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 35996 INFO (qtp20683723-220) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1,127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008682-18 hits=0 status=0 QTime=3 [junit4] 2> 35999 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1515332008686&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 36001 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&df=text&debug=query&debug=results&debug=query&debug=results&fl=id,text&shards.purpose=320&NOW=1515332008686&ids=2&isShard=true&shard.url=127.0.0.1:49158/solr/collection2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 36002 INFO (qtp20683723-222) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=query&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=4 [junit4] 2> 36005 INFO (qtp20683723-219) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008693-19&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008692&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 36007 INFO (qtp20683723-221) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=query&debug=track&debug=query&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008693-19&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008692&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 36010 INFO (qtp20683723-218) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008693-19 hits=1 status=0 QTime=6 [junit4] 2> 36013 INFO (qtp20683723-228) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1515332008700&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 36015 INFO (qtp20683723-220) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&df=text&debug=query&debug=query&fl=id,text&shards.purpose=320&NOW=1515332008700&ids=1&isShard=true&shard.url=127.0.0.1:49158/solr/collection1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 36016 INFO (qtp20683723-225) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=4 [junit4] 2> 36019 INFO (qtp20683723-229) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008706-20&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1515332008706&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0 [junit4] 2> 36021 INFO (qtp20683723-222) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={distrib=false&df=text&debug=timing&debug=track&debug=timing&debug=track&fl=id,text&shards.purpose=320&shard.url=127.0.0.1:49158/solr/collection2&rid=127.0.0.1-collection2-1515332008706-20&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1515332008706&ids=2&isShard=true&wt=javabin} status=0 QTime=0 [junit4] 2> 36022 INFO (qtp20683723-227) [ x:collection2] o.a.s.c.S.Request [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:49158/solr/collection2&distrib=true&debug=timing&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1515332008706-20 hits=1 status=0 QTime=4 [junit4] 2> 36026 INFO (qtp20683723-221) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection1-1515332008712-21&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008712&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 36027 INFO (qtp20683723-219) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:49158/solr/collection1&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1515332008712-21 hits=0 status=0 QTime=4 [junit4] 2> 36030 INFO (qtp20683723-228) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={distrib=false&df=text&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=127.0.0.1:49158/solr/collection1&rid=127.0.0.1-collection1-1515332008718-22&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1515332008718&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0 [junit4] 2> 36031 INFO (qtp20683723-218) [ x:collection1] o.a.s.c.S.Request [collection1] [...truncated too long message...] e, DefaultValueUpdateProcessorTest, TestExclusionRuleCollectionAccess, ExitableDirectoryReaderTest, SuggesterWFSTTest, MultiThreadedOCPTest, V2ApiIntegrationTest, MultiTermTest, HttpSolrCallGetCoreTest, TemplateUpdateProcessorTest, TestPointFields, TestSolrCloudWithKerberosAlt, DeleteNodeTest, TestFiltering, AddReplicaTest, TestSortByMinMaxFunction, BlobRepositoryCloudTest, IndexSchemaTest, CreateCollectionCleanupTest, CdcrReplicationHandlerTest, ShardSplitTest, ReturnFieldsTest, OverseerTaskQueueTest, SpellCheckCollatorTest, BlockJoinFacetDistribTest, HdfsNNFailoverTest, ConfigSetsAPITest, UninvertDocValuesMergePolicyTest, TestHighFrequencyDictionaryFactory, TestPseudoReturnFields, ManagedSchemaRoundRobinCloudTest, ResponseLogComponentTest, TestSchemaNameResource, DirectUpdateHandlerTest, TestCodecSupport, CollectionReloadTest, JavabinLoaderTest, TestFileDictionaryLookup, TestRandomDVFaceting, TestLegacyTerms, CustomHighlightComponentTest, TestSubQueryTransformer, HdfsAutoAddReplicasIntegrationTest, SolrCloudExampleTest, TestMinMaxOnMultiValuedField, TestOnReconnectListenerSupport, ClusterStateTest, TestDistributedSearch, TestBlobHandler, ScriptEngineTest, IndexBasedSpellCheckerTest, ShardRoutingTest, TestClusterProperties, TestLargeCluster, TestExecutePlanAction, InfoHandlerTest, SolrCoreMetricManagerTest, TestRequestForwarding, TestCloudInspectUtil, TestCloudSchemaless, SimpleCollectionCreateDeleteTest, TestManagedStopFilterFactory, SimpleMLTQParserTest, DistributedQueryElevationComponentTest, SpatialHeatmapFacetsTest, TestRandomFlRTGCloud, ComputePlanActionTest, TestDelegationWithHadoopAuth, MetricTriggerTest, DistributedTermsComponentTest, MetricUtilsTest, ShowFileRequestHandlerTest, TestQueryWrapperFilter, RegexBoostProcessorTest, HighlighterTest, SolrIndexMetricsTest, RequestHandlersTest, CollectionTooManyReplicasTest, MinimalSchemaTest, TestLegacyFieldReuse, TestSchemaSimilarityResource, TestDynamicLoading, NotRequiredUniqueKeyTest, TestHashQParserPlugin, ForceLeaderTest, TestSurroundQueryParser, TestSolrCoreProperties, TestTolerantSearch, NodeLostTriggerTest, TestBinaryResponseWriter, TimeRoutedAliasUpdateProcessorTest, TestRealTimeGet, CollectionsAPISolrJTest, TestNRTOpen, ResourceLoaderTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, OpenCloseCoreStressTest, OverseerTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, LeaderElectionTest, TestZkChroot, ZkCLITest, TestFaceting, TestHashPartitioner, DistributedSpellCheckComponentTest, ZkControllerTest, SimpleFacetsTest, StatsComponentTest, ConvertedLegacyTest, TestFunctionQuery, TestLazyCores, CoreAdminHandlerTest, SuggesterTSTTest, SuggesterTest, TestStressLucene, TestCSVLoader, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, TestWordDelimiterFilterFactory, QueryEqualityTest, DirectUpdateHandlerOptimizeTest, SortByFunctionTest, DocValuesMultiTest, TestSolrDeletionPolicy1, DebugComponentTest, DisMaxRequestHandlerTest, TestReversedWildcardFilterFactory, TestQueryTypes, TestOmitPositions, TermsComponentTest, MoreLikeThisHandlerTest, FieldAnalysisRequestHandlerTest, FastVectorHighlighterTest, TestJmxIntegration, QueryParsingTest, UniqFieldsUpdateProcessorFactoryTest, TestPHPSerializedResponseWriter, CSVRequestHandlerTest, TestLFUCache, BadComponentTest, TestStressRecovery, TestSolrDeletionPolicy2, TestSearchPerf, NumericFieldsTest, TestConfig, DirectSolrConnectionTest, TestPhraseSuggestions, TestLMJelinekMercerSimilarityFactory, PreAnalyzedFieldTest, SpellingQueryConverterTest, DOMUtilTest, ZkNodePropsTest, SystemInfoHandlerTest, FileUtilsTest, DistributedMLTComponentTest, DistributedIntervalFacetingTest, AliasIntegrationTest, AssignTest, ChaosMonkeySafeLeaderWithPullReplicasTest, CleanupOldIndexTest, CustomCollectionTest, DistribDocExpirationUpdateProcessorTest, HealthCheckHandlerTest, HttpPartitionTest, SSLMigrationTest, SaslZkACLProviderTest, TestCollectionAPI, TestDownShardTolerantSearch, TestLeaderElectionWithEmptyReplica, TestLeaderInitiatedRecoveryThread, TestLockTree, TestMiniSolrCloudClusterSSL, TestPullReplica, TestRequestStatusCollectionAPI, TestShortCircuitedRequests, TestSkipOverseerOperations, TestStressLiveNodes, TestTlogReplica, AutoAddReplicasIntegrationTest, TestClusterStateProvider, TestComputePlanAction, TestDistribStateManager, TestGenericDistributedQueue, TestNodeLostTrigger, TestSimDistributedQueue, TestTriggerIntegration] [junit4] Completed [587/766 (3!)] on J0 in 3.98s, 11 tests, 1 failure <<< FAILURES! [...truncated 3051 lines...] [junit4] Suite: org.apache.solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\init-core-data-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1847, maxMBSortInHeap=7.719068066521766, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4f7b24), locale=lt-LT, timezone=Australia/West [junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_144 (32-bit)/cpus=3,threads=1,free=11881016,total=29863936 [junit4] 2> NOTE: All tests run in this JVM: [TestICUCollationFieldOptions, TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory -Dtests.seed=D7E02347457CD7C4 -Dtests.slow=true -Dtests.locale=lt-LT -Dtests.timezone=Australia/West -Dtests.asserts=true -Dtests.file.encoding=Cp1252 [junit4] ERROR 0.00s J1 | TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-ner-person.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-ner-person.bin [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-tokenizer.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-tokenizer.bin [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-sent.bin: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001\tempDir-001\collection1\conf\en-test-sent.bin [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\contrib\solr-analysis-extras\test\J1\temp\solr.update.processor.TestOpenNLPExtractNamedEntitiesUpdateProcessorFactory_D7E02347457CD7C4-001 [junit4] > at __randomizedtesting.SeedInfo.seed([D7E02347457CD7C4]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [3/5 (1!)] on J1 in 1.27s, 8 tests, 1 error <<< FAILURES! [...truncated 41448 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org