Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/292/
Java: 64bit/jdk-9.0.1 -XX:-UseCompressedOops -XX:+UseSerialGC

3 tests failed.
FAILED:  
org.apache.lucene.replicator.IndexAndTaxonomyReplicationClientTest.testRecreateTaxonomy

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_48F67ADE228BD32E-001\replicationClientTest-003\2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_48F67ADE228BD32E-001\replicationClientTest-003\2
 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_48F67ADE228BD32E-001\replicationClientTest-003\2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_48F67ADE228BD32E-001\replicationClientTest-003\2

        at 
__randomizedtesting.SeedInfo.seed([48F67ADE228BD32E:740592BF494A052F]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
        at 
org.apache.lucene.replicator.PerSessionDirectoryFactory.cleanupSession(PerSessionDirectoryFactory.java:58)
        at 
org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:259)
        at 
org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:401)
        at 
org.apache.lucene.replicator.IndexAndTaxonomyReplicationClientTest.testRecreateTaxonomy(IndexAndTaxonomyReplicationClientTest.java:287)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
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 
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.base/java.lang.Thread.run(Thread.java:844)


FAILED:  
junit.framework.TestSuite.org.apache.solr.search.stats.TestExactSharedStatsCache

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard2\collection1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard2\collection1
    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard2
    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-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.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard2\collection1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard2\collection1
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard2
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001

        at __randomizedtesting.SeedInfo.seed([E382ADC9B96A4601]: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.base/java.lang.Thread.run(Thread.java:844)


FAILED:  
junit.framework.TestSuite.org.apache.solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data\version-2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data\version-2
    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data
    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1
    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper
    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-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.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data\version-2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data\version-2
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper
   
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001

        at __randomizedtesting.SeedInfo.seed([BCD922A828D4D5B8]: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.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 8720 lines...]
   [junit4] Suite: 
org.apache.lucene.replicator.IndexAndTaxonomyReplicationClientTest
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=IndexAndTaxonomyReplicationClientTest 
-Dtests.method=testRecreateTaxonomy -Dtests.seed=48F67ADE228BD32E 
-Dtests.slow=true -Dtests.locale=fr-MQ -Dtests.timezone=Asia/Sakhalin 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.34s J0 | 
IndexAndTaxonomyReplicationClientTest.testRecreateTaxonomy <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the 
following files (in the order of attempts):
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_48F67ADE228BD32E-001\replicationClientTest-003\2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_48F67ADE228BD32E-001\replicationClientTest-003\2
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([48F67ADE228BD32E:740592BF494A052F]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at 
org.apache.lucene.replicator.PerSessionDirectoryFactory.cleanupSession(PerSessionDirectoryFactory.java:58)
   [junit4]    >        at 
org.apache.lucene.replicator.ReplicationClient.doUpdate(ReplicationClient.java:259)
   [junit4]    >        at 
org.apache.lucene.replicator.ReplicationClient.updateNow(ReplicationClient.java:401)
   [junit4]    >        at 
org.apache.lucene.replicator.IndexAndTaxonomyReplicationClientTest.testRecreateTaxonomy(IndexAndTaxonomyReplicationClientTest.java:287)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:564)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\replicator\test\J0\temp\lucene.replicator.IndexAndTaxonomyReplicationClientTest_48F67ADE228BD32E-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{$full_path$=PostingsFormat(name=LuceneVarGapFixedInterval), $facets=FSTOrd50, 
$payloads$=BlockTreeOrds(blocksize=128)}, 
docValues:{$facets=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1314, 
maxMBSortInHeap=5.475030194971181, sim=RandomSimilarity(queryNorm=true): {}, 
locale=fr-MQ, timezone=Asia/Sakhalin
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=3,threads=1,free=84073016,total=97320960
   [junit4]   2> NOTE: All tests run in this JVM: [IndexReplicationClientTest, 
IndexAndTaxonomyReplicationClientTest]
   [junit4] Completed [6/9 (1!)] on J0 in 6.86s, 5 tests, 1 error <<< FAILURES!

[...truncated 2984 lines...]
   [junit4] Suite: org.apache.solr.search.stats.TestExactSharedStatsCache
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\init-core-data-001
   [junit4]   2> 159972 WARN  
(SUITE-TestExactSharedStatsCache-seed#[E382ADC9B96A4601]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 159972 INFO  
(SUITE-TestExactSharedStatsCache-seed#[E382ADC9B96A4601]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 159974 INFO  
(SUITE-TestExactSharedStatsCache-seed#[E382ADC9B96A4601]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 159974 INFO  
(SUITE-TestExactSharedStatsCache-seed#[E382ADC9B96A4601]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 159975 INFO  
(SUITE-TestExactSharedStatsCache-seed#[E382ADC9B96A4601]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 160727 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\cores\collection1
   [junit4]   2> 160730 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 160731 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1da48890{/,null,AVAILABLE}
   [junit4]   2> 160734 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3e86d76a{HTTP/1.1,[http/1.1]}{127.0.0.1:63153}
   [junit4]   2> 160739 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.Server Started @170849ms
   [junit4]   2> 160739 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=63153, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\cores}
   [junit4]   2> 160739 ERROR 
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 160739 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 160739 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 160739 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 160739 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-07T01:58:11.929004400Z
   [junit4]   2> 160739 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\solr.xml
   [junit4]   2> 160749 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 160749 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 160751 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 160820 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 160847 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 160847 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 160852 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\cores
   [junit4]   2> 160852 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 160855 INFO  (coreLoadExecutor-954-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 160859 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 160926 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 160976 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 161147 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 161182 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 161182 INFO  (coreLoadExecutor-954-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@2caaf097
   [junit4]   2> 161182 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 161182 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 161186 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=78.890625, 
floorSegmentMB=1.6220703125, forceMergeDeletesPctAllowed=14.024268754251318, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5521166074255556
   [junit4]   2> 161337 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 161338 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 161340 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 161341 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 161342 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7622232160382336]
   [junit4]   2> 161342 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@62049aef[collection1] main]
   [junit4]   2> 161343 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 161374 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 161502 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 161502 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 161504 INFO  (coreLoadExecutor-954-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1583370619001503744
   [junit4]   2> 161507 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 161507 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 161507 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 161508 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 161509 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 161510 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 161511 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 161511 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 161513 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@62049aef[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 162690 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard0\cores\collection1
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@165f35a7{/,null,AVAILABLE}
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@22b94f02{HTTP/1.1,[http/1.1]}{127.0.0.1:63156}
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.Server Started @172803ms
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=63156, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard0\cores}
   [junit4]   2> 162692 ERROR 
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-07T01:58:13.882271600Z
   [junit4]   2> 162692 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 162703 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 162703 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 162713 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 162799 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 162818 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 162818 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 162822 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard0\cores
   [junit4]   2> 162822 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 162822 INFO  (coreLoadExecutor-965-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 162823 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 162912 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 162954 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 163128 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 163163 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 163164 INFO  (coreLoadExecutor-965-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@2caaf097
   [junit4]   2> 163165 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 163165 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 163231 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=78.890625, 
floorSegmentMB=1.6220703125, forceMergeDeletesPctAllowed=14.024268754251318, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5521166074255556
   [junit4]   2> 163376 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 163376 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 163379 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 163379 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 163383 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7622232160382336]
   [junit4]   2> 163383 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6e50a294[collection1] main]
   [junit4]   2> 163384 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 163402 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 163510 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 163510 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 163510 INFO  (coreLoadExecutor-965-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1583370621104947200
   [junit4]   2> 163512 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 163512 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 163512 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 163513 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 163517 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 163517 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 163518 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 163518 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 163520 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6e50a294[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 164012 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 164025 INFO  (qtp988208365-1523) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1583370621637623808)} 0 8
   [junit4]   2> 164033 INFO  (qtp1851872450-1543) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:* (-1583370621648109568)} 0 4
   [junit4]   2> 164037 INFO  (qtp988208365-1532) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[0 (1583370621655449600)]} 0 2
   [junit4]   2> 164040 INFO  (qtp1851872450-1554) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[0 (1583370621657546752)]} 0 1
   [junit4]   2> 164041 INFO  (qtp988208365-1530) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1583370621661741056,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 164041 INFO  (qtp988208365-1530) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@565fdfd9 
commitCommandVersion:1583370621661741056
   [junit4]   2> 164077 INFO  (qtp988208365-1530) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@71d8a83b[collection1] main]
   [junit4]   2> 164080 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@71d8a83b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c1)))}
   [junit4]   2> 164080 INFO  (qtp988208365-1530) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 164080 INFO  (qtp988208365-1530) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 39
   [junit4]   2> 164081 INFO  (qtp1851872450-1553) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1583370621703684096,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 164081 INFO  (qtp1851872450-1553) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6d2bbd7d 
