You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/08/01 23:57:21 UTC
[JENKINS] Lucene-Solr-6.x-Windows (32bit/jdk1.8.0_102) - Build #
358 - Still Unstable!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Windows/358/
Java: 32bit/jdk1.8.0_102 -server -XX:+UseSerialGC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.client.solrj.embedded.MergeIndexesEmbeddedTest
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003
at __randomizedtesting.SeedInfo.seed([23E1034EAA6ABC16]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 13211 lines...]
[junit4] Suite: org.apache.solr.client.solrj.embedded.MergeIndexesEmbeddedTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\init-core-data-001
[junit4] 2> 145197 INFO (SUITE-MergeIndexesEmbeddedTest-seed#[23E1034EAA6ABC16]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 145262 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMergeMultipleRequest
[junit4] 2> 145315 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore'
[junit4] 2> 145315 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 145315 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145315 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\solr.xml
[junit4] 2> 145332 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145332 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer New CoreContainer 1205642
[junit4] 2> 145332 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore]
[junit4] 2> 145332 WARN (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\lib
[junit4] 2> 145332 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 145335 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 145336 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 145336 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 145336 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 145336 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 145337 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145341 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=core0, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 145342 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Found core core0 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0
[junit4] 2> 145347 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=core1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 145348 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Found core core1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1
[junit4] 2> 145351 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Found 2 core definitions
[junit4] 2> 145351 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0'
[junit4] 2> 145354 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 145354 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145352 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1'
[junit4] 2> 145361 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 145361 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145397 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 145398 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 145437 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 145445 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 145447 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 145450 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 145457 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.s.IndexSchema [core0] Schema name=example core zero
[junit4] 2> 145462 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is name
[junit4] 2> 145462 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.s.IndexSchema query parser default operator is OR
[junit4] 2> 145462 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 145463 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.s.IndexSchema [core1] Schema name=example core one
[junit4] 2> 145465 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.s.IndexSchema default search field in schema is name
[junit4] 2> 145465 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.s.IndexSchema query parser default operator is OR
[junit4] 2> 145465 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 145468 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0'
[junit4] 2> 145468 INFO (coreLoadExecutor-421-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'core0' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0
[junit4] 2> 145468 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1'
[junit4] 2> 145468 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrCore solr.StandardDirectoryFactory
[junit4] 2> 145468 INFO (coreLoadExecutor-421-thread-2) [ ] o.a.s.c.CoreContainer Creating SolrCore 'core1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1
[junit4] 2> 145468 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrCore solr.StandardDirectoryFactory
[junit4] 2> 145505 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrCore [[core0] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\]
[junit4] 2> 145505 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrCore JMX monitoring not detected for core: core0
[junit4] 2> 145507 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\snapshot_metadata
[junit4] 2> 145507 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 145507 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001
[junit4] 2> 145508 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\index/
[junit4] 2> 145509 WARN (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrCore [core0] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\index' doesn't exist. Creating new index...
[junit4] 2> 145510 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\index
[junit4] 2> 145519 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrCore [[core1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\]
[junit4] 2> 145519 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrCore JMX monitoring not detected for core: core1
[junit4] 2> 145521 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\snapshot_metadata
[junit4] 2> 145521 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 145522 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002
[junit4] 2> 145523 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\index/
[junit4] 2> 145523 WARN (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrCore [core1] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\index' doesn't exist. Creating new index...
[junit4] 2> 145526 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\index
[junit4] 2> 145537 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\index,segFN=segments_1,generation=1}
[junit4] 2> 145537 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\index,segFN=segments_1,generation=1}
[junit4] 2> 145537 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 145537 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 145539 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 145540 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 145548 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145548 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145549 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145549 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145551 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145551 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145552 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145552 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145553 INFO (OldIndexDirectoryCleanupThreadForCore-core0) [ x:core0] o.a.s.c.SolrCore Looking for old index directories to cleanup for core core0 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\
[junit4] 2> 145553 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.PluginBag requestHandler : '/analysis/field' created with startup=lazy
[junit4] 2> 145553 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/analysis/field,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
[junit4] 2> 145553 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 145554 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 145554 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 145555 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.PluginBag requestHandler : '/analysis/field' created with startup=lazy
[junit4] 2> 145555 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/analysis/field,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
[junit4] 2> 145555 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 145555 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 145555 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 145555 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 145556 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 145556 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 145556 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 145559 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\index,segFN=segments_1,generation=1}
[junit4] 2> 145559 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 145559 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.s.SolrIndexSearcher Opening [Searcher@88c8b2[core1] main]
[junit4] 2> 145560 WARN (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1\conf; switching to use InMemory storage instead.
[junit4] 2> 145560 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 145560 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 145560 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 145560 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 145560 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 145560 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 145560 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 145560 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1541506035581190144
[junit4] 2> 145561 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\index,segFN=segments_1,generation=1}
[junit4] 2> 145561 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 145561 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.s.SolrIndexSearcher Opening [Searcher@f8a1b[core0] main]
[junit4] 2> 145561 WARN (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0\conf; switching to use InMemory storage instead.
[junit4] 2> 145561 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 145561 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 145561 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 145561 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 145562 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1541506035581190144
[junit4] 2> 145562 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 145562 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 145562 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 145562 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1541506035583287296
[junit4] 2> 145562 INFO (coreLoadExecutor-421-thread-2) [ x:core1] o.a.s.c.CoreContainer registering core: core1
[junit4] 2> 145564 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1541506035583287296
[junit4] 2> 145564 INFO (OldIndexDirectoryCleanupThreadForCore-core1) [ x:core1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core core1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\
[junit4] 2> 145564 INFO (coreLoadExecutor-421-thread-1) [ x:core0] o.a.s.c.CoreContainer registering core: core0
[junit4] 2> 145566 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.s.MergeIndexesExampleTestBase CORES=org.apache.solr.core.CoreContainer@12658a : [core0, core1]
[junit4] 2> 145569 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMergeMultipleRequest
[junit4] 2> 145570 INFO (TEST-MergeIndexesEmbeddedTest.testMergeMultipleRequest-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1205642
[junit4] 2> 145570 INFO (searcherExecutor-422-thread-1-processing-x:core0) [ x:core0] o.a.s.c.SolrCore [core0] Registered new searcher Searcher@f8a1b[core0] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 145570 INFO (searcherExecutor-423-thread-1-processing-x:core1) [ x:core1] o.a.s.c.SolrCore [core1] Registered new searcher Searcher@88c8b2[core1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 145571 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.SolrCore [core1] CLOSING SolrCore org.apache.solr.core.SolrCore@1e43b18
[junit4] 2> 145581 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 145581 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 145581 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 145581 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 145586 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.SolrCore [core0] CLOSING SolrCore org.apache.solr.core.SolrCore@5f9617
[junit4] 2> 145588 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 145588 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 145588 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 145588 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.SolrCore [core1] Closing main searcher on request.
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.SolrCore [core0] Closing main searcher on request.
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing StandardDirectoryFactory - 3 directories currently being tracked
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\index [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\index;done=false>>]
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\index
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\snapshot_metadata [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\snapshot_metadata;done=false>>]
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002\snapshot_metadata
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002 [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002;done=false>>]
[junit4] 2> 145594 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 145595 INFO (coreCloseExecutor-432-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-002
[junit4] 2> 145597 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing StandardDirectoryFactory - 3 directories currently being tracked
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001 [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001;done=false>>]
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\snapshot_metadata [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\snapshot_metadata;done=false>>]
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\snapshot_metadata
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\index [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\index;done=false>>]
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 145598 INFO (coreCloseExecutor-432-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-001\index
[junit4] 2> 145603 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMergeIndexesByDirName
[junit4] 2> 145607 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore'
[junit4] 2> 145607 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 145607 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145607 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\solr.xml
[junit4] 2> 145618 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145618 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer New CoreContainer 33417129
[junit4] 2> 145618 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore]
[junit4] 2> 145618 WARN (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\lib
[junit4] 2> 145618 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 145620 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 145621 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 145621 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 145621 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 145621 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 145622 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145629 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=core0, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 145629 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Found core core0 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0
[junit4] 2> 145631 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=core1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 145631 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Found core core1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1
[junit4] 2> 145632 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Found 2 core definitions
[junit4] 2> 145640 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0'
[junit4] 2> 145640 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 145640 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145642 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1'
[junit4] 2> 145642 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 145642 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 145659 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 145660 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 145664 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 145680 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.s.IndexSchema [core1] Schema name=example core one
[junit4] 2> 145685 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.s.IndexSchema default search field in schema is name
[junit4] 2> 145685 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.s.IndexSchema query parser default operator is OR
[junit4] 2> 145685 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 145692 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1'
[junit4] 2> 145692 INFO (coreLoadExecutor-439-thread-2) [ ] o.a.s.c.CoreContainer Creating SolrCore 'core1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1
[junit4] 2> 145693 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrCore solr.StandardDirectoryFactory
[junit4] 2> 145693 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrCore [[core1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\]
[junit4] 2> 145693 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrCore JMX monitoring not detected for core: core1
[junit4] 2> 145693 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 145693 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\snapshot_metadata
[junit4] 2> 145693 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 145695 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 145695 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004
[junit4] 2> 145696 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index/
[junit4] 2> 145696 WARN (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrCore [core1] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index' doesn't exist. Creating new index...
[junit4] 2> 145697 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index
[junit4] 2> 145698 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 145702 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.s.IndexSchema [core0] Schema name=example core zero
[junit4] 2> 145704 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is name
[junit4] 2> 145704 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.s.IndexSchema query parser default operator is OR
[junit4] 2> 145705 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 145706 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0'
[junit4] 2> 145706 INFO (coreLoadExecutor-439-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'core0' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0
[junit4] 2> 145706 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrCore solr.StandardDirectoryFactory
[junit4] 2> 145706 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrCore [[core0] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\]
[junit4] 2> 145706 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrCore JMX monitoring not detected for core: core0
[junit4] 2> 145708 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\snapshot_metadata
[junit4] 2> 145708 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 145708 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003
[junit4] 2> 145708 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index/
[junit4] 2> 145709 WARN (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrCore [core0] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index' doesn't exist. Creating new index...
[junit4] 2> 145710 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index
[junit4] 2> 145718 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index,segFN=segments_1,generation=1}
[junit4] 2> 145718 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 145720 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index,segFN=segments_1,generation=1}
[junit4] 2> 145720 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 145721 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 145722 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145723 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145725 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145725 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145727 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.PluginBag requestHandler : '/analysis/field' created with startup=lazy
[junit4] 2> 145727 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/analysis/field,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
[junit4] 2> 145727 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 145727 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 145727 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 145728 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 145728 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 145730 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index,segFN=segments_1,generation=1}
[junit4] 2> 145730 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a81674[core0] main]
[junit4] 2> 145731 WARN (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core0\conf; switching to use InMemory storage instead.
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 145731 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1541506035760496640
[junit4] 2> 145733 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1541506035760496640
[junit4] 2> 145733 INFO (coreLoadExecutor-439-thread-1) [ x:core0] o.a.s.c.CoreContainer registering core: core0
[junit4] 2> 145734 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 145735 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145736 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145737 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145738 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 145741 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.PluginBag requestHandler : '/analysis/field' created with startup=lazy
[junit4] 2> 145741 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/analysis/field,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
[junit4] 2> 145741 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 145742 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 145742 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004 defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 145743 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 145743 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index,segFN=segments_1,generation=1}
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.s.SolrIndexSearcher Opening [Searcher@ba922e[core1] main]
[junit4] 2> 145745 WARN (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\core1\conf; switching to use InMemory storage instead.
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 145745 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1541506035775176704
[junit4] 2> 145747 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1541506035775176704
[junit4] 2> 145748 INFO (coreLoadExecutor-439-thread-2) [ x:core1] o.a.s.c.CoreContainer registering core: core1
[junit4] 2> 145749 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.s.MergeIndexesExampleTestBase CORES=org.apache.solr.core.CoreContainer@1fde7a9 : [core0, core1]
[junit4] 2> 145761 INFO (searcherExecutor-440-thread-1-processing-x:core1) [ x:core1] o.a.s.c.SolrCore [core1] Registered new searcher Searcher@ba922e[core1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 145762 INFO (searcherExecutor-441-thread-1-processing-x:core0) [ x:core0] o.a.s.c.SolrCore [core0] Registered new searcher Searcher@1a81674[core0] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 145763 INFO (OldIndexDirectoryCleanupThreadForCore-core0) [ x:core0] o.a.s.c.SolrCore Looking for old index directories to cleanup for core core0 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\
[junit4] 2> 145774 INFO (OldIndexDirectoryCleanupThreadForCore-core1) [ x:core1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core core1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\
[junit4] 2> 145779 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 145779 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 145780 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 145780 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 145780 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [core0] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true}{deleteByQuery=*:* (-1541506035780419584),commit=} 0 30
[junit4] 2> 145790 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 145790 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 145791 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 145791 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 145791 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [core1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true}{deleteByQuery=*:* (-1541506035811876864),commit=} 0 10
[junit4] 2> 145795 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 145873 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index,segFN=segments_1,generation=1}
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index,segFN=segments_2,generation=2}
[junit4] 2> 145873 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 145897 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@85e64e[core0] main]
[junit4] 2> 145897 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 145897 INFO (searcherExecutor-441-thread-1) [ ] o.a.s.c.SolrCore [core0] Registered new searcher Searcher@85e64e[core0] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.2.0):C1)))}
[junit4] 2> 145897 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [core0] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true}{add=[AAA (1541506035824459776)],commit=} 0 105
[junit4] 2> 145901 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 145977 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index,segFN=segments_1,generation=1}
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index,segFN=segments_2,generation=2}
[junit4] 2> 145979 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
[junit4] 2> 145982 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@10dee71[core1] main]
[junit4] 2> 145982 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 145982 INFO (searcherExecutor-440-thread-1) [ ] o.a.s.c.SolrCore [core1] Registered new searcher Searcher@10dee71[core1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.2.0):C1)))}
[junit4] 2> 145983 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [core1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true}{add=[BBB (1541506035934560256)],commit=} 0 85
[junit4] 2> 145984 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.S.Request [core0] webapp=null path=/select params={q=id:AAA} hits=1 status=0 QTime=0
[junit4] 2> 145984 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.S.Request [core1] webapp=null path=/select params={q=id:AAA} hits=0 status=0 QTime=0
[junit4] 2> 145985 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.S.Request [core0] webapp=null path=/select params={q=id:AAA} hits=1 status=0 QTime=0
[junit4] 2> 145985 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.S.Request [core0] webapp=null path=/select params={q=id:BBB} hits=0 status=0 QTime=0
[junit4] 2> 145985 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.S.Request [core1] webapp=null path=/select params={q=id:AAA} hits=0 status=0 QTime=0
[junit4] 2> 145985 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.S.Request [core1] webapp=null path=/select params={q=id:BBB} hits=1 status=0 QTime=0
[junit4] 2> 145986 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index
[junit4] 2> 146024 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 start mergeIndexes{}
[junit4] 2> 146116 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 end_mergeIndexes
[junit4] 2> 146117 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index;done=true>>]
[junit4] 2> 146117 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=false
[junit4] 2> 146117 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index
[junit4] 2> 146117 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 146171 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index,segFN=segments_2,generation=2}
[junit4] 2> commit{dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index,segFN=segments_3,generation=3}
[junit4] 2> 146171 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
[junit4] 2> 146176 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@82d977[core0] main]
[junit4] 2> 146176 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 146178 INFO (searcherExecutor-441-thread-1) [ ] o.a.s.c.SolrCore [core0] Registered new searcher Searcher@82d977[core0] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.2.0):C1) Uninverting(_1(6.2.0):C1)))}
[junit4] 2> 146178 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [core0] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true}{commit=} 0 60
[junit4] 2> 146179 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.S.Request [core0] webapp=null path=/select params={q=id:AAA} hits=1 status=0 QTime=0
[junit4] 2> 146179 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.S.Request [core0] webapp=null path=/select params={q=id:BBB} hits=1 status=0 QTime=0
[junit4] 2> 146180 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testMergeIndexesByDirName
[junit4] 2> 146180 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByDirName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=33417129
[junit4] 2> 146183 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.SolrCore [core0] CLOSING SolrCore org.apache.solr.core.SolrCore@df3e91
[junit4] 2> 146188 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=177,transaction_logs_total_number=2}
[junit4] 2> 146188 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 146188 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 146188 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 146190 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.SolrCore [core1] CLOSING SolrCore org.apache.solr.core.SolrCore@1ab6844
[junit4] 2> 146191 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=177,transaction_logs_total_number=2}
[junit4] 2> 146191 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 146191 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 146191 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.SolrCore [core0] Closing main searcher on request.
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing StandardDirectoryFactory - 3 directories currently being tracked
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index;done=false>>]
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\index
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\snapshot_metadata [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\snapshot_metadata;done=false>>]
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003\snapshot_metadata
[junit4] 2> 146207 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003 [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003;done=false>>]
[junit4] 2> 146208 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146208 INFO (coreCloseExecutor-450-thread-1) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003
[junit4] 2> 146216 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.SolrCore [core1] Closing main searcher on request.
[junit4] 2> 146216 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing StandardDirectoryFactory - 3 directories currently being tracked
[junit4] 2> 146216 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004 [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004;done=false>>]
[junit4] 2> 146216 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146216 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004
[junit4] 2> 146216 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index;done=false>>]
[junit4] 2> 146217 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146217 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\index
[junit4] 2> 146217 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\snapshot_metadata [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\snapshot_metadata;done=false>>]
[junit4] 2> 146217 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146217 INFO (coreCloseExecutor-450-thread-2) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-004\snapshot_metadata
[junit4] 2> 146225 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMergeIndexesByCoreName
[junit4] 2> 146231 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore'
[junit4] 2> 146231 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 146231 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 146231 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\solr.xml
[junit4] 2> 146241 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 146241 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer New CoreContainer 19304267
[junit4] 2> 146241 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore]
[junit4] 2> 146241 WARN (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore\lib
[junit4] 2> 146242 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 146244 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 146244 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 146245 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 146245 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 146245 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 146245 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\solrj\src\test-files\solrj\solr\multicore
[junit4] 2> 146247 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1034EAA6ABC16]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=core0, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\}
[junit4] 2> 146247 INFO (TEST-MergeIndexesEmbeddedTest.testMergeIndexesByCoreName-seed#[23E1
[...truncated too long message...]
ogs_total_number=2}
[junit4] 2> 146761 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 146761 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 146761 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 146761 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 146761 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 146761 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.SolrCore [core1] Closing main searcher on request.
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing StandardDirectoryFactory - 3 directories currently being tracked
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006 [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006;done=false>>]
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006\snapshot_metadata [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006\snapshot_metadata;done=false>>]
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006\snapshot_metadata
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006\index [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006\index;done=false>>]
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146765 INFO (coreCloseExecutor-468-thread-1) [ x:core1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-006\index
[junit4] 2> 146768 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.SolrCore [core0] Closing main searcher on request.
[junit4] 2> 146768 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing StandardDirectoryFactory - 3 directories currently being tracked
[junit4] 2> 146768 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005\index [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005\index;done=false>>]
[junit4] 2> 146768 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146768 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005\index
[junit4] 2> 146768 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005 [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005;done=false>>]
[junit4] 2> 146769 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146769 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005
[junit4] 2> 146769 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005\snapshot_metadata [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005\snapshot_metadata;done=false>>]
[junit4] 2> 146769 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 146769 INFO (coreCloseExecutor-468-thread-2) [ x:core0] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-005\snapshot_metadata
[junit4] 2> 146770 INFO (SUITE-MergeIndexesEmbeddedTest-seed#[23E1034EAA6ABC16]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {_version_=Lucene50(blocksize=128), name=FSTOrd50, id=FSTOrd50}, docValues:{_version_=DocValuesFormat(name=Asserting), name=DocValuesFormat(name=Memory), id=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=400, maxMBSortInHeap=5.30642516934571, sim=ClassicSimilarity, locale=he, timezone=Africa/Banjul
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_102 (32-bit)/cpus=3,threads=1,free=72497808,total=154263552
[junit4] 2> NOTE: All tests run in this JVM: [TestCloudSolrClientConnections, DocumentAnalysisResponseTest, GraphTest, TestSpellCheckResponse, CloudSolrClientBuilderTest, TestZkConfigManager, TestXMLEscaping, JettyWebappTest, TestSolrProperties, NamedListTest, ConcurrentUpdateSolrClientTest, TestDocumentObjectBinder, SolrExampleEmbeddedTest, StreamExpressionParserTest, CollectionAdminRequestRequiredParamsTest, TestJsonRecordReader, TestSuggesterResponse, TestConfigSetAdminRequest, CommonParamsTest, TestCoreAdmin, TestSolrJErrorHandling, StreamExpressionTest, SolrExampleStreamingTest, SolrExampleXMLTest, SolrExampleJettyTest, TestBatchUpdate, LargeVolumeEmbeddedTest, MergeIndexesEmbeddedTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=MergeIndexesEmbeddedTest -Dtests.seed=23E1034EAA6ABC16 -Dtests.slow=true -Dtests.locale=he -Dtests.timezone=Africa/Banjul -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[junit4] ERROR 0.00s J0 | MergeIndexesEmbeddedTest (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-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.MergeIndexesEmbeddedTest_23E1034EAA6ABC16-001\tempDir-003
[junit4] > at __randomizedtesting.SeedInfo.seed([23E1034EAA6ABC16]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [51/85 (1!)] on J0 in 1.72s, 3 tests, 1 error <<< FAILURES!
[...truncated 51847 lines...]
[JENKINS] Lucene-Solr-6.x-Windows (64bit/jdk1.8.0_102) - Build #
359 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Windows/359/
Java: 64bit/jdk1.8.0_102 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.handler.component.DistributedMLTComponentTest
Error Message:
Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\collection1 C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2 C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-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-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\collection1
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001
at __randomizedtesting.SeedInfo.seed([7FEE6F4C48AF1F6F]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 12055 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedMLTComponentTest
[junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\init-core-data-001
[junit4] 2> 1863536 INFO (SUITE-DistributedMLTComponentTest-seed#[7FEE6F4C48AF1F6F]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1863536 INFO (SUITE-DistributedMLTComponentTest-seed#[7FEE6F4C48AF1F6F]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /kxb/m
[junit4] 2> 1864036 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1
[junit4] 2> 1864040 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 1864041 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7c0d5943{/kxb/m,null,AVAILABLE}
[junit4] 2> 1864042 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.ServerConnector Started ServerConnector@3c0bd5a6{HTTP/1.1,[http/1.1]}{127.0.0.1:65052}
[junit4] 2> 1864043 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.Server Started @1869361ms
[junit4] 2> 1864043 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/kxb/m, hostPort=65052, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores}
[junit4] 2> 1864043 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 1864043 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control'
[junit4] 2> 1864044 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1864044 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1864044 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\solr.xml
[junit4] 2> 1864055 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores
[junit4] 2> 1864055 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer New CoreContainer 1297475540
[junit4] 2> 1864055 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control]
[junit4] 2> 1864056 WARN (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\lib
[junit4] 2> 1864056 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 1864060 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1864061 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1864061 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1864061 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1864061 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1864064 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores
[junit4] 2> 1864065 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\, configSet=collection1}
[junit4] 2> 1864066 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1
[junit4] 2> 1864066 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1864066 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1864066 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1864067 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1'
[junit4] 2> 1864067 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1864067 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1864068 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1864068 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1864124 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1864132 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0
[junit4] 2> 1864146 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1864153 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1864232 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1864241 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1864241 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1864249 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1864251 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1864253 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1864253 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1864261 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1'
[junit4] 2> 1864261 INFO (coreLoadExecutor-7069-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1
[junit4] 2> 1864261 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1864262 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1\data\]
[junit4] 2> 1864262 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4195207f
[junit4] 2> 1864262 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1\data\snapshot_metadata
[junit4] 2> 1864262 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 1864264 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1\data\
[junit4] 2> 1864264 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1\data\index/
[junit4] 2> 1864264 WARN (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1864264 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1\data\index
[junit4] 2> 1864264 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1654100720, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1864265 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7f2f7a75 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@40428cce),segFN=segments_1,generation=1}
[junit4] 2> 1864265 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1864288 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1864289 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1864289 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1864289 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1864289 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1864289 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1864289 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1864291 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1864291 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1864291 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1864291 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1864291 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1864299 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1864301 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1864302 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1864304 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1864310 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1864311 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\control\cores\collection1\data\
[junit4] 2> 1864311 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/graph,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 1864311 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1864312 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1864312 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1864313 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1864313 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1864314 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1864321 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@7f2f7a75 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@40428cce),segFN=segments_1,generation=1}
[junit4] 2> 1864321 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1864321 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@42d6394f[collection1] main]
[junit4] 2> 1864321 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 1864322 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 1864322 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1864322 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1864345 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1864408 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1864408 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1864409 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1864409 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1864409 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1864410 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1864410 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1864410 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1864410 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1864411 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1864411 INFO (searcherExecutor-7070-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@42d6394f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1864411 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 1864411 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 1864411 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 1864411 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1541543840935051264
[junit4] 2> 1864414 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1541543840935051264
[junit4] 2> 1864414 INFO (coreLoadExecutor-7069-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1865176 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1
[junit4] 2> 1865179 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 1865180 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6524ed17{/kxb/m,null,AVAILABLE}
[junit4] 2> 1865181 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.ServerConnector Started ServerConnector@390b5942{HTTP/1.1,[http/1.1]}{127.0.0.1:65058}
[junit4] 2> 1865181 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.Server Started @1870499ms
[junit4] 2> 1865181 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/kxb/m, hostPort=65058, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores}
[junit4] 2> 1865182 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 1865182 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0'
[junit4] 2> 1865182 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1865182 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1865184 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\solr.xml
[junit4] 2> 1865194 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores
[junit4] 2> 1865194 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer New CoreContainer 603744591
[junit4] 2> 1865194 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0]
[junit4] 2> 1865195 WARN (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\lib
[junit4] 2> 1865195 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 1865198 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1865199 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1865199 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1865199 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1865199 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1865199 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores
[junit4] 2> 1865201 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\, configSet=collection1}
[junit4] 2> 1865201 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1
[junit4] 2> 1865201 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1865201 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1865201 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1865202 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1'
[junit4] 2> 1865202 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1865202 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1865202 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1865202 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1865255 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1865261 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0
[junit4] 2> 1865275 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1865281 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1865343 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1865351 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1865352 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1865357 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1865359 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1865361 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1865361 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1865369 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1'
[junit4] 2> 1865370 INFO (coreLoadExecutor-7080-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1
[junit4] 2> 1865370 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1865370 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1\data\]
[junit4] 2> 1865370 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4195207f
[junit4] 2> 1865371 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1\data\snapshot_metadata
[junit4] 2> 1865371 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 1865371 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1\data\
[junit4] 2> 1865371 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1\data\index/
[junit4] 2> 1865371 WARN (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1865371 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1\data\index
[junit4] 2> 1865374 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1654100720, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1865375 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@12595a3e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3e4535f3),segFN=segments_1,generation=1}
[junit4] 2> 1865375 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1865375 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1\data\
[junit4] 2> 1865376 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard0\cores\collection1\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1865380 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1865386 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1865387 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1865408 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1865409 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1865414 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1865416 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/graph,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 1865416 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1865419 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1865419 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1865420 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1865420 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1865421 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1865422 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@12595a3e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3e4535f3),segFN=segments_1,generation=1}
[junit4] 2> 1865422 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1865422 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@202c1174[collection1] main]
[junit4] 2> 1865422 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 1865422 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 1865422 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1865422 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1865532 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1865605 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1865606 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 1865606 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 1865606 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 1865606 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1541543842188099584
[junit4] 2> 1865608 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1541543842188099584
[junit4] 2> 1865608 INFO (coreLoadExecutor-7080-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1865612 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1865614 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1865614 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1865614 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1865614 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1865614 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1865615 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1865616 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1865617 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1865617 INFO (searcherExecutor-7081-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@202c1174[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1866214 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1
[junit4] 2> 1866216 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 1866218 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@fc3ac93{/kxb/m,null,AVAILABLE}
[junit4] 2> 1866218 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.ServerConnector Started ServerConnector@5f559187{HTTP/1.1,[http/1.1]}{127.0.0.1:65064}
[junit4] 2> 1866219 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.Server Started @1871536ms
[junit4] 2> 1866220 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/kxb/m, hostPort=65064, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores}
[junit4] 2> 1866220 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 1866220 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1'
[junit4] 2> 1866221 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1866221 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1866221 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\solr.xml
[junit4] 2> 1866231 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores
[junit4] 2> 1866231 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer New CoreContainer 1872118577
[junit4] 2> 1866232 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1]
[junit4] 2> 1866232 WARN (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\lib
[junit4] 2> 1866232 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 1866235 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1866235 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1866235 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1866235 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1866237 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1866237 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores
[junit4] 2> 1866239 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\, configSet=collection1}
[junit4] 2> 1866239 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1
[junit4] 2> 1866240 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1866240 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1866240 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1866240 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1'
[junit4] 2> 1866240 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1866240 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1866240 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1866240 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1866294 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1866300 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0
[junit4] 2> 1866315 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1866321 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1866386 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1866395 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1866396 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1866401 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1866403 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1866405 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1866405 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1866413 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1'
[junit4] 2> 1866413 INFO (coreLoadExecutor-7091-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1
[junit4] 2> 1866414 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1866414 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1\data\]
[junit4] 2> 1866414 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4195207f
[junit4] 2> 1866414 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1\data\snapshot_metadata
[junit4] 2> 1866414 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 1866415 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1\data\
[junit4] 2> 1866415 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1\data\index/
[junit4] 2> 1866415 WARN (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1866415 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1\data\index
[junit4] 2> 1866415 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1654100720, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1866416 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@64cff1af lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@743c7ae0),segFN=segments_1,generation=1}
[junit4] 2> 1866417 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1866417 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1\data\
[junit4] 2> 1866418 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard1\cores\collection1\data\ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1866421 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1866422 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1866422 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1866427 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1866429 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1866430 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1866431 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1866437 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 1866439 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/graph,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 1866439 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1866440 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1866440 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1866441 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1866441 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1866443 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=40, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1866443 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@64cff1af lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@743c7ae0),segFN=segments_1,generation=1}
[junit4] 2> 1866443 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1866443 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@42f4b702[collection1] main]
[junit4] 2> 1866444 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 1866444 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 1866444 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1866444 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 1866456 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1866514 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1866516 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1866516 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 1866516 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 1866516 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 1866516 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1541543843142303744
[junit4] 2> 1866517 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1866517 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1866517 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1866517 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1866518 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1541543843142303744
[junit4] 2> 1866518 INFO (coreLoadExecutor-7091-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1866518 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1866519 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1866520 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1866522 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1866523 INFO (searcherExecutor-7092-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@42f4b702[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1867291 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1
[junit4] 2> 1867294 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 1867295 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2b01c853{/kxb/m,null,AVAILABLE}
[junit4] 2> 1867296 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.ServerConnector Started ServerConnector@6de8b379{HTTP/1.1,[http/1.1]}{127.0.0.1:65069}
[junit4] 2> 1867296 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.Server Started @1872614ms
[junit4] 2> 1867296 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/kxb/m, hostPort=65069, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores}
[junit4] 2> 1867296 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 1867297 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2'
[junit4] 2> 1867297 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1867297 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1867299 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\solr.xml
[junit4] 2> 1867310 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores
[junit4] 2> 1867311 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer New CoreContainer 1961137920
[junit4] 2> 1867311 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2]
[junit4] 2> 1867311 WARN (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\lib to classpath: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\lib
[junit4] 2> 1867311 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
[junit4] 2> 1867314 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1867315 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1867315 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1867315 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1867315 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1867319 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores
[junit4] 2> 1867320 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data\, configSet=collection1}
[junit4] 2> 1867320 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1
[junit4] 2> 1867321 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 1867321 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 1867321 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1867322 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1'
[junit4] 2> 1867323 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1867323 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 1867323 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1867323 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1867407 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1867414 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0
[junit4] 2> 1867429 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1867435 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1867494 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1867502 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1867503 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1867507 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1867509 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1867511 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1867511 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1867520 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1'
[junit4] 2> 1867521 INFO (coreLoadExecutor-7102-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1
[junit4] 2> 1867521 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1867521 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\]
[junit4] 2> 1867521 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4195207f
[junit4] 2> 1867522 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\snapshot_metadata
[junit4] 2> 1867522 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file...
[junit4] 2> 1867523 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\
[junit4] 2> 1867523 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\index/
[junit4] 2> 1867523 WARN (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\index' doesn't exist. Creating new index...
[junit4] 2> 1867523 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\index
[junit4] 2> 1867523 INFO (coreLoadExecutor-7102-thread-1) [ x:collection1] o.a.s.u.RandomMergePoli
[...truncated too long message...]
workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\snapshot_metadata
[junit4] 2> 1868776 INFO (coreCloseExecutor-7114-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\index;done=false>>]
[junit4] 2> 1868776 INFO (coreCloseExecutor-7114-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true
[junit4] 2> 1868776 INFO (coreCloseExecutor-7114-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\cores\collection1\data\index
[junit4] 2> 1868784 INFO (TEST-DistributedMLTComponentTest.test-seed#[7FEE6F4C48AF1F6F]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2b01c853{/kxb/m,null,UNAVAILABLE}
[junit4] 2> 1868802 INFO (SUITE-DistributedMLTComponentTest-seed#[7FEE6F4C48AF1F6F]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {range_facet_l_dv=Lucene50(blocksize=128), _version_=PostingsFormat(name=Direct), lowerfilt1=PostingsFormat(name=Memory doPackFST= false), lowerfilt1and2=PostingsFormat(name=LuceneFixedGap), multiDefault=PostingsFormat(name=LuceneFixedGap), intDefault=PostingsFormat(name=Direct), lowerfilt=PostingsFormat(name=LuceneFixedGap), id=Lucene50(blocksize=128), range_facet_i_dv=PostingsFormat(name=Direct), range_facet_l=PostingsFormat(name=Direct), timestamp=PostingsFormat(name=Direct)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), range_facet_i_dv=DocValuesFormat(name=Lucene54), timestamp=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=1527, maxMBSortInHeap=6.01169864588142, sim=ClassicSimilarity, locale=fi, timezone=Canada/Pacific
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_102 (64-bit)/cpus=3,threads=1,free=183678096,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestAnalyzeInfixSuggestions, RuleEngineTest, TestSimpleQParserPlugin, TestSolrConfigHandler, DistribJoinFromCollectionTest, TestStandardQParsers, TestFieldCacheSort, TestCSVLoader, TestLazyCores, TestDFRSimilarityFactory, TestStressVersions, HdfsDirectoryFactoryTest, TestCustomDocTransformer, CdcrUpdateLogTest, HdfsTlogReplayBufferedWhileIndexingTest, RecoveryZkTest, PreAnalyzedFieldTest, TestRestoreCore, CircularListTest, TestCursorMarkWithoutUniqueKey, HdfsDirectoryTest, ConcurrentDeleteAndCreateCollectionTest, SolrRequestParserTest, TestSurroundQueryParser, OverseerRolesTest, TestDocSet, AddSchemaFieldsUpdateProcessorFactoryTest, SuggestComponentContextFilterQueryTest, TestComponentsName, TestFieldSortValues, TestDocumentBuilder, CheckHdfsIndexTest, TestClusterStateMutator, TestSolrQueryParserResource, TestIntervalFaceting, TestSchemaNameResource, LeaderInitiatedRecoveryOnCommitTest, PathHierarchyTokenizerFactoryTest, DOMUtilTest, TestFileDictionaryLookup, SyncSliceTest, SolrCLIZkUtilsTest, TestSolrConfigHandlerCloud, TestCloudDeleteByQuery, TestSchemaManager, SortSpecParsingTest, ClusterStateTest, PrimUtilsTest, TestRandomCollapseQParserPlugin, SSLMigrationTest, TestImplicitCoreProperties, DistributedQueryComponentOptimizationTest, TestConfigSetImmutable, HdfsWriteToMultipleCollectionsTest, TestLockTree, FullHLLTest, TestFieldCacheVsDocValues, ConnectionManagerTest, UpdateParamsTest, SecurityConfHandlerTest, DocExpirationUpdateProcessorFactoryTest, SuggesterFSTTest, TestConfigSetsAPIExclusivity, DirectUpdateHandlerTest, TestConfig, SolrTestCaseJ4Test, TestTrieFacet, TestSolrDeletionPolicy1, TestDistribIDF, DirectSolrSpellCheckerTest, TestRandomFlRTGCloud, TestFaceting, PolyFieldTest, TestPostingsSolrHighlighter, TestMinMaxOnMultiValuedField, TestStressCloudBlindAtomicUpdates, TestInitParams, TestCloudManagedSchema, PingRequestHandlerTest, TestSubQueryTransformer, StatelessScriptUpdateProcessorFactoryTest, TestArbitraryIndexDir, TestPivotHelperCode, TestPhraseSuggestions, TestObjectReleaseTracker, TestSchemaSimilarityResource, CoreAdminCreateDiscoverTest, AlternateDirectoryTest, TestGraphMLResponseWriter, TestSort, DistributedFacetPivotWhiteBoxTest, TestAnalyzedSuggestions, TestSolr4Spatial2, TestHashPartitioner, TestSolrCLIRunExample, VMParamsZkACLAndCredentialsProvidersTest, TestSortByMinMaxFunction, HttpPartitionTest, TestHdfsCloudBackupRestore, SOLR749Test, TestBulkSchemaAPI, DistributedDebugComponentTest, CurrencyFieldXmlFileTest, TestCoreContainer, TestFastLRUCache, TestRandomDVFaceting, SoftAutoCommitTest, TestCollectionAPI, ExternalFileFieldSortTest, UUIDUpdateProcessorFallbackTest, DocumentAnalysisRequestHandlerTest, HdfsNNFailoverTest, DistribCursorPagingTest, CollectionStateFormat2Test, AnalysisAfterCoreReloadTest, TestSlowCompositeReaderWrapper, IndexSchemaTest, RestartWhileUpdatingTest, AsyncMigrateRouteKeyTest, CollectionsAPIAsyncDistributedZkTest, CdcrReplicationDistributedZkTest, TestSizeLimitedDistributedMap, TlogReplayBufferedWhileIndexingTest, ChaosMonkeyNothingIsSafeTest, CursorPagingTest, HdfsBasicDistributedZkTest, RegexBoostProcessorTest, CustomCollectionTest, TestHighlightDedupGrouping, TestJsonRequest, TestDocBasedVersionConstraints, DeleteShardTest, BasicDistributedZkTest, DistributedFacetPivotSmallAdvancedTest, TestOverriddenPrefixQueryForCustomFieldType, SliceStateTest, BlockJoinFacetDistribTest, TestNamedUpdateProcessors, TestLMDirichletSimilarityFactory, SharedFSAutoReplicaFailoverUtilsTest, TestCloudSchemaless, DisMaxRequestHandlerTest, TestFieldTypeCollectionResource, ShardRoutingTest, UUIDFieldTest, LeaderElectionTest, TestExactStatsCache, TestReplicationHandlerBackup, DocumentBuilderTest, TestUpdate, TestNumericTerms64, HighlighterTest, BigEndianAscendingWordDeserializerTest, ZkCLITest, TestDistributedGrouping, TestRecovery, DistributedSpellCheckComponentTest, ZkControllerTest, TestStressReorder, HardAutoCommitTest, TestRangeQuery, SimpleFacetsTest, SolrCoreTest, SpellCheckComponentTest, TestGroupingSearch, QueryElevationComponentTest, PeerSyncTest, TestFunctionQuery, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, SimplePostToolTest, TestCoreDiscovery, TestExtendedDismaxParser, TestFoldingMultitermQuery, DocValuesTest, TestWordDelimiterFilterFactory, SortByFunctionTest, TestRemoteStreaming, DebugComponentTest, IndexBasedSpellCheckerTest, TestQueryUtils, StandardRequestHandlerTest, TestReversedWildcardFilterFactory, TestQueryTypes, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, MoreLikeThisHandlerTest, FastVectorHighlighterTest, TestJmxIntegration, ReturnFieldsTest, TestCSVResponseWriter, JsonLoaderTest, CSVRequestHandlerTest, TestQuerySenderNoQuery, ResponseLogComponentTest, SolrIndexConfigTest, BadComponentTest, TestStressRecovery, TestMergePolicyConfig, TestSolrDeletionPolicy2, SampleTest, TestSearchPerf, TestElisionMultitermQuery, TestLuceneMatchVersion, TestCodecSupport, TestXIncludeConfig, TestSweetSpotSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, TestFastWriter, TestJmxMonitoredMap, TimeZoneUtilsTest, TestFastOutputStream, ScriptEngineTest, URLClassifyProcessorTest, TestSystemIdResolver, TestSuggestSpellingConverter, DateFieldTest, RAMDirectoryFactoryTest, TestLRUCache, SystemInfoHandlerTest, FileUtilsTest, DistributedMLTComponentTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistributedMLTComponentTest -Dtests.seed=7FEE6F4C48AF1F6F -Dtests.slow=true -Dtests.locale=fi -Dtests.timezone=Canada/Pacific -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | DistributedMLTComponentTest (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-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2\collection1
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001\shard2
[junit4] > C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedMLTComponentTest_7FEE6F4C48AF1F6F-001\tempDir-001
[junit4] > at __randomizedtesting.SeedInfo.seed([7FEE6F4C48AF1F6F]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [437/625 (1!)] on J0 in 5.92s, 1 test, 1 error <<< FAILURES!
[...truncated 60697 lines...]