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...]

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to