commitCommandVersion:1583370621703684096
   [junit4]   2> 164092 INFO  (qtp1851872450-1553) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3e774d08[collection1] main]
   [junit4]   2> 164094 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3e774d08[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c1)))}
   [junit4]   2> 164094 INFO  (qtp1851872450-1553) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 164094 INFO  (qtp1851872450-1553) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 14
   [junit4]   2> 164100 INFO  (qtp988208365-1529) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_t:one&fl=*,score&wt=javabin&version=2&debugQuery=true} hits=1 
status=0 QTime=2
   [junit4]   2> 164115 INFO  (qtp1851872450-1552) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=*,score&shards.purpose=32768&shard.url=http://127.0.0.1:63156//collection1&rid=127.0.0.1-collection1-1510019895295-0&version=2&q=a_t:one&requestPurpose=GET_TERM_STATS&NOW=1510019895292&isShard=true&wt=javabin&debugQuery=false}
 status=0 QTime=6
   [junit4]   2> 164119 INFO  (qtp1851872450-1552) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&org.apache.solr.stats.termStats=a_t:on,1,1&shard.url=http://127.0.0.1:63156//collection1&rid=127.0.0.1-collection1-1510019895295-0&rows=10&version=2&org.apache.solr.stats.colStats=a_t,1,1,3,3&q=a_t:one&requestPurpose=GET_TOP_IDS,SET_TERM_STATS&NOW=1510019895292&isShard=true&org.apache.solr.stats.terms=a_t:on&wt=javabin&debugQuery=false}
 hits=1 status=0 QTime=1
   [junit4]   2> 164126 INFO  (qtp1851872450-1552) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&debug=timing&debug=track&fl=*,score&shards.purpose=320&shard.url=http://127.0.0.1:63156//collection1&rid=127.0.0.1-collection1-1510019895295-0&version=2&q=a_t:one&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1510019895292&ids=0&isShard=true&wt=javabin&debugQuery=true}
 status=0 QTime=0
   [junit4]   2> 164128 INFO  (qtp1851872450-1553) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_t:one&shards=http://127.0.0.1:63156//collection1&fl=*,score&wt=javabin&version=2&debugQuery=true}
 rid=127.0.0.1-collection1-1510019895295-0 hits=1 status=0 QTime=26
   [junit4]   1> ======================= Control Response 
