You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/01/11 19:26:55 UTC

[JENKINS] Lucene-Solr-6.x-Windows (32bit/jdk1.8.0_112) - Build # 684 - Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Windows/684/
Java: 32bit/jdk1.8.0_112 -client -XX:+UseParallelGC

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.update.SolrCmdDistributorTest

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\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\collection1    C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2    C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-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\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\collection1
   C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2
   C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001

	at __randomizedtesting.SeedInfo.seed([D62C38592FB53F81]: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 11020 lines...]
   [junit4] Suite: org.apache.solr.update.SolrCmdDistributorTest
   [junit4]   2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\init-core-data-001
   [junit4]   2> 288447 INFO  (SUITE-SolrCmdDistributorTest-seed#[D62C38592FB53F81]-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> 288447 INFO  (SUITE-SolrCmdDistributorTest-seed#[D62C38592FB53F81]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_q/h
   [junit4]   2> 288454 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 288988 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\control\cores\collection1
   [junit4]   2> 288992 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 288993 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@77922d{/_q/h,null,AVAILABLE}
   [junit4]   2> 289002 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1760450{HTTP/1.1,[http/1.1]}{127.0.0.1:51150}
   [junit4]   2> 289002 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server Started @292874ms
   [junit4]   2> 289002 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001/control/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/_q/h, hostPort=51150, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\control\cores}
   [junit4]   2> 289003 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 289003 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 6.4.0
   [junit4]   2> 289003 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 289003 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 289003 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-01-11T18:16:45.920Z
   [junit4]   2> 289004 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\control\solr.xml
   [junit4]   2> 289022 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 289029 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\control\cores
   [junit4]   2> 289029 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 289032 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 289131 WARN  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 289132 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 289178 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 289295 WARN  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 289298 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 289320 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] 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> 289320 INFO  (coreLoadExecutor-2035-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\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\control\cores\collection1\data\]
   [junit4]   2> 289320 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@176d2c8
   [junit4]   2> 289333 WARN  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 289361 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 289361 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 289364 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 289364 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 289366 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@bae0f[collection1] main]
   [junit4]   2> 289369 WARN  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
   [junit4]   2> 289375 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 289377 INFO  (searcherExecutor-2036-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@bae0f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 289377 INFO  (coreLoadExecutor-2035-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1556253094753337344
   [junit4]   2> 289953 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard0\cores\collection1
   [junit4]   2> 289956 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 289957 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7a9142{/_q/h,null,AVAILABLE}
   [junit4]   2> 289958 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1bc5690{HTTP/1.1,[http/1.1]}{127.0.0.1:51157}
   [junit4]   2> 289958 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server Started @293831ms
   [junit4]   2> 289958 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001/shard0/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/_q/h, hostPort=51157, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard0\cores}
   [junit4]   2> 289958 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 289960 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 6.4.0
   [junit4]   2> 289960 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 289960 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 289960 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-01-11T18:16:46.877Z
   [junit4]   2> 289961 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard0\solr.xml
   [junit4]   2> 289978 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 289983 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard0\cores
   [junit4]   2> 289983 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 289987 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 290061 WARN  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 290062 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 290083 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 290210 WARN  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 290218 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 290263 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] 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> 290265 INFO  (coreLoadExecutor-2046-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\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard0\cores\collection1\data\]
   [junit4]   2> 290265 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@176d2c8
   [junit4]   2> 290277 WARN  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 290307 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 290307 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 290316 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 290316 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 290321 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@91ab1a[collection1] main]
   [junit4]   2> 290326 WARN  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
   [junit4]   2> 290326 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 290329 INFO  (searcherExecutor-2047-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@91ab1a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 290333 INFO  (coreLoadExecutor-2046-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1556253095755776000
   [junit4]   2> 290953 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard1\cores\collection1
   [junit4]   2> 290957 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 290958 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d1ace4{/_q/h,null,AVAILABLE}
   [junit4]   2> 290960 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1c4d6ec{HTTP/1.1,[http/1.1]}{127.0.0.1:51163}
   [junit4]   2> 290960 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server Started @294832ms
   [junit4]   2> 290960 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001/shard1/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/_q/h, hostPort=51163, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard1\cores}
   [junit4]   2> 290961 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 290961 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 6.4.0
   [junit4]   2> 290961 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 290961 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 290961 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-01-11T18:16:47.878Z
   [junit4]   2> 290962 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard1\solr.xml
   [junit4]   2> 290981 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 290986 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard1\cores
   [junit4]   2> 290986 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 290988 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 291056 WARN  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 291057 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 291075 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 291185 WARN  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 291189 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 291221 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] 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> 291222 INFO  (coreLoadExecutor-2057-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\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard1\cores\collection1\data\]
   [junit4]   2> 291222 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@176d2c8
   [junit4]   2> 291235 WARN  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 291276 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 291277 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 291278 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 291278 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 291283 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ee9c50[collection1] main]
   [junit4]   2> 291286 WARN  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
   [junit4]   2> 291286 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 291288 INFO  (searcherExecutor-2058-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ee9c50[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 291290 INFO  (coreLoadExecutor-2057-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1556253096759263232
   [junit4]   2> 291884 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\cores\collection1
   [junit4]   2> 291887 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 291888 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d7b2a1{/_q/h,null,AVAILABLE}
   [junit4]   2> 291890 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@116e365{HTTP/1.1,[http/1.1]}{127.0.0.1:51167}
   [junit4]   2> 291890 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server Started @295762ms
   [junit4]   2> 291890 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001/shard2/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/_q/h, hostPort=51167, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\cores}
   [junit4]   2> 291890 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 291890 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 6.4.0
   [junit4]   2> 291890 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 291892 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 291892 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-01-11T18:16:48.809Z
   [junit4]   2> 291893 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\solr.xml
   [junit4]   2> 291908 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 291912 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\cores
   [junit4]   2> 291912 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 291915 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 291983 WARN  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 291984 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 292001 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 292119 WARN  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 292122 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 292629 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] 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> 292630 INFO  (coreLoadExecutor-2068-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\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\cores\collection1\data\]
   [junit4]   2> 292630 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@176d2c8
   [junit4]   2> 292646 WARN  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 292677 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 292677 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 292678 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 292678 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 292687 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@12871e6[collection1] main]
   [junit4]   2> 292688 WARN  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
   [junit4]   2> 292688 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 292690 INFO  (searcherExecutor-2069-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@12871e6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 292692 INFO  (coreLoadExecutor-2068-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1556253098229366784
   [junit4]   2> 293291 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard3\cores\collection1
   [junit4]   2> 293295 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 293296 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d2cef4{/_q/h,null,AVAILABLE}
   [junit4]   2> 293298 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@3ea060{HTTP/1.1,[http/1.1]}{127.0.0.1:51174}
   [junit4]   2> 293298 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.Server Started @297170ms
   [junit4]   2> 293299 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001/shard3/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/_q/h, hostPort=51174, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard3\cores}
   [junit4]   2> 293299 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 293299 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 6.4.0
   [junit4]   2> 293299 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 293299 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 293299 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2017-01-11T18:16:50.216Z
   [junit4]   2> 293300 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard3\solr.xml
   [junit4]   2> 293315 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 293322 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard3\cores
   [junit4]   2> 293323 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 293343 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-6.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 293424 WARN  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 293424 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 293460 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 293572 WARN  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 293576 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 293620 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] 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> 293621 INFO  (coreLoadExecutor-2079-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\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard3\cores\collection1\data\]
   [junit4]   2> 293621 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@176d2c8
   [junit4]   2> 293642 WARN  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 293673 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 293673 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 293675 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 293675 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 293685 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@18dacac[collection1] main]
   [junit4]   2> 293686 WARN  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\core\src\test-files\solr\collection1\conf; switching to use InMemory storage instead.
   [junit4]   2> 293686 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 293689 INFO  (searcherExecutor-2080-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18dacac[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 293697 INFO  (coreLoadExecutor-2079-thread-1) [    x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1556253099283185664
   [junit4]   2> 293706 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 293718 INFO  (qtp2187894-3304) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1556253099302060032)} 0 3
   [junit4]   2> 293727 INFO  (qtp23172025-3330) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1556253099311497216)} 0 3
   [junit4]   2> 293733 INFO  (qtp9734425-3339) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1556253099319885824)} 0 2
   [junit4]   2> 293742 INFO  (qtp10877728-3359) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1556253099328274432)} 0 2
   [junit4]   2> 293749 INFO  (qtp14992031-3376) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1556253099334565888)} 0 3
   [junit4]   2> 293757 INFO  (qtp2187894-3305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[1 (1556253099341905920)]} 0 4
   [junit4]   2> 293762 INFO  (qtp2187894-3307) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 293762 INFO  (qtp2187894-3307) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@a350ed
   [junit4]   2> 293777 INFO  (qtp2187894-3307) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@8fc1d2[collection1] main]
   [junit4]   2> 293778 INFO  (qtp2187894-3307) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 293780 INFO  (searcherExecutor-2036-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@8fc1d2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c1)))}
   [junit4]   2> 293780 INFO  (qtp2187894-3307) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 18
   [junit4]   2> 293785 INFO  (qtp2187894-3308) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 293795 INFO  (qtp2187894-3309) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={commit_end_point=true&wt=javabin&version=2}{add=[2 (1556253099379654656), 3 (1556253099385946112)]} 0 7
   [junit4]   2> 293798 INFO  (qtp23172025-3326) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={commit_end_point=true&wt=javabin&version=2}{add=[2 (1556253099381751808), 3 (1556253099388043264), 4 (1556253099389091840)]} 0 8
   [junit4]   2> 293803 INFO  (qtp2187894-3302) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 293803 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 293805 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c1cd2b
   [junit4]   2> 293806 INFO  (qtp2187894-3302) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@a350ed
   [junit4]   2> 293824 INFO  (qtp2187894-3302) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6616a[collection1] main]
   [junit4]   2> 293825 INFO  (qtp2187894-3302) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 293827 INFO  (searcherExecutor-2036-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6616a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c1) Uninverting(_1(6.4.0):c2)))}
   [junit4]   2> 293828 INFO  (qtp2187894-3302) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 24
   [junit4]   2> 293832 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@389fd1[collection1] main]
   [junit4]   2> 293833 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 293834 INFO  (searcherExecutor-2047-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@389fd1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c3)))}
   [junit4]   2> 293835 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 31
   [junit4]   2> 293838 INFO  (qtp2187894-3304) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/select params={q=*:*&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 293843 INFO  (qtp23172025-3323) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/select params={q=*:*&wt=javabin&version=2} hits=3 status=0 QTime=0
   [junit4]   2> 293848 INFO  (qtp23172025-3322) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={commit_end_point=true&wt=javabin&version=2}{delete=[3 (-1556253099438374912)]} 0 2
   [junit4]   2> 293848 INFO  (qtp2187894-3306) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={commit_end_point=true&wt=javabin&version=2}{delete=[3 (-1556253099438374912)]} 0 2
   [junit4]   2> 293853 INFO  (qtp2187894-3305) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 293853 INFO  (qtp23172025-3321) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 293853 INFO  (qtp2187894-3305) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@a350ed
   [junit4]   2> 293853 INFO  (qtp23172025-3321) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c1cd2b
   [junit4]   2> 293857 INFO  (qtp2187894-3305) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@cfe400[collection1] main]
   [junit4]   2> 293858 INFO  (qtp2187894-3305) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 293860 INFO  (searcherExecutor-2036-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@cfe400[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c1) Uninverting(_1(6.4.0):c2/1:delGen=1)))}
   [junit4]   2> 293860 INFO  (qtp2187894-3305) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 8
   [junit4]   2> 293864 INFO  (qtp23172025-3321) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@13eb2ae[collection1] main]
   [junit4]   2> 293865 INFO  (qtp23172025-3321) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 293867 INFO  (searcherExecutor-2047-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@13eb2ae[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c3/1:delGen=1)))}
   [junit4]   2> 293868 INFO  (qtp23172025-3321) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 15
   [junit4]   2> 293871 INFO  (qtp2187894-3307) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
   [junit4]   2> 293873 INFO  (qtp23172025-3331) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
   [junit4]   2> 293877 INFO  (qtp23172025-3319) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 293877 WARN  (qtp23172025-3319) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care.
   [junit4]   2> 294052 INFO  (qtp23172025-3319) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c1cd2b
   [junit4]   2> 294055 INFO  (qtp23172025-3319) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1669ad4[collection1] main]
   [junit4]   2> 294057 INFO  (qtp23172025-3319) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294058 INFO  (searcherExecutor-2047-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1669ad4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.4.0):C2)))}
   [junit4]   2> 294059 INFO  (qtp23172025-3319) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={optimize=true&maxSegments=1&waitSearcher=true&wt=javabin&version=2}{optimize=} 0 181
   [junit4]   2> 294062 INFO  (qtp9734425-3349) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 294063 WARN  (qtp9734425-3349) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care.
   [junit4]   2> 294063 INFO  (qtp9734425-3349) [    x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 294064 INFO  (qtp9734425-3349) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294064 INFO  (qtp9734425-3349) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={optimize=true&maxSegments=1&waitSearcher=true&wt=javabin&version=2}{optimize=} 0 1
   [junit4]   2> 294066 INFO  (qtp10877728-3362) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 294066 WARN  (qtp10877728-3362) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care.
   [junit4]   2> 294067 INFO  (qtp10877728-3362) [    x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 294068 INFO  (qtp10877728-3362) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294068 INFO  (qtp10877728-3362) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={optimize=true&maxSegments=1&waitSearcher=true&wt=javabin&version=2}{optimize=} 0 1
   [junit4]   2> 294071 INFO  (qtp14992031-3379) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 294071 WARN  (qtp14992031-3379) [    x:collection1] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care.
   [junit4]   2> 294072 INFO  (qtp14992031-3379) [    x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 294074 INFO  (qtp14992031-3379) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294074 INFO  (qtp14992031-3379) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={optimize=true&maxSegments=1&waitSearcher=true&wt=javabin&version=2}{optimize=} 0 2
   [junit4]   2> 294157 INFO  (qtp23172025-3330) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[5 (1556253099682693120), 7 (1556253099706810368), 8 (1556253099707858944), 12 (1556253099707858945), 15 (1556253099708907520), 17 (1556253099708907521), 19 (1556253099708907522), 21 (1556253099708907523), 22 (1556253099709956096), 23 (1556253099709956097), ... (93 adds)]} 0 79
   [junit4]   2> 294216 INFO  (qtp10877728-3363) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[5 (1556253099687936000), 6 (1556253099707858944), 7 (1556253099707858945), 8 (1556253099707858946), 12 (1556253099708907520), 13 (1556253099708907521), 17 (1556253099708907522), 19 (1556253099708907523), 20 (1556253099709956096), 22 (1556253099709956097), ... (194 adds)]} 0 133
   [junit4]   2> 294218 INFO  (qtp23172025-3325) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[202 (1556253099768676352), 204 (1556253099768676353), 205 (1556253099769724928), 206 (1556253099769724929), 209 (1556253099769724930), 210 (1556253099769724931), 212 (1556253099770773504), 214 (1556253099770773505), 215 (1556253099770773506), 216 (1556253099770773507), ... (138 adds)]} 0 58
   [junit4]   2> 294223 INFO  (qtp10877728-3365) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[393 (1556253099830542336), 394 (1556253099831590912), 396 (1556253099831590913), 398 (1556253099831590914), 399 (1556253099831590915), 400 (1556253099832639488), 403 (1556253099832639489), 405 (1556253099832639490), 406 (1556253099832639491), 407 (1556253099832639492), ... (33 adds)]} 0 4
   [junit4]   2> 294225 INFO  (qtp9734425-3346) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[8 (1556253099713101824), 9 (1556253099724636160), 14 (1556253099724636161), 18 (1556253099724636162), 19 (1556253099724636163), 21 (1556253099725684736), 22 (1556253099725684737), 25 (1556253099725684738), 29 (1556253099726733312), 33 (1556253099726733313), ... (183 adds)]} 0 119
   [junit4]   2> 294233 INFO  (qtp9734425-3345) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[391 (1556253099841028096), 392 (1556253099841028097), 394 (1556253099842076672), 396 (1556253099842076673), 399 (1556253099842076674), 400 (1556253099842076675), 401 (1556253099842076676), 407 (1556253099842076677), 412 (1556253099842076678), 414 (1556253099842076679), ... (27 adds)]} 0 4
   [junit4]   2> 294235 INFO  (qtp14992031-3380) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[6 (1556253099711004672), 7 (1556253099770773504), 8 (1556253099771822080), 10 (1556253099771822081), 11 (1556253099771822082), 13 (1556253099772870656), 14 (1556253099772870657), 16 (1556253099772870658), 18 (1556253099772870659), 22 (1556253099773919232), ... (198 adds)]} 0 131
   [junit4]   2> 294244 INFO  (qtp14992031-3381) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={wt=javabin&version=2}{add=[391 (1556253099850465280), 394 (1556253099851513856), 395 (1556253099851513857), 396 (1556253099851513858), 398 (1556253099852562432), 399 (1556253099852562433), 400 (1556253099852562434), 404 (1556253099852562435), 407 (1556253099852562436), 408 (1556253099853611008), ... (28 adds)]} 0 5
   [junit4]   2> 294248 INFO  (qtp9734425-3344) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 294248 INFO  (qtp23172025-3326) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 294249 INFO  (qtp23172025-3326) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@c1cd2b
   [junit4]   2> 294249 INFO  (qtp9734425-3344) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@10ea030
   [junit4]   2> 294249 INFO  (qtp10877728-3366) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 294251 INFO  (qtp14992031-3382) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 294251 INFO  (qtp10877728-3366) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@cf84a4
   [junit4]   2> 294252 INFO  (qtp14992031-3382) [    x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@56f02e
   [junit4]   2> 294323 INFO  (qtp10877728-3366) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ef2793[collection1] main]
   [junit4]   2> 294323 INFO  (qtp14992031-3382) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@15e00b1[collection1] main]
   [junit4]   2> 294325 INFO  (qtp10877728-3366) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294326 INFO  (qtp9734425-3344) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4ac6bf[collection1] main]
   [junit4]   2> 294327 INFO  (qtp9734425-3344) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294328 INFO  (searcherExecutor-2069-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ef2793[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c227)))}
   [junit4]   2> 294329 INFO  (searcherExecutor-2080-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15e00b1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c226)))}
   [junit4]   2> 294331 INFO  (qtp10877728-3366) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 81
   [junit4]   2> 294332 INFO  (qtp14992031-3382) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294332 INFO  (qtp14992031-3382) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 81
   [junit4]   2> 294343 INFO  (searcherExecutor-2058-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4ac6bf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c210)))}
   [junit4]   2> 294344 INFO  (qtp9734425-3344) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 95
   [junit4]   2> 294351 INFO  (qtp23172025-3326) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@62176e[collection1] main]
   [junit4]   2> 294353 INFO  (qtp23172025-3326) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294354 INFO  (searcherExecutor-2047-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@62176e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.4.0):C2) Uninverting(_2(6.4.0):c231)))}
   [junit4]   2> 294354 INFO  (qtp23172025-3326) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 106
   [junit4]   2> 294371 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/admin/luke params={wt=javabin&version=2} status=0 QTime=9
   [junit4]   2> 294375 INFO  (qtp9734425-3343) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/admin/luke params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 294379 INFO  (qtp10877728-3361) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/admin/luke params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 294383 INFO  (qtp14992031-3383) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/admin/luke params={wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 294387 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.SolrCmdDistributor java.net.ConnectException
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients.exception(MockStreamingSolrClients.java:52)
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients.access$100(MockStreamingSolrClients.java:29)
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients$MockSolrClient.request(MockStreamingSolrClients.java:74)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.doRequest(SolrCmdDistributor.java:293)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.submit(SolrCmdDistributor.java:286)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.distribAdd(SolrCmdDistributor.java:209)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.distribAdd(SolrCmdDistributor.java:195)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributorTest.testMaxRetries(SolrCmdDistributorTest.java:357)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributorTest.test(SolrCmdDistributorTest.java:326)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2> 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
   [junit4]   2> 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 294391 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.SolrCmdDistributor forwarding update to http://127.0.0.1:51157/_q/h/collection1/ failed - retrying ... retries: 1 add{,id=(null)} params: rsp:-1:java.net.ConnectException
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients.exception(MockStreamingSolrClients.java:52)
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients.access$100(MockStreamingSolrClients.java:29)
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients$MockSolrClient.request(MockStreamingSolrClients.java:74)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.doRequest(SolrCmdDistributor.java:293)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.submit(SolrCmdDistributor.java:286)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.distribAdd(SolrCmdDistributor.java:209)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.distribAdd(SolrCmdDistributor.java:195)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributorTest.testMaxRetries(SolrCmdDistributorTest.java:357)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributorTest.test(SolrCmdDistributorTest.java:326)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2> 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
   [junit4]   2> 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 294393 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.SolrCmdDistributor java.net.ConnectException
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients.exception(MockStreamingSolrClients.java:52)
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients.access$100(MockStreamingSolrClients.java:29)
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients$MockSolrClient.request(MockStreamingSolrClients.java:74)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.doRequest(SolrCmdDistributor.java:293)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.submit(SolrCmdDistributor.java:286)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.doRetriesIfNeeded(SolrCmdDistributor.java:166)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:248)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:93)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributorTest.testMaxRetries(SolrCmdDistributorTest.java:358)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributorTest.test(SolrCmdDistributorTest.java:326)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2> 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
   [junit4]   2> 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 294393 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.u.SolrCmdDistributor forwarding update to http://127.0.0.1:51157/_q/h/collection1/ failed - retrying ... retries: 2 add{,id=(null)} params: rsp:-1:java.net.ConnectException
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients.exception(MockStreamingSolrClients.java:52)
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients.access$100(MockStreamingSolrClients.java:29)
   [junit4]   2> 	at org.apache.solr.update.MockStreamingSolrClients$MockSolrClient.request(MockStreamingSolrClients.java:74)
   [junit4]   2> 	at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.doRequest(SolrCmdDistributor.java:293)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.submit(SolrCmdDistributor.java:286)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.doRetriesIfNeeded(SolrCmdDistributor.java:166)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:248)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:93)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributorTest.testMaxRetries(SolrCmdDistributorTest.java:358)
   [junit4]   2> 	at org.apache.solr.update.SolrCmdDistributorTest.test(SolrCmdDistributorTest.java:326)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]   2> 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2> 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2> 	at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2> 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
   [junit4]   2> 	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2> 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2> 	at org.apache.lucene.util.TestRuleIgn

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


   [junit4]   2> 
   [junit4]   2> 294480 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 294480 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 294481 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 294481 INFO  (qtp23172025-3324) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/_q/h path=/update params={waitSearcher=true&openSearcher=true&commit=true&softCommit=false&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 0
   [junit4]   2> 294483 INFO  (qtp23172025-3323) [    x:collection1] o.a.s.c.S.Request [collection1]  webapp=/_q/h path=/select params={q=*:*&wt=javabin&version=2} hits=234 status=0 QTime=0
   [junit4]   2> 294484 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> 294485 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@1760450{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 294485 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=29722979
   [junit4]   2> 294487 INFO  (coreCloseExecutor-2085-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@22ded0
   [junit4]   2> 294509 INFO  (coreCloseExecutor-2085-thread-1) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 294509 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 294510 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@77922d{/_q/h,null,UNAVAILABLE}
   [junit4]   2> 294512 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@1bc5690{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 294512 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=11686333
   [junit4]   2> 294513 INFO  (coreCloseExecutor-2087-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1d15a3
   [junit4]   2> 294535 INFO  (coreCloseExecutor-2087-thread-1) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 294536 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 294536 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7a9142{/_q/h,null,UNAVAILABLE}
   [junit4]   2> 294539 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@1c4d6ec{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 294539 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=18756098
   [junit4]   2> 294539 INFO  (coreCloseExecutor-2089-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6741ab
   [junit4]   2> 294555 INFO  (coreCloseExecutor-2089-thread-1) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 294556 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 294556 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d1ace4{/_q/h,null,UNAVAILABLE}
   [junit4]   2> 294560 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@116e365{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 294561 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=24811136
   [junit4]   2> 294562 INFO  (coreCloseExecutor-2091-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1b2a3be
   [junit4]   2> 294577 INFO  (coreCloseExecutor-2091-thread-1) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 294578 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 294578 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d7b2a1{/_q/h,null,UNAVAILABLE}
   [junit4]   2> 294581 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@3ea060{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 294581 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=68245
   [junit4]   2> 294581 INFO  (coreCloseExecutor-2093-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@36a5
   [junit4]   2> 294603 INFO  (coreCloseExecutor-2093-thread-1) [    x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 294604 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 294604 INFO  (TEST-SolrCmdDistributorTest.test-seed#[D62C38592FB53F81]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d2cef4{/_q/h,null,UNAVAILABLE}
   [junit4]   2> 294610 INFO  (SUITE-SolrCmdDistributorTest-seed#[D62C38592FB53F81]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62), sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=es-AR, timezone=Australia/South
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_112 (32-bit)/cpus=3,threads=1,free=90693248,total=278659072
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrQueryResponse, TestReload, TestMacros, JsonLoaderTest, TestConfig, FullHLLTest, TestRangeQuery, HLLUtilTest, CollectionReloadTest, TestRTimerTree, TestManagedSchemaThreadSafety, AnalyticsQueryTest, SortByFunctionTest, TestConfigReload, EchoParamsTest, ChaosMonkeySafeLeaderTest, SpatialRPTFieldTypeTest, TestSolrCloudSnapshots, TestDefaultStatsCache, TestZkChroot, TestManagedStopFilterFactory, TestSolrQueryParser, TestDynamicFieldCollectionResource, SecurityConfHandlerTest, ManagedSchemaRoundRobinCloudTest, SolrMetricReporterTest, TestConfigSetsAPIZkFailure, LeaderElectionContextKeyTest, LoggingHandlerTest, TestFieldCacheSanityChecker, TestInfoStreamLogging, AsyncCallRequestStatusResponseTest, TestManagedSchema, WordBreakSolrSpellCheckerTest, DefaultValueUpdateProcessorTest, TestSolrDynamicMBean, TestSearchPerf, TolerantUpdateProcessorTest, UpdateRequestProcessorFactoryTest, TestCloudPseudoReturnFields, StatsReloadRaceTest, ShowFileRequestHandlerTest, TestBlendedInfixSuggestions, TestRestoreCore, TestFieldCollectionResource, TestDFRSimilarityFactory, TestMiniSolrCloudClusterSSL, ConnectionReuseTest, DistributedFacetPivotWhiteBoxTest, AnalysisErrorHandlingTest, TestCustomDocTransformer, OverriddenZkACLAndCredentialsProvidersTest, ExternalFileFieldSortTest, SolrCmdDistributorTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SolrCmdDistributorTest -Dtests.seed=D62C38592FB53F81 -Dtests.slow=true -Dtests.locale=es-AR -Dtests.timezone=Australia/South -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J1 | SolrCmdDistributorTest (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\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\collection1: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2\collection1
   [junit4]    >    C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001\shard2
   [junit4]    >    C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J1\temp\solr.update.SolrCmdDistributorTest_D62C38592FB53F81-001\tempDir-001
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([D62C38592FB53F81]:0)
   [junit4]    > 	at org.apache.lucene.util.IOUtils.rm(IOUtils.java:323)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [75/680 (1!)] on J1 in 7.05s, 1 test, 1 error <<< FAILURES!

[...truncated 56630 lines...]