lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-7.0-Windows (64bit/jdk1.8.0_144) - Build # 180 - Still Unstable!
Date Mon, 02 Oct 2017 08:05:16 GMT
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...]

Mime
View raw message