=======================
   [junit4]   1> 
{responseHeader={status=0,QTime=2},response={numFound=1,start=0,maxScore=0.57735026,docs=[SolrDocument{id=0,
 range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], range_facet_i_dv=[0], 
a_t=[one two three], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, 
timestamp=Tue Nov 07 08:58:15 HOVT 2017, _version_=1583370621655449600, 
intDvoDefault=42, 
score=0.57735026}]},debug={rawquerystring=a_t:one,querystring=a_t:one,parsedquery=a_t:on,parsedquery_toString=a_t:on,explain={0=
   [junit4]   1> 0.57735026 = weight(a_t:on in 0) [MockConfigurableSimilarity], 
result of:
   [junit4]   1>   0.57735026 = fieldWeight in 0, product of:
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = termFreq=1.0
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1.0 = docFreq
   [junit4]   1>       1.0 = docCount
   [junit4]   1>     0.57735026 = fieldNorm(doc=0)
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=2.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=1.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}
   [junit4]   1> 
   [junit4]   1> 
   [junit4]   1> ======================= Shard Response =======================
   [junit4]   1> 
   [junit4]   1> 
{responseHeader={status=0,QTime=26},response={numFound=1,start=0,maxScore=0.57735026,docs=[SolrDocument{id=0,
 range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], range_facet_i_dv=[0], 
a_t=[one two three], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, 
timestamp=Tue Nov 07 08:58:15 HOVT 2017, _version_=1583370621657546752, 
intDvoDefault=42, 
score=0.57735026}]},debug={track={rid=127.0.0.1-collection1-1510019895295-0,PARSE_QUERY={http://127.0.0.1:63156//collection1={QTime=6,ElapsedTime=9,RequestPurpose=GET_TERM_STATS,Response={responseHeader={status=0,QTime=6},org.apache.solr.stats.terms=a_t:on,org.apache.solr.stats.termStats=a_t:on,1,1,org.apache.solr.stats.colStats=a_t,1,1,3,3,debug={timing={time=6.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=5.0,query={time=5.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}},EXECUTE_QUERY={http://127.0.0.1:63156//collection1={QTime=1,ElapsedTime=2,RequestPurpose=GET_TOP_IDS,SET_TERM_STATS,NumFound=1,Response={responseHeader={status=0,QTime=1},response={numFound=1,start=0,maxScore=0.57735026,docs=[SolrDocument{id=0,
 
score=0.57735026}]},sort_values={},debug={timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}},GET_FIELDS={http://127.0.0.1:63156//collection1={QTime=0,ElapsedTime=3,RequestPurpose=GET_FIELDS,GET_DEBUG,NumFound=1,Response={responseHeader={status=0,QTime=0},response={numFound=1,start=0,docs=[SolrDocument{id=0,
 range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], range_facet_i_dv=[0], 
