You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/10/02 08:05:16 UTC
[JENKINS] Lucene-Solr-7.0-Windows (64bit/jdk1.8.0_144) - Build #
180 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.0-Windows/180/
Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseSerialGC
2 tests failed.
FAILED: org.apache.solr.cloud.TestTlogReplica.testOnlyLeaderIndexes
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([625C2FF31CC2D857:7E5D527E6967A6C4]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertFalse(Assert.java:68)
at org.junit.Assert.assertFalse(Assert.java:79)
at org.apache.solr.cloud.TestTlogReplica.testOnlyLeaderIndexes(TestTlogReplica.java:497)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: junit.framework.TestSuite.org.apache.solr.handler.component.DistributedMLTComponentTest
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\collection1 C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2 C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\collection1
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2
C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001
at __randomizedtesting.SeedInfo.seed([625C2FF31CC2D857]: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 12599 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedMLTComponentTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\init-core-data-001
[junit4] 2> 1664377 INFO (SUITE-DistributedMLTComponentTest-seed#[625C2FF31CC2D857]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1664382 INFO (SUITE-DistributedMLTComponentTest-seed#[625C2FF31CC2D857]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1664382 INFO (SUITE-DistributedMLTComponentTest-seed#[625C2FF31CC2D857]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /y_/cp
[junit4] 2> 1664803 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\control\cores\collection1
[junit4] 2> 1664805 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1664806 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2b15abc6{/y_/cp,null,AVAILABLE}
[junit4] 2> 1664806 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5d2fcb67{HTTP/1.1,[http/1.1]}{127.0.0.1:53064}
[junit4] 2> 1664806 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.Server Started @1667725ms
[junit4] 2> 1664806 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/y_/cp, hostPort=53064, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\control\cores}
[junit4] 2> 1664807 ERROR (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1664807 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.1
[junit4] 2> 1664807 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1664807 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 1664807 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-02T07:24:45.937Z
[junit4] 2> 1664808 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\control\solr.xml
[junit4] 2> 1664822 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1664889 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1664896 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1664896 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1664899 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\control\cores
[junit4] 2> 1664899 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1664900 INFO (coreLoadExecutor-8516-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1664900 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.0-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.0-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1664968 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.1
[junit4] 2> 1664984 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1665075 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1665092 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1665092 INFO (coreLoadExecutor-8516-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@7dd283d9
[junit4] 2> 1665093 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1665093 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\control\cores\collection1\data\]
[junit4] 2> 1665110 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=22.5068359375, floorSegmentMB=1.080078125, forceMergeDeletesPctAllowed=12.852692314339286, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7943300468678157
[junit4] 2> 1665219 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1665220 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1665222 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1665223 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1665226 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=38.232421875, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=12.547988415801703, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8559955753526725
[junit4] 2> 1665228 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5dfcec48[collection1] main]
[junit4] 2> 1665232 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1665245 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1665278 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1665278 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1665280 INFO (coreLoadExecutor-8516-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1580129673711452160
[junit4] 2> 1665282 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1665282 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1665282 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1665283 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1665285 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1665286 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1665287 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1665287 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1665287 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5dfcec48[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1666191 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard0\cores\collection1
[junit4] 2> 1666193 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1666193 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@162e2f5f{/y_/cp,null,AVAILABLE}
[junit4] 2> 1666194 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1dc0080{HTTP/1.1,[http/1.1]}{127.0.0.1:53070}
[junit4] 2> 1666194 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.Server Started @1669112ms
[junit4] 2> 1666194 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/y_/cp, hostPort=53070, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard0\cores}
[junit4] 2> 1666194 ERROR (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1666195 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.1
[junit4] 2> 1666195 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1666195 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 1666195 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-02T07:24:47.325Z
[junit4] 2> 1666195 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard0\solr.xml
[junit4] 2> 1666203 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1666291 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1666298 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1666298 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1666301 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard0\cores
[junit4] 2> 1666301 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1666340 INFO (coreLoadExecutor-8527-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1666341 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.0-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.0-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1666394 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.1
[junit4] 2> 1666415 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1666499 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1666508 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1666508 INFO (coreLoadExecutor-8527-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@7dd283d9
[junit4] 2> 1666508 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1666508 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard0\cores\collection1\data\]
[junit4] 2> 1666511 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=22.5068359375, floorSegmentMB=1.080078125, forceMergeDeletesPctAllowed=12.852692314339286, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7943300468678157
[junit4] 2> 1666589 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1666589 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1666590 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1666590 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1666591 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=38.232421875, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=12.547988415801703, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8559955753526725
[junit4] 2> 1666591 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6e708353[collection1] main]
[junit4] 2> 1666592 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1666597 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1666639 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1666639 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1666639 INFO (coreLoadExecutor-8527-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1580129675136466944
[junit4] 2> 1666640 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1666640 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1666640 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1666640 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1666640 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1666641 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1666641 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1666641 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1666642 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6e708353[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1667115 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard1\cores\collection1
[junit4] 2> 1667120 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1667121 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@56ab685a{/y_/cp,null,AVAILABLE}
[junit4] 2> 1667122 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2ae03a1a{HTTP/1.1,[http/1.1]}{127.0.0.1:53078}
[junit4] 2> 1667122 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.Server Started @1670041ms
[junit4] 2> 1667122 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/y_/cp, hostPort=53078, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard1\cores}
[junit4] 2> 1667124 ERROR (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1667124 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.1
[junit4] 2> 1667124 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1667124 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 1667124 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-02T07:24:48.254Z
[junit4] 2> 1667125 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard1\solr.xml
[junit4] 2> 1667137 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1667229 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1667237 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1667237 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1667240 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard1\cores
[junit4] 2> 1667240 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1667241 INFO (coreLoadExecutor-8538-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1667242 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.0-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.0-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1667298 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.1
[junit4] 2> 1667314 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1667407 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1667415 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1667415 INFO (coreLoadExecutor-8538-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@7dd283d9
[junit4] 2> 1667415 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1667415 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard1\cores\collection1\data\]
[junit4] 2> 1667417 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=22.5068359375, floorSegmentMB=1.080078125, forceMergeDeletesPctAllowed=12.852692314339286, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7943300468678157
[junit4] 2> 1667498 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1667499 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1667500 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1667500 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1667501 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=38.232421875, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=12.547988415801703, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8559955753526725
[junit4] 2> 1667501 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5b8f7e5a[collection1] main]
[junit4] 2> 1667502 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1667511 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1667547 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1667547 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1667547 INFO (coreLoadExecutor-8538-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1580129676088573952
[junit4] 2> 1667547 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1667547 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1667547 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1667548 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1667549 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1667549 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1667549 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1667550 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1667551 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5b8f7e5a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1668030 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\cores\collection1
[junit4] 2> 1668032 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1668032 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@24e60222{/y_/cp,null,AVAILABLE}
[junit4] 2> 1668034 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@741c4ca2{HTTP/1.1,[http/1.1]}{127.0.0.1:53081}
[junit4] 2> 1668034 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.e.j.s.Server Started @1670952ms
[junit4] 2> 1668034 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/y_/cp, hostPort=53081, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\cores}
[junit4] 2> 1668034 ERROR (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1668034 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.1
[junit4] 2> 1668034 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1668034 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null
[junit4] 2> 1668034 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-10-02T07:24:49.164Z
[junit4] 2> 1668035 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\solr.xml
[junit4] 2> 1668041 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1668116 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1668125 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1668125 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7dd283d9
[junit4] 2> 1668130 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\cores
[junit4] 2> 1668130 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1668131 INFO (coreLoadExecutor-8549-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1668131 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.0-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.0-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1668184 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.1
[junit4] 2> 1668230 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1668327 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1668337 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\core\src\test-files\solr\collection1, trusted=true
[junit4] 2> 1668337 INFO (coreLoadExecutor-8549-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@7dd283d9
[junit4] 2> 1668337 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1668337 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_625C2FF31CC2D857-001\tempDir-001\shard2\cores\collection1\data\]
[junit4] 2> 1668339 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=22.5068359375, floorSegmentMB=1.080078125, forceMergeDeletesPctAllowed=12.852692314339286, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7943300468678157
[junit4] 2> 1668425 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1668425 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1668426 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1668426 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1668427 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=38.232421875, floorSegmentMB=1.974609375, forceMergeDeletesPctAllowed=12.547988415801703, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8559955753526725
[junit4] 2> 1668427 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1995a88c[collection1] main]
[junit4] 2> 1668428 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1668437 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1668468 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1668468 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1668469 INFO (coreLoadExecutor-8549-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1580129677055361024
[junit4] 2> 1668471 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1668471 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1668471 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1668472 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1668472 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1668472 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1668473 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1668473 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1668476 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1995a88c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1668979 INFO (TEST-DistributedMLTComponentTest.test-seed#[625C2FF31CC2D857]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1668992 INFO (qtp1325294780-17939) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1580129677602717696)} 0 1
[junit4] 2> 1669001 INFO (qtp666924566-17959) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1580129677605863424)} 0 7
[junit4] 2> 1669012 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1580129677615300608)} 0 9
[junit4] 2> 1669023 INFO (qtp1787034192-17996) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1580129677627883520)} 0 7
[junit4] 2> 1669028 INFO (qtp1325294780-17943) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[1 (1580129677637320704)]} 0 3
[junit4] 2> 1669032 INFO (qtp666924566-17961) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[1 (1580129677641515008)]} 0 3
[junit4] 2> 1669033 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[2 (1580129677646757888)]} 0 0
[junit4] 2> 1669038 INFO (qtp1932811662-17979) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[2 (1580129677647806464)]} 0 3
[junit4] 2> 1669038 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[3 (1580129677652000768)]} 0 0
[junit4] 2> 1669048 INFO (qtp1787034192-17998) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[3 (1580129677652000768)]} 0 9
[junit4] 2> 1669049 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[4 (1580129677663535104)]} 0 0
[junit4] 2> 1669050 INFO (qtp666924566-17962) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[4 (1580129677664583680)]} 0 0
[junit4] 2> 1669051 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[5 (1580129677665632256)]} 0 0
[junit4] 2> 1669051 INFO (qtp1932811662-17980) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[5 (1580129677665632256)]} 0 0
[junit4] 2> 1669052 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[6 (1580129677666680832)]} 0 0
[junit4] 2> 1669055 INFO (qtp1787034192-17998) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[6 (1580129677668777984)]} 0 1
[junit4] 2> 1669056 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[7 (1580129677669826560)]} 0 0
[junit4] 2> 1669057 INFO (qtp666924566-17962) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[7 (1580129677671923712)]} 0 0
[junit4] 2> 1669057 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[8 (1580129677671923712)]} 0 0
[junit4] 2> 1669058 INFO (qtp1932811662-17980) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[8 (1580129677671923712)]} 0 0
[junit4] 2> 1669058 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[9 (1580129677672972288)]} 0 0
[junit4] 2> 1669157 INFO (qtp1787034192-17998) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[9 (1580129677775732736)]} 0 0
[junit4] 2> 1669157 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[10 (1580129677776781312)]} 0 0
[junit4] 2> 1669158 INFO (qtp666924566-17962) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[10 (1580129677777829888)]} 0 0
[junit4] 2> 1669158 INFO (qtp1325294780-17950) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[12 (1580129677777829888)]} 0 0
[junit4] 2> 1669158 INFO (qtp1787034192-17999) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[12 (1580129677777829888)]} 0 0
[junit4] 2> 1669159 INFO (qtp1325294780-17942) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[13 (1580129677778878464)]} 0 0
[junit4] 2> 1669160 INFO (qtp666924566-17965) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[13 (1580129677778878464)]} 0 0
[junit4] 2> 1669160 INFO (qtp1325294780-17939) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[14 (1580129677779927040)]} 0 0
[junit4] 2> 1669161 INFO (qtp1932811662-17980) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[14 (1580129677779927040)]} 0 0
[junit4] 2> 1669161 INFO (qtp1325294780-17939) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[15 (1580129677780975616)]} 0 0
[junit4] 2> 1669161 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[15 (1580129677780975616)]} 0 0
[junit4] 2> 1669163 INFO (qtp1325294780-17943) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[16 (1580129677780975617)]} 0 0
[junit4] 2> 1669163 INFO (qtp666924566-17966) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[16 (1580129677783072768)]} 0 0
[junit4] 2> 1669164 INFO (qtp1325294780-17945) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[17 (1580129677784121344)]} 0 0
[junit4] 2> 1669164 INFO (qtp1932811662-17980) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[17 (1580129677784121344)]} 0 0
[junit4] 2> 1669166 INFO (qtp1325294780-17946) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[18 (1580129677785169920)]} 0 0
[junit4] 2> 1669166 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[18 (1580129677786218496)]} 0 0
[junit4] 2> 1669167 INFO (qtp1325294780-17948) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[19 (1580129677786218496)]} 0 0
[junit4] 2> 1669167 INFO (qtp666924566-17959) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[19 (1580129677787267072)]} 0 0
[junit4] 2> 1669168 INFO (qtp1325294780-17949) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[20 (1580129677788315648)]} 0 0
[junit4] 2> 1669169 INFO (qtp1932811662-17987) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[20 (1580129677788315648)]} 0 0
[junit4] 2> 1669169 INFO (qtp1325294780-17944) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[21 (1580129677789364224)]} 0 0
[junit4] 2> 1669170 INFO (qtp1787034192-18002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[21 (1580129677789364224)]} 0 0
[junit4] 2> 1669170 INFO (qtp1325294780-17950) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[22 (1580129677790412800)]} 0 0
[junit4] 2> 1669170 INFO (qtp666924566-17961) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[22 (1580129677790412800)]} 0 0
[junit4] 2> 1669171 INFO (qtp1325294780-17950) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[23 (1580129677791461376)]} 0 0
[junit4] 2> 1669171 INFO (qtp1932811662-17988) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[23 (1580129677791461376)]} 0 0
[junit4] 2> 1669172 INFO (qtp1325294780-17950) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[24 (1580129677792509952)]} 0 0
[junit4] 2> 1669172 INFO (qtp1787034192-18002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[24 (1580129677792509952)]} 0 0
[junit4] 2> 1669172 INFO (qtp1325294780-17943) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[25 (1580129677792509953)]} 0 0
[junit4] 2> 1669173 INFO (qtp666924566-17961) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={wt=javabin&version=2}{add=[25 (1580129677793558528)]} 0 0
[junit4] 2> 1669173 INFO (qtp1325294780-17945) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1580129677793558528,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1669173 INFO (qtp1325294780-17945) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@6362cc50 commitCommandVersion:1580129677793558528
[junit4] 2> 1669190 INFO (qtp1325294780-17945) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@32ca0d77[collection1] main]
[junit4] 2> 1669193 INFO (searcherExecutor-8517-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@32ca0d77[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.1):c24)))}
[junit4] 2> 1669193 INFO (qtp1325294780-17945) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1669193 INFO (qtp1325294780-17945) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 19
[junit4] 2> 1669194 INFO (qtp666924566-17964) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1580129677815578624,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1669194 INFO (qtp666924566-17964) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5259c8c1 commitCommandVersion:1580129677815578624
[junit4] 2> 1669203 INFO (qtp666924566-17964) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1acd2698[collection1] main]
[junit4] 2> 1669205 INFO (qtp666924566-17964) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1669207 INFO (searcherExecutor-8528-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1acd2698[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.1):c9)))}
[junit4] 2> 1669207 INFO (qtp666924566-17964) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 13
[junit4] 2> 1669207 INFO (qtp1932811662-17989) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1580129677829210112,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1669207 INFO (qtp1932811662-17989) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@691ff1a1 commitCommandVersion:1580129677829210112
[junit4] 2> 1669215 INFO (qtp1932811662-17989) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@66a9090a[collection1] main]
[junit4] 2> 1669218 INFO (searcherExecutor-8539-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@66a9090a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.1):c7)))}
[junit4] 2> 1669220 INFO (qtp1932811662-17989) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1669221 INFO (qtp1932811662-17989) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 13
[junit4] 2> 1669221 INFO (qtp1787034192-17996) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1580129677843890176,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1669221 INFO (qtp1787034192-17996) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1408dc4 commitCommandVersion:1580129677843890176
[junit4] 2> 1669231 INFO (qtp1787034192-17996) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2dd00d00[collection1] main]
[junit4] 2> 1669234 INFO (searcherExecutor-8550-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2dd00d00[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.1):c8)))}
[junit4] 2> 1669234 INFO (qtp1787034192-17996) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1669234 INFO (qtp1787034192-17996) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/y_/cp path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 13
[junit4] 2> 1669241 INFO (qtp1325294780-17946) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={q=match_none&distrib=false&qt=mltrh&mlt=true&mlt.fl=lowerfilt&wt=javabin&version=2&shards.qt=mltrh} hits=0 status=0 QTime=5
[junit4] 2> 1669244 INFO (qtp666924566-17962) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=http://127.0.0.1:53070/y_/cp/collection1|[ff01::213]:33332/y_/cp|[ff01::114]:33332/y_/cp|[ff01::083]:33332/y_/cp&rows=10&version=2&shards.qt=mltrh&q=match_none&mlt=true&NOW=1506929090371&mlt.fl=lowerfilt&isShard=true&wt=javabin} hits=0 status=0 QTime=0
[junit4] 2> 1669250 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=[ff01::083]:33332/y_/cp|http://127.0.0.1:53078/y_/cp/collection1|[ff01::114]:33332/y_/cp&rows=10&version=2&shards.qt=mltrh&q=match_none&mlt=true&NOW=1506929090371&mlt.fl=lowerfilt&isShard=true&wt=javabin} hits=0 status=0 QTime=0
[junit4] 2> 1669251 INFO (qtp1787034192-17998) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=[ff01::083]:33332/y_/cp|http://127.0.0.1:53081/y_/cp/collection1&rows=10&version=2&shards.qt=mltrh&q=match_none&mlt=true&NOW=1506929090371&mlt.fl=lowerfilt&isShard=true&wt=javabin} hits=0 status=0 QTime=0
[junit4] 2> 1669252 INFO (qtp1787034192-17996) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={q=match_none&shards=http://127.0.0.1:53070/y_/cp/collection1|[ff01::213]:33332/y_/cp|[ff01::114]:33332/y_/cp|[ff01::083]:33332/y_/cp,[ff01::083]:33332/y_/cp|http://127.0.0.1:53078/y_/cp/collection1|[ff01::114]:33332/y_/cp,[ff01::083]:33332/y_/cp|http://127.0.0.1:53081/y_/cp/collection1&qt=mltrh&mlt=true&mlt.fl=lowerfilt&wt=javabin&version=2&shards.qt=mltrh} hits=0 status=0 QTime=10
[junit4] 2> 1669252 INFO (qtp1325294780-17946) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={q=lowerfilt:sonata&distrib=false&qt=mltrh&mlt=true&mlt.fl=lowerfilt&wt=javabin&version=2&shards.qt=mltrh} hits=1 status=0 QTime=0
[junit4] 2> 1669254 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=http://127.0.0.1:53078/y_/cp/collection1|[ff01::114]:33332/y_/cp&rows=10&version=2&shards.qt=mltrh&q=lowerfilt:sonata&mlt=true&NOW=1506929090383&mlt.fl=lowerfilt&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 1669254 INFO (qtp666924566-17962) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=[ff01::114]:33332/y_/cp|http://127.0.0.1:53070/y_/cp/collection1|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp&rows=10&version=2&shards.qt=mltrh&q=lowerfilt:sonata&mlt=true&NOW=1506929090383&mlt.fl=lowerfilt&isShard=true&wt=javabin} hits=0 status=0 QTime=0
[junit4] 2> 1669255 INFO (qtp1787034192-17999) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=[ff01::083]:33332/y_/cp|http://127.0.0.1:53081/y_/cp/collection1|[ff01::213]:33332/y_/cp|[ff01::114]:33332/y_/cp&rows=10&version=2&shards.qt=mltrh&q=lowerfilt:sonata&mlt=true&NOW=1506929090383&mlt.fl=lowerfilt&isShard=true&wt=javabin} hits=0 status=0 QTime=0
[junit4] 2> 1669255 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&shards.purpose=64&shard.url=http://127.0.0.1:53078/y_/cp/collection1|[ff01::114]:33332/y_/cp&version=2&shards.qt=mltrh&q=lowerfilt:sonata&mlt=false&NOW=1506929090383&mlt.fl=lowerfilt&ids=8&isShard=true&wt=javabin} status=0 QTime=0
[junit4] 2> 1669256 INFO (qtp1787034192-17998) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={q=lowerfilt:sonata&shards=[ff01::114]:33332/y_/cp|http://127.0.0.1:53070/y_/cp/collection1|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp,http://127.0.0.1:53078/y_/cp/collection1|[ff01::114]:33332/y_/cp,[ff01::083]:33332/y_/cp|http://127.0.0.1:53081/y_/cp/collection1|[ff01::213]:33332/y_/cp|[ff01::114]:33332/y_/cp&qt=mltrh&mlt=true&mlt.fl=lowerfilt&wt=javabin&version=2&shards.qt=mltrh} hits=1 status=0 QTime=2
[junit4] 2> 1669257 INFO (qtp1325294780-17946) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={distrib=false&qt=mltrh&fl=id&sort=id_i1+desc&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&q=lowerfilt:moon&mlt=true&mlt.fl=lowerfilt&wt=javabin&mlt.mindf=1} hits=2 status=0 QTime=0
[junit4] 2> 1669258 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&shards.purpose=68&start=0&fsv=true&sort=id_i1+desc&shard.url=http://127.0.0.1:53078/y_/cp/collection1&rows=10&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&q=lowerfilt:moon&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=1 status=0 QTime=0
[junit4] 2> 1669258 INFO (qtp666924566-17962) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&shards.purpose=68&start=0&fsv=true&sort=id_i1+desc&shard.url=http://127.0.0.1:53070/y_/cp/collection1&rows=10&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&q=lowerfilt:moon&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=1 status=0 QTime=0
[junit4] 2> 1669262 INFO (qtp1787034192-18003) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&shards.purpose=68&start=0&fsv=true&sort=id_i1+desc&shard.url=http://127.0.0.1:53081/y_/cp/collection1&rows=10&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&q=lowerfilt:moon&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=0 status=0 QTime=1
[junit4] 2> 1669264 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53078/y_/cp/collection1&rows=20&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&mlt.dist.id=17&q=%2B(lowerfilt:the+lowerfilt:moon.+lowerfilt:and+lowerfilt:foxes+lowerfilt:moon)+-id:17&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=3 status=0 QTime=0
[junit4] 2> 1669264 INFO (qtp666924566-17962) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53070/y_/cp/collection1&rows=20&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&mlt.dist.id=17&q=%2B(lowerfilt:the+lowerfilt:moon.+lowerfilt:and+lowerfilt:foxes+lowerfilt:moon)+-id:17&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=5 status=0 QTime=1
[junit4] 2> 1669267 INFO (qtp1787034192-18003) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53081/y_/cp/collection1&rows=20&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&mlt.dist.id=17&q=%2B(lowerfilt:the+lowerfilt:moon.+lowerfilt:and+lowerfilt:foxes+lowerfilt:moon)+-id:17&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=5 status=0 QTime=1
[junit4] 2> 1669270 INFO (qtp666924566-17962) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53070/y_/cp/collection1&rows=20&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&mlt.dist.id=7&q=%2B(lowerfilt:the+lowerfilt:and+lowerfilt:moon)+-id:7&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669271 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53078/y_/cp/collection1&rows=20&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&mlt.dist.id=7&q=%2B(lowerfilt:the+lowerfilt:and+lowerfilt:moon)+-id:7&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669272 INFO (qtp1787034192-18003) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53081/y_/cp/collection1&rows=20&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&mlt.dist.id=7&q=%2B(lowerfilt:the+lowerfilt:and+lowerfilt:moon)+-id:7&mlt=true&NOW=1506929090388&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=5 status=0 QTime=0
[junit4] 2> 1669273 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.h.c.MoreLikeThisComponent MLT: results added for key: 17 documents: {numFound=3,start=0,maxScore=0.65740556,docs=[SolrDocument{id=14, score=0.65740556}, SolrDocument{id=20, score=0.65740556}, SolrDocument{id=23, score=0.65740556}]}
[junit4] 2> 1669273 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.h.c.MoreLikeThisComponent MLT: results added for key: 17 documents: {numFound=5,start=0,maxScore=3.4950314,docs=[SolrDocument{id=7, score=3.4950314}, SolrDocument{id=13, score=0.67566174}, SolrDocument{id=16, score=0.67566174}, SolrDocument{id=19, score=0.67566174}, SolrDocument{id=22, score=0.67566174}]}
[junit4] 2> 1669274 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.h.c.MoreLikeThisComponent MLT: results added for key: 17 documents: {numFound=5,start=0,maxScore=1.2457749,docs=[SolrDocument{id=9, score=1.2457749}, SolrDocument{id=15, score=0.62854314}, SolrDocument{id=18, score=0.62854314}, SolrDocument{id=21, score=0.62854314}, SolrDocument{id=24, score=0.62854314}]}
[junit4] 2> 1669274 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.h.c.MoreLikeThisComponent MLT: results added for key: 7 documents: {numFound=4,start=0,maxScore=0.67566174,docs=[SolrDocument{id=13, score=0.67566174}, SolrDocument{id=16, score=0.67566174}, SolrDocument{id=19, score=0.67566174}, SolrDocument{id=22, score=0.67566174}]}
[junit4] 2> 1669274 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.h.c.MoreLikeThisComponent MLT: results added for key: 7 documents: {numFound=4,start=0,maxScore=2.0108068,docs=[SolrDocument{id=17, score=2.0108068}, SolrDocument{id=14, score=0.65740556}, SolrDocument{id=20, score=0.65740556}, SolrDocument{id=23, score=0.65740556}]}
[junit4] 2> 1669274 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.h.c.MoreLikeThisComponent MLT: results added for key: 7 documents: {numFound=5,start=0,maxScore=1.2457749,docs=[SolrDocument{id=9, score=1.2457749}, SolrDocument{id=15, score=0.62854314}, SolrDocument{id=18, score=0.62854314}, SolrDocument{id=21, score=0.62854314}, SolrDocument{id=24, score=0.62854314}]}
[junit4] 2> 1669274 INFO (qtp1787034192-18000) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={qt=mltrh&fl=id&sort=id_i1+desc&mlt.count=20&version=2&mlt.mintf=2&shards.qt=mltrh&q=lowerfilt:moon&shards=http://127.0.0.1:53070/y_/cp/collection1,http://127.0.0.1:53078/y_/cp/collection1,http://127.0.0.1:53081/y_/cp/collection1&mlt=true&mlt.fl=lowerfilt&wt=javabin&mlt.mindf=1} hits=2 status=0 QTime=15
[junit4] 2> 1669277 INFO (qtp1325294780-17946) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={distrib=false&qt=mltrh&fl=id&sort=id_i1+desc&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&q=lowerfilt:fox&mlt=true&mlt.fl=lowerfilt&wt=javabin&mlt.mindf=1} hits=13 status=0 QTime=2
[junit4] 2> 1669290 INFO (qtp666924566-17964) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&shards.purpose=68&start=0&fsv=true&sort=id_i1+desc&shard.url=http://127.0.0.1:53070/y_/cp/collection1|[ff01::114]:33332/y_/cp|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp&rows=10&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&q=lowerfilt:fox&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669293 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&shards.purpose=68&start=0&fsv=true&sort=id_i1+desc&shard.url=http://127.0.0.1:53078/y_/cp/collection1|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp|[ff01::114]:33332/y_/cp&rows=10&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&q=lowerfilt:fox&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669296 INFO (qtp1787034192-18003) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=id&shards.purpose=68&start=0&fsv=true&sort=id_i1+desc&shard.url=http://127.0.0.1:53081/y_/cp/collection1|[ff01::213]:33332/y_/cp&rows=10&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&q=lowerfilt:fox&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=5 status=0 QTime=0
[junit4] 2> 1669301 INFO (qtp666924566-17964) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53070/y_/cp/collection1|[ff01::114]:33332/y_/cp|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=22&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:dogs.+lowerfilt:jumped+lowerfilt:lazy+lowerfilt:brown+lowerfilt:over+lowerfilt:quote+lowerfilt:the)+-id:22&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=2
[junit4] 2> 1669302 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53078/y_/cp/collection1|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp|[ff01::114]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=22&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:dogs.+lowerfilt:jumped+lowerfilt:lazy+lowerfilt:brown+lowerfilt:over+lowerfilt:quote+lowerfilt:the)+-id:22&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=2
[junit4] 2> 1669303 INFO (qtp1787034192-18003) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53081/y_/cp/collection1|[ff01::213]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=22&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:dogs.+lowerfilt:jumped+lowerfilt:lazy+lowerfilt:brown+lowerfilt:over+lowerfilt:quote+lowerfilt:the)+-id:22&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=5 status=0 QTime=1
[junit4] 2> 1669331 INFO (qtp666924566-17964) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53070/y_/cp/collection1|[ff01::114]:33332/y_/cp|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=19&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:dogs.+lowerfilt:brown+lowerfilt:jumped+lowerfilt:lazy+lowerfilt:over+lowerfilt:hose+lowerfilt:the)+-id:19&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=25
[junit4] 2> 1669331 INFO (qtp1787034192-18003) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53081/y_/cp/collection1|[ff01::213]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=9&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:brown+lowerfilt:lazy+lowerfilt:jumped+lowerfilt:over+lowerfilt:dogs.+lowerfilt:and+lowerfilt:quick+lowerfilt:big+lowerfilt:large+lowerfilt:the)+-id:9&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669333 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53078/y_/cp/collection1|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp|[ff01::114]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=9&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:brown+lowerfilt:lazy+lowerfilt:jumped+lowerfilt:over+lowerfilt:dogs.+lowerfilt:and+lowerfilt:quick+lowerfilt:big+lowerfilt:large+lowerfilt:the)+-id:9&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669334 INFO (qtp1787034192-18003) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53081/y_/cp/collection1|[ff01::213]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=15&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:dogs.+lowerfilt:jumped+lowerfilt:brown+lowerfilt:lazy+lowerfilt:over+lowerfilt:fat+lowerfilt:the)+-id:15&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669334 INFO (qtp1932811662-17976) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53078/y_/cp/collection1|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp|[ff01::114]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=15&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:dogs.+lowerfilt:jumped+lowerfilt:brown+lowerfilt:lazy+lowerfilt:over+lowerfilt:fat+lowerfilt:the)+-id:15&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669335 INFO (qtp666924566-17964) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53070/y_/cp/collection1|[ff01::114]:33332/y_/cp|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=9&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:brown+lowerfilt:lazy+lowerfilt:jumped+lowerfilt:over+lowerfilt:dogs.+lowerfilt:and+lowerfilt:quick+lowerfilt:big+lowerfilt:large+lowerfilt:the)+-id:9&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=5 status=0 QTime=0
[junit4] 2> 1669336 INFO (qtp1787034192-18003) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53081/y_/cp/collection1|[ff01::213]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=18&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:dogs.+lowerfilt:jumped+lowerfilt:lazy+lowerfilt:brown+lowerfilt:over+lowerfilt:quote+lowerfilt:the)+-id:18&mlt=true&NOW=1506929090408&mlt.fl=lowerfilt&isShard=true&wt=javabin&mlt.mindf=1} hits=4 status=0 QTime=0
[junit4] 2> 1669337 INFO (qtp666924566-17964) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/y_/cp path=/select params={df=text&distrib=false&qt=mltrh&fl=score,id&shards.purpose=4097&start=0&sort=score+desc&shard.url=http://127.0.0.1:53070/y_/cp/collection1|[ff01::114]:33332/y_/cp|[ff01::083]:33332/y_/cp|[ff01::213]:33332/y_/cp&rows=20&mlt.count=20&version=2&mlt.mintf=1&shards.qt=mltrh&mlt.dist.id=15&q=%2B(lowerfilt:red+lowerfilt:fox+lowerfilt:dogs.+lowerfilt:jumped+lowerfilt:brown+lowerfilt:lazy+lowerfilt:over+lowerfilt:fat+lowerfilt:the)+-id:15&mlt=true&NOW=1506929090408&mlt.fl=lo
[...truncated too long message...]
rity.json
[junit4] 2> 3 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 40 /solr/collections/tlog_replica_test_recovery/state.json
[junit4] 2> 32 /solr/collections/tlog_replica_test_create_delete/state.json
[junit4] 2> 29 /solr/collections/tlog_replica_test_remove_leader/state.json
[junit4] 2> 28 /solr/collections/tlog_replica_test_kill_leader/state.json
[junit4] 2> 27 /solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/state.json
[junit4] 2> 27 /solr/collections/tlog_replica_test_basic_leader_election/state.json
[junit4] 2> 27 /solr/collections/tlog_replica_test_add_remove_tlog_replica/state.json
[junit4] 2> 26 /solr/collections/tlog_replica_test_kill_tlog_replica/state.json
[junit4] 2> 17 /solr/collections/tlog_replica_test_real_time_get/state.json
[junit4] 2> 13 /solr/collections/tlog_replica_test_only_leader_indexes/state.json
[junit4] 2> 13 /solr/collections/tlog_replica_test_delete_by_id/state.json
[junit4] 2> 10 /solr/clusterstate.json
[junit4] 2> 10 /solr/clusterprops.json
[junit4] 2> 6 /solr/collections/tlog_replica_test_add_docs/state.json
[junit4] 2> 4 /solr/collections/tlog_replica_test_recovery/leader_elect/shard1/election/98758149433524238-core_node1-n_0000000000
[junit4] 2> 4 /solr/overseer_elect/election/98758149433524238-127.0.0.1:57970_solr-n_0000000003
[junit4] 2> 2 /solr/collections/tlog_replica_test_real_time_get/leader_elect/shard1/election/98758149433524229-core_node1-n_0000000001
[junit4] 2> 2 /solr/collections/tlog_replica_test_kill_tlog_replica/leader_elect/shard1/election/98758149433524238-core_node2-n_0000000000
[junit4] 2> 2 /solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/98758149433524235-core_node4-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 10 /solr/collections
[junit4] 2> 5 /solr/overseer/queue
[junit4] 2> 5 /solr/overseer/collection-queue-work
[junit4] 2> 3 /solr/live_nodes
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-7.0-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestTlogReplica_625C2FF31CC2D857-001
[junit4] 2> Oct 02, 2017 7:37:58 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 3 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=true): {}, locale=en, timezone=AST
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=100355880,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [LeaderElectionTest, TestWriterPerf, TestSolrFieldCacheBean, ClusterStateUpdateTest, JavabinLoaderTest, TestRebalanceLeaders, TestLegacyFieldReuse, SolrTestCaseJ4Test, ZkCLITest, TestOverriddenPrefixQueryForCustomFieldType, HardAutoCommitTest, SolrShardReporterTest, TestLeaderElectionWithEmptyReplica, TestHighFrequencyDictionaryFactory, TestRandomDVFaceting, TestCryptoKeys, DistanceUnitsTest, TestStressInPlaceUpdates, TestObjectReleaseTracker, TestCloudNestedDocsSort, ResourceLoaderTest, BlockJoinFacetDistribTest, TestDocTermOrds, PreAnalyzedUpdateProcessorTest, SimpleFacetsTest, TestSortByMinMaxFunction, OverriddenZkACLAndCredentialsProvidersTest, TestLeaderInitiatedRecoveryThread, TestStressUserVersions, SimpleMLTQParserTest, TestRequestForwarding, SolrSlf4jReporterTest, TestFunctionQuery, XsltUpdateRequestHandlerTest, TestExportWriter, TestPHPSerializedResponseWriter, DistanceFunctionTest, NumericFieldsTest, UtilsToolTest, MoveReplicaHDFSTest, TestLRUStatsCache, CustomCollectionTest, HdfsCollectionsAPIDistributedZkTest, TestMultiWordSynonyms, HdfsRecoverLeaseTest, SoftAutoCommitTest, TestLegacyTerms, TestSolrConfigHandlerConcurrent, DistributedSpellCheckComponentTest, TemplateUpdateProcessorTest, TestManagedSchemaThreadSafety, ConnectionManagerTest, TestFieldCollectionResource, ReplicaListTransformerTest, UniqFieldsUpdateProcessorFactoryTest, TestRandomFlRTGCloud, SolrMetricReporterTest, TestStressVersions, TestRestManager, TestReplicationHandlerBackup, TestSchemaSimilarityResource, CloneFieldUpdateProcessorFactoryTest, TestPushWriter, TestDistributedSearch, PathHierarchyTokenizerFactoryTest, TestSchemaManager, TestNumericRangeQuery32, TestCoreContainer, NodeMutatorTest, TestIBSimilarityFactory, TestUpdate, TestDFISimilarityFactory, BaseCdcrDistributedZkTest, RequestHandlersTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestFieldCacheSortRandom, TestUninvertingReader, TestComplexPhraseQParserPlugin, HdfsRestartWhileUpdatingTest, TestClassNameShortening, MoveReplicaTest, TestExactSharedStatsCache, DistributedFacetPivotWhiteBoxTest, TestNumericTerms32, TestRandomCollapseQParserPlugin, TestRestoreCore, TestUtils, CheckHdfsIndexTest, CSVRequestHandlerTest, ClusterStateTest, TestJsonRequest, SolrInfoBeanTest, TestRuleBasedAuthorizationPlugin, TestAuthenticationFramework, JvmMetricsTest, CdcrRequestHandlerTest, TestSort, CloudExitableDirectoryReaderTest, SliceStateTest, DeleteReplicaTest, ReplicationFactorTest, HttpSolrCallGetCoreTest, DistributedExpandComponentTest, TestMinMaxOnMultiValuedField, TestManagedStopFilterFactory, TriLevelCompositeIdRoutingTest, TestSurroundQueryParser, TestBinaryField, FacetPivotSmallTest, DirectUpdateHandlerOptimizeTest, AnalysisAfterCoreReloadTest, TestCodecSupport, ReturnFieldsTest, SolrCoreTest, BooleanFieldTest, RegexBoostProcessorTest, FieldAnalysisRequestHandlerTest, TestChildDocTransformer, TestUseDocValuesAsStored, RulesTest, HighlighterTest, SpatialFilterTest, HdfsChaosMonkeyNothingIsSafeTest, DistributedQueueTest, QueryParsingTest, HdfsBasicDistributedZk2Test, AutoScalingHandlerTest, ZkStateReaderTest, ChaosMonkeyNothingIsSafeTest, TestSubQueryTransformerCrossCore, TestSolrCloudWithDelegationTokens, TestLFUCache, CursorPagingTest, TestReloadDeadlock, TestSimpleTextCodec, SolrCoreMetricManagerTest, MetricsHandlerTest, TestFieldCacheReopen, TestEmbeddedSolrServerConstructors, SecurityConfHandlerTest, TestDefaultStatsCache, TestXmlQParser, JSONWriterTest, WordBreakSolrSpellCheckerTest, TestSolr4Spatial2, SaslZkACLProviderTest, TestTolerantUpdateProcessorRandomCloud, TestExclusionRuleCollectionAccess, TestManagedSchema, SolrCloudExampleTest, MetricUtilsTest, TestCoreAdminApis, DistributedFacetPivotLargeTest, SyncSliceTest, DocValuesNotIndexedTest, TestJettySolrRunner, TestFoldingMultitermQuery, TestFieldTypeCollectionResource, DeleteLastCustomShardedReplicaTest, TestCursorMarkWithoutUniqueKey, DefaultValueUpdateProcessorTest, TestExtendedDismaxParser, ShardRoutingTest, URLClassifyProcessorTest, PeerSyncTest, TestShortCircuitedRequests, CoreAdminCreateDiscoverTest, TestManagedSynonymGraphFilterFactory, TestPhraseSuggestions, SearchHandlerTest, SortByFunctionTest, TestReversedWildcardFilterFactory, TestFileDictionaryLookup, AnalysisErrorHandlingTest, HLLUtilTest, DeleteStatusTest, TestReplicationHandler, SimpleCollectionCreateDeleteTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, BasicZkTest, RecoveryZkTest, TestRandomFaceting, TestZkChroot, TestFaceting, TestHashPartitioner, TermVectorComponentDistributedTest, ZkControllerTest, TestRealTimeGet, TestStressReorder, TestJoin, TestRangeQuery, StatsComponentTest, SpellCheckComponentTest, TestGroupingSearch, SolrCmdDistributorTest, QueryElevationComponentTest, BadIndexSchemaTest, TestLazyCores, DistributedQueryElevationComponentTest, SpellCheckCollatorTest, CoreAdminHandlerTest, DocValuesTest, TestRemoteStreaming, DebugComponentTest, IndexBasedSpellCheckerTest, DisMaxRequestHandlerTest, DocumentAnalysisRequestHandlerTest, TestOmitPositions, XmlUpdateRequestHandlerTest, DocumentBuilderTest, TestIndexingPerformance, RequiredFieldsTest, FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, SolrPluginUtilsTest, TestJmxIntegration, TestCSVResponseWriter, TestAnalyzedSuggestions, BinaryUpdateRequestHandlerTest, HighlighterConfigTest, SOLR749Test, TestQuerySenderListener, UpdateParamsTest, AlternateDirectoryTest, TestSolrIndexConfig, TestQuerySenderNoQuery, ResponseLogComponentTest, SolrIndexConfigTest, TestStressRecovery, TestSolrDeletionPolicy2, MultiTermTest, SampleTest, MinimalSchemaTest, TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, DirectSolrConnectionTest, TestCharFilters, TestXIncludeConfig, TestSweetSpotSimilarityFactory, TestLMDirichletSimilarityFactory, TimeZoneUtilsTest, TestFastOutputStream, OpenExchangeRatesOrgProviderTest, TestFastLRUCache, PreAnalyzedFieldTest, DateFieldTest, DOMUtilTest, TestLRUCache, CircularListTest, DistributedMLTComponentTest, TestHighlightDedupGrouping, TestTolerantSearch, ConnectionReuseTest, AliasIntegrationTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, CollectionsAPISolrJTest, ForceLeaderTest, LeaderFailureAfterFreshStartTest, LeaderInitiatedRecoveryOnCommitTest, OverseerRolesTest, OverseerTaskQueueTest, RemoteQueryErrorTest, ReplaceNodeTest, SSLMigrationTest, SharedFSAutoReplicaFailoverTest, SharedFSAutoReplicaFailoverUtilsTest, TestCloudInspectUtil, TestCloudPivotFacet, TestClusterProperties, TestCollectionAPI, TestConfigSetsAPIExclusivity, TestConfigSetsAPIZkFailure, TestDeleteCollectionOnDownNodes, TestDistribDocBasedVersion, TestDownShardTolerantSearch, TestLeaderElectionZkExpiry, TestOnReconnectListenerSupport, TestPullReplica, TestReplicaProperties, TestSSLRandomization, TestTlogReplica]
[junit4] Completed [586/730 (2!)] on J0 in 108.88s, 13 tests, 1 failure <<< FAILURES!
[...truncated 44074 lines...]