a_t=[one two three], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, 
timestamp=Tue Nov 07 08:58:15 HOVT 2017, _version_=1583370621657546752, 
intDvoDefault=42, 
score=0.57735026}]},debug={rawquerystring=a_t:one,querystring=a_t:one,parsedquery=a_t:on,parsedquery_toString=a_t:on,explain={0=
   [junit4]   1> 0.57735026 = weight(a_t:on in 0) [MockConfigurableSimilarity], 
result of:
   [junit4]   1>   0.57735026 = fieldWeight in 0, product of:
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = termFreq=1.0
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1.0 = docFreq
   [junit4]   1>       1.0 = docCount
   [junit4]   1>     0.57735026 = fieldNorm(doc=0)
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}}},timing={time=6.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=5.0,query={time=5.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}},rawquerystring=a_t:one,querystring=a_t:one,parsedquery=a_t:on,parsedquery_toString=a_t:on,QParser=LuceneQParser,explain={0=
   [junit4]   1> 0.57735026 = weight(a_t:on in 0) [MockConfigurableSimilarity], 
result of:
   [junit4]   1>   0.57735026 = fieldWeight in 0, product of:
   [junit4]   1>     1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>       1.0 = termFreq=1.0
   [junit4]   1>     1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>       1.0 = docFreq
   [junit4]   1>       1.0 = docCount
   [junit4]   1>     0.57735026 = fieldNorm(doc=0)
   [junit4]   1> }}}
   [junit4]   2> 164134 INFO  (qtp988208365-1528) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1583370621756112896)]} 0 3
   [junit4]   2> 164139 INFO  (qtp1851872450-1552) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={wt=javabin&version=2}{add=[1 (1583370621760307200)]} 0 3
   [junit4]   2> 164141 INFO  (qtp988208365-1527) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1583370621766598656,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 164141 INFO  (qtp988208365-1527) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@565fdfd9 
commitCommandVersion:1583370621766598656
   [junit4]   2> 164144 INFO  (qtp988208365-1527) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@139b1802[collection1] main]
   [junit4]   2> 164146 INFO  
(searcherExecutor-955-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@139b1802[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c1)
 Uninverting(_1(7.2.0):c1)))}
   [junit4]   2> 164147 INFO  (qtp988208365-1527) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 164147 INFO  (qtp988208365-1527) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 7
   [junit4]   2> 164148 INFO  (qtp1851872450-1546) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1583370621773938688,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 164148 INFO  (qtp1851872450-1546) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6d2bbd7d 
commitCommandVersion:1583370621773938688
   [junit4]   2> 164155 INFO  (qtp1851872450-1546) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@192bdfbe[collection1] main]
   [junit4]   2> 164158 INFO  
(searcherExecutor-966-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@192bdfbe[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):c1)
 Uninverting(_1(7.2.0):c1)))}
   [junit4]   2> 164159 INFO  (qtp1851872450-1546) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 164159 INFO  (qtp1851872450-1546) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp= path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 11
   [junit4]   2> 164166 INFO  (qtp988208365-1526) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_t:one+a_t:four&fl=*,score&wt=javabin&version=2&debugQuery=true} 
hits=2 status=0 QTime=6
   [junit4]   2> 164173 INFO  (qtp1851872450-1543) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=*,score&shards.purpose=32768&shard.url=http://127.0.0.1:63156//collection1&rid=127.0.0.1-collection1-1510019895361-1&version=2&q=a_t:one+a_t:four&requestPurpose=GET_TERM_STATS&NOW=1510019895356&isShard=true&wt=javabin&debugQuery=false}
 status=0 QTime=0
   [junit4]   2> 164177 INFO  (qtp1851872450-1543) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&org.apache.solr.stats.termStats=a_t:on,2,2!a_t:four,1,1&shard.url=http://127.0.0.1:63156//collection1&rid=127.0.0.1-collection1-1510019895361-1&rows=10&version=2&org.apache.solr.stats.colStats=a_t,2,2,8,8&q=a_t:one+a_t:four&requestPurpose=GET_TOP_IDS,SET_TERM_STATS&NOW=1510019895356&isShard=true&org.apache.solr.stats.terms=a_t:on&org.apache.solr.stats.terms=a_t:four&wt=javabin&debugQuery=false}
 hits=2 status=0 QTime=1
   [junit4]   2> 164180 INFO  (qtp1851872450-1543) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={df=text&distrib=false&debug=timing&debug=track&fl=*,score&shards.purpose=320&shard.url=http://127.0.0.1:63156//collection1&rid=127.0.0.1-collection1-1510019895361-1&version=2&q=a_t:one+a_t:four&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1510019895356&ids=0,1&isShard=true&wt=javabin&debugQuery=true}
 status=0 QTime=1
   [junit4]   2> 164184 INFO  (qtp1851872450-1546) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp= path=/select 
params={q=a_t:one+a_t:four&shards=http://127.0.0.1:63156//collection1&fl=*,score&wt=javabin&version=2&debugQuery=true}
 rid=127.0.0.1-collection1-1510019895361-1 hits=2 status=0 QTime=14
   [junit4]   1> ======================= Control Response 
=======================
   [junit4]   1> 
{responseHeader={status=0,QTime=6},response={numFound=2,start=0,maxScore=1.0757567,docs=[SolrDocument{id=1,
 range_facet_l=[1], id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], 
a_t=[one two three four five], shard_i=[1], multiDefault=[muLti-Default], 
intDefault=42, timestamp=Tue Nov 07 08:58:15 HOVT 2017, 
_version_=1583370621756112896, intDvoDefault=42, score=1.0757567}, 
SolrDocument{id=0, range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], 
range_facet_i_dv=[0], a_t=[one two three], shard_i=[1], 
multiDefault=[muLti-Default], intDefault=42, timestamp=Tue Nov 07 08:58:15 HOVT 
2017, _version_=1583370621655449600, intDvoDefault=42, 
score=0.57735026}]},debug={rawquerystring=a_t:one a_t:four,querystring=a_t:one 
a_t:four,parsedquery=a_t:on a_t:four,parsedquery_toString=a_t:on 
a_t:four,explain={1=
   [junit4]   1> 1.0757567 = sum of:
   [junit4]   1>   0.4472136 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.4472136 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1> ,0=
   [junit4]   1> 0.57735026 = sum of:
   [junit4]   1>   0.57735026 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.57735026 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.57735026 = fieldNorm(doc=0)
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=6.0,prepare={time=1.0,query={time=1.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=5.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=3.0}}}}}
   [junit4]   1> 
   [junit4]   1> 
   [junit4]   1> ======================= Shard Response =======================
   [junit4]   1> 
   [junit4]   1> 
{responseHeader={status=0,QTime=14},response={numFound=2,start=0,maxScore=1.0757567,docs=[SolrDocument{id=1,
 range_facet_l=[1], id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], 
a_t=[one two three four five], shard_i=[1], multiDefault=[muLti-Default], 
intDefault=42, timestamp=Tue Nov 07 08:58:15 HOVT 2017, 
_version_=1583370621760307200, intDvoDefault=42, score=1.0757567}, 
SolrDocument{id=0, range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], 
range_facet_i_dv=[0], a_t=[one two three], shard_i=[1], 
multiDefault=[muLti-Default], intDefault=42, timestamp=Tue Nov 07 08:58:15 HOVT 
2017, _version_=1583370621657546752, intDvoDefault=42, 
score=0.57735026}]},debug={track={rid=127.0.0.1-collection1-1510019895361-1,PARSE_QUERY={http://127.0.0.1:63156//collection1={QTime=0,ElapsedTime=2,RequestPurpose=GET_TERM_STATS,Response={responseHeader={status=0,QTime=0},org.apache.solr.stats.terms=a_t:four,org.apache.solr.stats.terms=a_t:on,org.apache.solr.stats.termStats=a_t:on,2,2!a_t:four,1,1,org.apache.solr.stats.colStats=a_t,2,2,8,8,debug={timing={time=0.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}},EXECUTE_QUERY={http://127.0.0.1:63156//collection1={QTime=1,ElapsedTime=3,RequestPurpose=GET_TOP_IDS,SET_TERM_STATS,NumFound=2,Response={responseHeader={status=0,QTime=1},response={numFound=2,start=0,maxScore=1.0757567,docs=[SolrDocument{id=1,
 score=1.0757567}, SolrDocument{id=0, 
score=0.57735026}]},sort_values={},debug={timing={time=1.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}},GET_FIELDS={http://127.0.0.1:63156//collection1={QTime=1,ElapsedTime=3,RequestPurpose=GET_FIELDS,GET_DEBUG,NumFound=2,Response={responseHeader={status=0,QTime=1},response={numFound=2,start=0,docs=[SolrDocument{id=0,
 range_facet_l=[0], id_i1=0, range_facet_l_dv=[0], range_facet_i_dv=[0], 
a_t=[one two three], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, 
timestamp=Tue Nov 07 08:58:15 HOVT 2017, _version_=1583370621657546752, 
intDvoDefault=42, score=0.57735026}, SolrDocument{id=1, range_facet_l=[1], 
id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], a_t=[one two three four 
five], shard_i=[1], multiDefault=[muLti-Default], intDefault=42, timestamp=Tue 
Nov 07 08:58:15 HOVT 2017, _version_=1583370621760307200, intDvoDefault=42, 
score=1.0757567}]},debug={rawquerystring=a_t:one a_t:four,querystring=a_t:one 
a_t:four,parsedquery=a_t:on a_t:four,parsedquery_toString=a_t:on 
a_t:four,explain={0=
   [junit4]   1> 0.57735026 = sum of:
   [junit4]   1>   0.57735026 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.57735026 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.57735026 = fieldNorm(doc=0)
   [junit4]   1> ,1=
   [junit4]   1> 1.0757567 = sum of:
   [junit4]   1>   0.4472136 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.4472136 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1> 
},QParser=LuceneQParser,timing={time=1.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}}}}}}},timing={time=2.0,prepare={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}},process={time=0.0,query={time=0.0},facet={time=0.0},facet_module={time=0.0},mlt={time=0.0},highlight={time=0.0},stats={time=0.0},expand={time=0.0},terms={time=0.0},debug={time=0.0}}},rawquerystring=a_t:one
 a_t:four,querystring=a_t:one a_t:four,parsedquery=a_t:on 
a_t:four,parsedquery_toString=a_t:on a_t:four,QParser=LuceneQParser,explain={1=
   [junit4]   1> 1.0757567 = sum of:
   [junit4]   1>   0.4472136 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.4472136 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1>   0.6285431 = weight(a_t:four in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.6285431 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.4054651 = idf, computed as 
log((docCount+1)/(docFreq+1)) + 1 from:
   [junit4]   1>         1.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.4472136 = fieldNorm(doc=0)
   [junit4]   1> ,0=
   [junit4]   1> 0.57735026 = sum of:
   [junit4]   1>   0.57735026 = weight(a_t:on in 0) 
[MockConfigurableSimilarity], result of:
   [junit4]   1>     0.57735026 = fieldWeight in 0, product of:
   [junit4]   1>       1.0 = tf(freq=1.0), with freq of:
   [junit4]   1>         1.0 = termFreq=1.0
   [junit4]   1>       1.0 = idf, computed as log((docCount+1)/(docFreq+1)) + 1 
from:
   [junit4]   1>         2.0 = docFreq
   [junit4]   1>         2.0 = docCount
   [junit4]   1>       0.57735026 = fieldNorm(doc=0)
   [junit4]   1> }}}
   [junit4]   2> 164187 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> 164189 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@3e86d76a{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 164189 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=837622383
   [junit4]   2> 164190 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 164190 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3508bbb0: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@1262d475
   [junit4]   2> 164195 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 164196 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@c32ad2: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@4bbb1def
   [junit4]   2> 164205 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 164205 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7fdcb94f: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@139fa9ad
   [junit4]   2> 164206 INFO  (coreCloseExecutor-971-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@dee0ffb
   [junit4]   2> 164206 INFO  (coreCloseExecutor-971-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=233705467
   [junit4]   2> 164206 INFO  (coreCloseExecutor-971-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2d4e28e1: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@98841d6
   [junit4]   2> 164219 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1da48890{/,null,UNAVAILABLE}
   [junit4]   2> 164221 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@22b94f02{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 164221 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=539772226
   [junit4]   2> 164221 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 164222 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2fb8203: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@5497deac
   [junit4]   2> 164230 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 164230 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e9efada: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@4bbb1def
   [junit4]   2> 164236 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 164236 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b5a2c5f: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@139fa9ad
   [junit4]   2> 164237 INFO  (coreCloseExecutor-973-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@768e6930
   [junit4]   2> 164237 INFO  (coreCloseExecutor-973-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1989044528
   [junit4]   2> 164237 INFO  (coreCloseExecutor-973-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5842307c: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@2a0e985
   [junit4]   2> 164258 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@165f35a7{/,null,UNAVAILABLE}
   [junit4]   2> 164769 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 164769 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6919ead9{/,null,AVAILABLE}
   [junit4]   2> 164770 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@698c4b71{HTTP/1.1,[http/1.1]}{127.0.0.1:63162}
   [junit4]   2> 164770 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.Server Started @174879ms
   [junit4]   2> 164770 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=63162, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\cores}
   [junit4]   2> 164771 ERROR 
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 164771 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 164771 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 164771 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 164771 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-07T01:58:15.961546800Z
   [junit4]   2> 164772 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\solr.xml
   [junit4]   2> 164776 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 164776 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 164777 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 164846 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 164857 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 164857 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 164860 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\cores
   [junit4]   2> 164860 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 164870 INFO  (coreLoadExecutor-980-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 164870 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 164946 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 164985 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 165217 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 165239 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 165240 INFO  (coreLoadExecutor-980-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@2caaf097
   [junit4]   2> 165240 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 165240 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 165242 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=10, maxMergedSegmentMB=78.890625, 
floorSegmentMB=1.6220703125, forceMergeDeletesPctAllowed=14.024268754251318, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5521166074255556
   [junit4]   2> 165373 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 165373 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 165374 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 165374 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 165377 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7622232160382336]
   [junit4]   2> 165377 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@335e1014[collection1] main]
   [junit4]   2> 165378 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 165380 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 165389 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 165389 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 165389 INFO  (coreLoadExecutor-980-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1583370623075221504
   [junit4]   2> 165390 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 165390 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 165390 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 165391 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 165392 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 165397 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 165399 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 165404 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 165409 INFO  
(searcherExecutor-981-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@335e1014[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 165971 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 165973 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7c4a2541{/,null,AVAILABLE}
   [junit4]   2> 165974 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@443f29f4{HTTP/1.1,[http/1.1]}{127.0.0.1:63165}
   [junit4]   2> 165974 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.e.j.s.Server Started @176083ms
   [junit4]   2> 165974 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=63165, 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard0\cores}
   [junit4]   2> 165984 ERROR 
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 165984 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.2.0
   [junit4]   2> 165984 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 165984 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 165984 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-11-07T01:58:17.174548600Z
   [junit4]   2> 165985 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 165991 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 165991 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 165992 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 166054 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 166062 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 166062 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2caaf097
   [junit4]   2> 166069 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J1\temp\solr.search.stats.TestExactSharedStatsCache_E382ADC9B96A4601-001\tempDir-001\shard0\cores
   [junit4]   2> 166069 INFO  
(TEST-TestExactSharedStatsCache.test-seed#[E382ADC9B96A4601]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 166072 INFO  (coreLoadExecutor-991-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 166073 INFO  (coreLoadExecutor-991-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
 
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 166127 INFO  (coreLoadExecutor-991-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0
   [junit4]   2> 166168 INFO  (coreLoadExecutor-991-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 166306 INFO  (coreLoadExecutor-991-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 166331 INFO  (coreLoadExecutor-991-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from configset 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
 trusted=true
   [junit4]   2> 166332 INFO  (coreLoadExecutor-991-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@2caaf097
   [junit4]   2> 166332 INFO  (coreLoadExecutor-991-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 166332 INFO  (coreLoadExecutor-991-thread-1) [    
x:collection1] 

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

InfoStream [IW][coreCloseExecutor-292-thread-1]: startCommit(): start
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IW][coreCloseExecutor-292-thread-1]:   skip startCommit(): no changes pending
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IW][coreCloseExecutor-292-thread-1]: commit: pendingCommit == null; skip
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IW][coreCloseExecutor-292-thread-1]: commit: took 0.2 msec
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IW][coreCloseExecutor-292-thread-1]: commit: done
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IW][coreCloseExecutor-292-thread-1]: rollback
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IW][coreCloseExecutor-292-thread-1]: all running merges have aborted
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IW][coreCloseExecutor-292-thread-1]: rollback: done finish merges
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[DW][coreCloseExecutor-292-thread-1]: abort
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[DW][coreCloseExecutor-292-thread-1]: done abort success=true
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IW][coreCloseExecutor-292-thread-1]: rollback: infos=
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IFD][coreCloseExecutor-292-thread-1]: now checkpoint "" [0 segments ; isCommit 
= false]
   [junit4]   2> 66749 INFO  (coreCloseExecutor-292-thread-1) 
[n:127.0.0.1:56684_solr c:techproducts s:shard1 r:core_node2 
x:techproducts_shard1_replica_n1] o.a.s.u.LoggingInfoStream 
[IFD][coreCloseExecutor-292-thread-1]: 0 msec to checkpoint
   [junit4]   2> 66750 INFO  (jetty-closer-561-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=98960912641163267-127.0.0.1:56684_solr-n_0000000000) closing
   [junit4]   2> 66750 INFO  
(OverseerStateUpdate-98960912641163267-127.0.0.1:56684_solr-n_0000000000) 
[n:127.0.0.1:56684_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:56684_solr
   [junit4]   2> 66751 WARN  
(OverseerAutoScalingTriggerThread-98960912641163267-127.0.0.1:56684_solr-n_0000000000)
 [n:127.0.0.1:56684_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 66752 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15f946cfca00003, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 66753 INFO  (jetty-closer-561-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@2934896c{/solr,null,UNAVAILABLE}
   [junit4]   2> 66754 ERROR 
(SUITE-UsingSolrJRefGuideExamplesTest-seed#[BCD922A828D4D5B8]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 66754 INFO  
(SUITE-UsingSolrJRefGuideExamplesTest-seed#[BCD922A828D4D5B8]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:56674 56674
   [junit4]   2> 66755 INFO  (Thread-111) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:56674 56674
   [junit4]   2> 66756 WARN  (Thread-111) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/aliases.json
   [junit4]   2>        2       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/collections/techproducts/state.json
   [junit4]   2>        2       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/live_nodes
   [junit4]   2>        2       /solr/collections
   [junit4]   2> 
   [junit4]   2> 66757 INFO  
(SUITE-UsingSolrJRefGuideExamplesTest-seed#[BCD922A828D4D5B8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> Nov 07, 2017 3:01:35 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): {}, 
docValues:{}, maxPointsInLeafNode=2014, maxMBSortInHeap=6.834930676248643, 
sim=RandomSimilarity(queryNorm=true): {}, locale=sr-RS, timezone=Asia/Kathmandu
   [junit4]   2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9.0.1 
(64-bit)/cpus=3,threads=1,free=94517760,total=214511616
   [junit4]   2> NOTE: All tests run in this JVM: [RecursiveEvaluatorTest, 
SolrExampleEmbeddedTest, CumulativeProbabilityEvaluatorTest, UuidEvaluatorTest, 
NamedListTest, HyperbolicSineEvaluatorTest, AppendEvaluatorTest, 
EmpiricalDistributionEvaluatorTest, TestSolrProperties, ArcSineEvaluatorTest, 
StreamExpressionToExpessionTest, GetByIdTest, FloorEvaluatorTest, 
TestJavaBinCodec, ConcatOperationTest, ExclusiveOrEvaluatorTest, 
TestEmbeddedSolrServer, ReverseEvaluatorTest, TestCollectionStateWatchers, 
LengthEvaluatorTest, JdbcTest, SubtractEvaluatorTest, TestJsonRecordReader, 
UsingSolrJRefGuideExamplesTest]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=UsingSolrJRefGuideExamplesTest -Dtests.seed=BCD922A828D4D5B8 
-Dtests.slow=true -Dtests.locale=sr-RS -Dtests.timezone=Asia/Kathmandu 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | UsingSolrJRefGuideExamplesTest (suite) <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the 
following files (in the order of attempts):
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data\version-2:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data\version-2
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1\data
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper\server1
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001\zookeeper
   [junit4]    >    
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001:
 java.nio.file.DirectoryNotEmptyException: 
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.ref_guide_examples.UsingSolrJRefGuideExamplesTest_BCD922A828D4D5B8-001\tempDir-001
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([BCD922A828D4D5B8]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [39/146 (1!)] on J0 in 4.68s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 39529 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to