[JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.8.0_31) - Build # 4533 - Still Failing!

[Policeman Jenkins Server]

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4533/
Java: 32bit/jdk1.8.0_31 -client -XX:+UseSerialGC

2 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.core.TestSolrConfigHandler

Error Message:
Could not remove the following files (in the order of attempts):    
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf\params.json: 
java.nio.file.FileSystemException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf\params.json: The process 
cannot access the file because it is being used by another process.     
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf: 
java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf    
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1: 
java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1    
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010 

Stack Trace:
java.io.IOException: Could not remove the following files (in the order of 
attempts):
   
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf\params.json: 
java.nio.file.FileSystemException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf\params.json: The process 
cannot access the file because it is being used by another process.

   
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf: 
java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf
   
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1: 
java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1
   
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010

        at __randomizedtesting.SeedInfo.seed([DC8D5A670BAEDE0]:0)
        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:286)
        at 
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:200)
        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:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.cloud.ReplicationFactorTest.test

Error Message:
org.apache.http.NoHttpResponseException: The target server failed to respond

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: 
org.apache.http.NoHttpResponseException: The target server failed to respond
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:901)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:754)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
        at 
org.apache.solr.cloud.ReplicationFactorTest.testRf3(ReplicationFactorTest.java:284)
        at 
org.apache.solr.cloud.ReplicationFactorTest.test(ReplicationFactorTest.java:112)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:483)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:958)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:933)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)
Caused by: org.apache.http.NoHttpResponseException: The target server failed to 
respond
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260)
        at 
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
        at 
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
        at 
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123)
        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682)
        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486)
        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:461)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:211)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:207)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:370)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient$2.call(CloudSolrClient.java:568)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient$2.call(CloudSolrClient.java:565)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        ... 1 more




Build Log:
[...truncated 10081 lines...]
   [junit4] Suite: org.apache.solr.cloud.ReplicationFactorTest
   [junit4]   2> Creating dataDir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\init-core-data-001
   [junit4]   2> 4603467 T19320 
oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system 
property: /xgp/ep
   [junit4]   2> 4603492 T19320 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   1> client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 4603493 T19321 oasc.ZkTestServer$ZKServerMain.runFromConfig 
Starting server
   [junit4]   2> 4603579 T19320 oasc.ZkTestServer.run start zk server on 
port:50995
   [junit4]   2> 4603579 T19320 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 4603582 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4603587 T19328 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@a1b24 name:ZooKeeperConnection 
Watcher:127.0.0.1:50995 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 4603588 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4603589 T19320 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 4603589 T19320 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 4603597 T19320 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 4603600 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4603603 T19331 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@e527f5 name:ZooKeeperConnection 
Watcher:127.0.0.1:50995/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 4603604 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4603605 T19320 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 4603605 T19320 oascc.SolrZkClient.makePath makePath: 
/collections/collection1
   [junit4]   2> 4603615 T19320 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/shards
   [junit4]   2> 4603619 T19320 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection
   [junit4]   2> 4603622 T19320 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/shards
   [junit4]   2> 4603626 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 4603627 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.xml
   [junit4]   2> 4603633 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 4603633 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/schema.xml
   [junit4]   2> 4603644 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 4603645 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 4603651 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 4603652 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/stopwords.txt
   [junit4]   2> 4603656 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 4603657 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/protwords.txt
   [junit4]   2> 4603662 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 4603662 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/currency.xml
   [junit4]   2> 4603669 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 4603670 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/enumsConfig.xml
   [junit4]   2> 4603675 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 4603676 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/open-exchange-rates.json
   [junit4]   2> 4603680 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 4603682 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 4603689 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 4603690 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/old_synonyms.txt
   [junit4]   2> 4603694 T19320 oasc.AbstractZkTestCase.putConfig put 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 4603695 T19320 oascc.SolrZkClient.makePath makePath: 
/configs/conf1/synonyms.txt
   [junit4]   2> 4605356 T19320 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1
   [junit4]   2> 4605368 T19320 oejs.Server.doStart jetty-9.2.9.v20150224
   [junit4]   2> 4605375 T19320 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@15942f0{/xgp/ep,null,AVAILABLE}
   [junit4]   2> 4605380 T19320 oejs.AbstractConnector.doStart Started 
ServerConnector@6b0c61{HTTP/1.1}{127.0.0.1:51003}
   [junit4]   2> 4605380 T19320 oejs.Server.doStart Started @4621203ms
   [junit4]   2> 4605380 T19320 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\tempDir-001/control/data, hostContext=/xgp/ep, 
hostPort=51002, 
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores}
   [junit4]   2> 4605382 T19320 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@387f44
   [junit4]   2> 4605382 T19320 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\'
   [junit4]   2> 4605433 T19320 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\solr.xml
   [junit4]   2> 4605446 T19320 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores
   [junit4]   2> 4605446 T19320 oasc.CoreContainer.<init> New CoreContainer 
2065689
   [junit4]   2> 4605446 T19320 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\]
   [junit4]   2> 4605446 T19320 oasc.CoreContainer.load loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\lib
   [junit4]   2> 4605449 T19320 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\lib).
   [junit4]   2> 4605464 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 4605464 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 4605464 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 4605464 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 4605464 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 4605464 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 4605468 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 4605468 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 4605468 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 4605468 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 4605469 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting useRetries to: false
   [junit4]   2> 4605470 T19320 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 4605470 T19320 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 4605470 T19320 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 4605470 T19320 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 4605470 T19320 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:50995/solr
   [junit4]   2> 4605470 T19320 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 4605473 T19320 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 4605474 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4605479 T19345 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@107555a name:ZooKeeperConnection 
Watcher:127.0.0.1:50995 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 4605479 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4605480 T19320 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 4605484 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4605488 T19348 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@6cb2ec name:ZooKeeperConnection 
Watcher:127.0.0.1:50995/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 4605488 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4605493 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer/queue
   [junit4]   2> 4605499 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-queue-work
   [junit4]   2> 4605504 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-running
   [junit4]   2> 4605509 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-completed
   [junit4]   2> 4605513 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer/collection-map-failure
   [junit4]   2> 4605519 T19320 oascc.SolrZkClient.makePath makePath: 
/live_nodes
   [junit4]   2> 4605522 T19320 oasc.ZkController.createEphemeralLiveNode 
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51002_xgp%2Fep
   [junit4]   2> 4605523 T19320 oascc.SolrZkClient.makePath makePath: 
/live_nodes/127.0.0.1:51002_xgp%2Fep
   [junit4]   2> 4605528 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer_elect
   [junit4]   2> 4605532 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer_elect/election
   [junit4]   2> 4605535 T19320 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 4605538 T19320 oasc.OverseerElectionContext.runLeaderProcess I 
am going to be the leader 127.0.0.1:51002_xgp%2Fep
   [junit4]   2> 4605539 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer_elect/leader
   [junit4]   2> 4605542 T19320 oasc.Overseer.start Overseer 
(id=93444336996253699-127.0.0.1:51002_xgp%2Fep-n_0000000000) starting
   [junit4]   2> 4605547 T19320 oascc.SolrZkClient.makePath makePath: 
/overseer/queue-work
   [junit4]   2> 4605562 T19320 oasc.OverseerAutoReplicaFailoverThread.<init> 
Starting OverseerAutoReplicaFailoverThread 
autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 4605564 T19349 oasc.Overseer$ClusterStateUpdater.run Starting 
to work on the main queue
   [junit4]   2> 4605565 T19350 oasc.OverseerCollectionProcessor.run Process 
current queue of collection creations
   [junit4]   2> 4605565 T19320 oascc.SolrZkClient.makePath makePath: 
/clusterstate.json
   [junit4]   2> 4605570 T19320 oascc.SolrZkClient.makePath makePath: 
/aliases.json
   [junit4]   2> 4605573 T19320 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 4605582 T19320 oasc.CorePropertiesLocator.discover Looking for 
core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores
   [junit4]   1> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, 
transient=false, schema=schema.xml, loadOnStartup=true, 
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1, 
collection=control_collection, 
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\, coreNodeName=, 
dataDir=data\, shard=}
   [junit4]   2> 4605584 T19320 oasc.CorePropertiesLocator.discoverUnder Found 
core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\
   [junit4]   2> 4605584 T19320 oasc.CorePropertiesLocator.discover Found 1 
core definitions
   [junit4]   2> 4605588 T19352 oasc.ZkController.publish publishing 
core=collection1 state=down collection=control_collection
   [junit4]   2> 4605588 T19352 oasc.ZkController.publish numShards not found 
on descriptor - reading it from system property
   [junit4]   2> 4605590 T19352 oasc.ZkController.waitForCoreNodeName look for 
our core node name
   [junit4]   2> 4605590 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4605592 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51002/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51002_xgp%2Fep",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state"} current state version: 0
   [junit4]   2> 4605593 T19349 oasco.ReplicaMutator.updateState Update state 
numShards=1 message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51002/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51002_xgp%2Fep",
   [junit4]   2>          "numShards":"1",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 4605594 T19349 oasco.ClusterStateMutator.createCollection 
building a new cName: control_collection
   [junit4]   2> 4605594 T19349 oasco.ReplicaMutator.updateState Assigning new 
node to shard shard=shard1
   [junit4]   2> 4605596 T19348 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4606449 T19352 oasc.ZkController.waitForShardId waiting to 
find shard id in clusterstate for collection1
   [junit4]   2> 4606449 T19352 oasc.ZkController.createCollectionZkNode Check 
for collection zkNode:control_collection
   [junit4]   2> 4606450 T19352 oasc.ZkController.createCollectionZkNode 
Collection zkNode exists
   [junit4]   2> 4606451 T19352 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/control_collection
   [junit4]   2> 4606452 T19352 oascc.ZkStateReader.readConfigName 
path=/collections/control_collection configName=conf1 specified config exists 
in ZooKeeper
   [junit4]   2> 4606452 T19352 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\'
   [junit4]   2> 4606489 T19352 oasc.ZkController.watchZKConfDir watch zkdir 
/configs/conf1
   [junit4]   2> 4606494 T19352 oasc.Config.<init> loaded config solrconfig.xml 
with version 0 
   [junit4]   2> 4606511 T19352 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 4606516 T19352 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 6.0.0
   [junit4]   2> 4606547 T19352 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 4606550 T19352 oass.IndexSchema.readSchema Reading Solr Schema 
from /configs/conf1/schema.xml
   [junit4]   2> 4606564 T19352 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 4606726 T19352 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 4606736 T19352 oass.IndexSchema.readSchema default search 
field in schema is text
   [junit4]   2> 4606740 T19352 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 4606765 T19352 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 4606770 T19352 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 4606774 T19352 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 4606775 T19352 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 4606776 T19352 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 4606776 T19352 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 4606779 T19352 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 4606779 T19352 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 4606780 T19352 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from collection control_collection
   [junit4]   2> 4606780 T19352 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 4606781 T19352 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\, 
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\data\
   [junit4]   2> 4606781 T19352 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@12f28cd
   [junit4]   2> 4606782 T19352 oasc.CachingDirectoryFactory.get return new 
directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\data\
   [junit4]   2> 4606782 T19352 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\data\index/
   [junit4]   2> 4606783 T19352 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\data\index' doesn't exist. 
Creating new index...
   [junit4]   2> 4606783 T19352 oasc.CachingDirectoryFactory.get return new 
directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\control-001\cores\collection1\data\index
   [junit4]   2> 4606784 T19352 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=57.8251953125, 
floorSegmentMB=1.5791015625, forceMergeDeletesPctAllowed=14.212839082535151, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2988005972702946
   [junit4]   2> 4606785 T19352 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@3871bc 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@161cb94),segFN=segments_1,generation=1}
   [junit4]   2> 4606785 T19352 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4606792 T19352 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 4606793 T19352 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 4606794 T19352 oasup.UpdateRequestProcessorChain.init 
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 4606794 T19352 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 4606794 T19352 oasup.UpdateRequestProcessorChain.init 
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 4606795 T19352 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 4606796 T19352 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 4606796 T19352 oasup.UpdateRequestProcessorChain.init 
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 4606796 T19352 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 4606802 T19352 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4606805 T19352 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4606808 T19352 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4606810 T19352 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4606817 T19352 oasc.RequestHandlers.initHandlersFromConfig 
Registered paths: 
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 4606818 T19352 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 4606819 T19352 oasu.UpdateHandler.<init> Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 4606819 T19352 oasu.UpdateLog.init Initializing UpdateLog: 
dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 4606821 T19352 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 4606821 T19352 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 4606822 T19352 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=15.75, 
floorSegmentMB=1.177734375, forceMergeDeletesPctAllowed=15.115013245469152, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5023377285072776
   [junit4]   2> 4606823 T19352 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@3871bc 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@161cb94),segFN=segments_1,generation=1}
   [junit4]   2> 4606823 T19352 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4606823 T19352 oass.SolrIndexSearcher.<init> Opening 
Searcher@2c391c[collection1] main
   [junit4]   2> 4606824 T19352 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/control_collection
   [junit4]   2> 4606826 T19352 oascc.ZkStateReader.readConfigName 
path=/collections/control_collection configName=conf1 specified config exists 
in ZooKeeper
   [junit4]   2> 4606826 T19352 oasr.ManagedResourceStorage.newStorageIO 
Setting up ZooKeeper-based storage for the RestManager with znodeBase: 
/configs/conf1
   [junit4]   2> 4606827 T19352 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 4606827 T19352 oasr.RestManager.init Initializing RestManager 
with initArgs: {}
   [junit4]   2> 4606827 T19352 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 4606830 T19352 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 4606830 T19352 oasr.ManagedResourceStorage.load Loaded null at 
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 4606830 T19352 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 4606831 T19352 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 4606831 T19352 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 4606832 T19353 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@2c391c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 4606833 T19356 oasc.ZkController.register Register replica - 
core:collection1 address:http://127.0.0.1:51002/xgp/ep 
collection:control_collection shard:shard1
   [junit4]   2> 4606833 T19320 oass.SolrDispatchFilter.init 
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 4606834 T19320 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 4606834 T19356 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 4606834 T19320 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 4606837 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4606839 T19360 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@f87942 name:ZooKeeperConnection 
Watcher:127.0.0.1:50995/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 4606840 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4606841 T19320 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 4606844 T19320 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 4606845 T19356 
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for 
shard shard1
   [junit4]   2> 4606849 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4606851 T19356 
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found 
to continue.
   [junit4]   2> 4606851 T19356 
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try 
and sync
   [junit4]   2> ASYNC  NEW_CORE C6702 name=collection1 
org.apache.solr.core.SolrCore@1d26cc6 
url=http://127.0.0.1:51002/xgp/ep/collection1 node=127.0.0.1:51002_xgp%2Fep 
C6702_STATE=coll:control_collection core:collection1 props:{core=collection1, 
base_url=http://127.0.0.1:51002/xgp/ep, node_name=127.0.0.1:51002_xgp%2Fep, 
state=down}
   [junit4]   2> 4606851 T19356 C6702 P51002 oasc.SyncStrategy.sync Sync 
replicas to http://127.0.0.1:51002/xgp/ep/collection1/
   [junit4]   2> 4606852 T19356 C6702 P51002 oasc.SyncStrategy.syncReplicas 
Sync Success - now sync replicas to me
   [junit4]   2> 4606853 T19356 C6702 P51002 oasc.SyncStrategy.syncToMe 
http://127.0.0.1:51002/xgp/ep/collection1/ has no replicas
   [junit4]   2> 4606853 T19356 
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: 
http://127.0.0.1:51002/xgp/ep/collection1/ shard1
   [junit4]   2> 4606854 T19356 oascc.SolrZkClient.makePath makePath: 
/collections/control_collection/leaders/shard1
   [junit4]   2> 4606853 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection"} current state 
version: 1
   [junit4]   2> 4606854 T19320 oasc.ChaosMonkey.monkeyLog monkey: init - 
expire sessions:false cause connection loss:false
   [junit4]   2> 4606855 T19320 oasc.AbstractFullDistribZkTestBase.createJettys 
Creating collection1 with stateFormat=2
   [junit4]   2> 4606855 T19320 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 4606857 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4606862 T19363 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@7de5c2 name:ZooKeeperConnection 
Watcher:127.0.0.1:50995/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 4606863 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4606864 T19320 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 4606867 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4606870 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"create",
   [junit4]   2>          "name":"collection1",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "stateFormat":"2"} current state version: 1
   [junit4]   2> 4606871 T19349 oasco.ClusterStateMutator.createCollection 
building a new cName: collection1
   [junit4]   2> 4606876 T19348 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4606877 T19360 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4606898 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "base_url":"http://127.0.0.1:51002/xgp/ep";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 2
   [junit4]   2> 4606899 T19349 oasco.ZkStateWriter.writePendingUpdates going 
to create_collection /collections/collection1/state.json
   [junit4]   2> 4606903 T19348 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4606905 T19360 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4606914 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4606917 T19360 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4606918 T19348 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4606983 T19356 oasc.ZkController.register We are 
http://127.0.0.1:51002/xgp/ep/collection1/ and leader is 
http://127.0.0.1:51002/xgp/ep/collection1/
   [junit4]   2> 4606983 T19356 oasc.ZkController.register No LogReplay needed 
for core=collection1 baseURL=http://127.0.0.1:51002/xgp/ep
   [junit4]   2> 4606983 T19356 oasc.ZkController.checkRecovery I am the 
leader, no recovery necessary
   [junit4]   2> 4606983 T19356 oasc.ZkController.publish publishing 
core=collection1 state=active collection=control_collection
   [junit4]   2> 4606983 T19356 oasc.ZkController.publish numShards not found 
on descriptor - reading it from system property
   [junit4]   2> 4606985 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4606987 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51002/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51002_xgp%2Fep",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state"} current state version: 4
   [junit4]   2> 4606988 T19349 oasco.ReplicaMutator.updateState Update state 
numShards=3 message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51002/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51002_xgp%2Fep",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "shard":"shard1",
   [junit4]   2>          "collection":"control_collection",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 4607088 T19348 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4607089 T19360 oascc.ZkStateReader$2.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 4608492 T19320 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1
   [junit4]   2> 4608495 T19320 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 1 in directory 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001
   [junit4]   2> 4608497 T19320 oejs.Server.doStart jetty-9.2.9.v20150224
   [junit4]   2> 4608502 T19320 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@1ff3b19{/xgp/ep,null,AVAILABLE}
   [junit4]   2> 4608503 T19320 oejs.AbstractConnector.doStart Started 
ServerConnector@b146b0{HTTP/1.1}{127.0.0.1:51019}
   [junit4]   2> 4608503 T19320 oejs.Server.doStart Started @4624683ms
   [junit4]   2> 4608503 T19320 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\tempDir-001/jetty1, solrconfig=solrconfig.xml, 
hostContext=/xgp/ep, hostPort=51018, 
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores}
   [junit4]   2> 4608504 T19320 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@387f44
   [junit4]   2> 4608504 T19320 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\'
   [junit4]   2> 4608544 T19320 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\solr.xml
   [junit4]   2> 4608558 T19320 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores
   [junit4]   2> 4608558 T19320 oasc.CoreContainer.<init> New CoreContainer 
20824199
   [junit4]   2> 4608558 T19320 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\]
   [junit4]   2> 4608559 T19320 oasc.CoreContainer.load loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\lib
   [junit4]   2> 4608559 T19320 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\lib).
   [junit4]   2> 4608574 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 4608574 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 4608575 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 4608575 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 4608575 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 4608576 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 4608576 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 4608576 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 4608577 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 4608577 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 4608577 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting useRetries to: false
   [junit4]   2> 4608577 T19320 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 4608577 T19320 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 4608577 T19320 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 4608577 T19320 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 4608577 T19320 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:50995/solr
   [junit4]   2> 4608578 T19320 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 4608579 T19320 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 4608581 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4608585 T19377 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@adb1c5 name:ZooKeeperConnection 
Watcher:127.0.0.1:50995 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 4608587 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4608587 T19320 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 4608590 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4608593 T19380 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@91e0c5 name:ZooKeeperConnection 
Watcher:127.0.0.1:50995/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 4608593 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4608610 T19320 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 4609558 T19320 oasc.ZkController.createEphemeralLiveNode 
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51018_xgp%2Fep
   [junit4]   2> 4609562 T19320 oascc.SolrZkClient.makePath makePath: 
/live_nodes/127.0.0.1:51018_xgp%2Fep
   [junit4]   2> 4609576 T19320 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 4609582 T19320 oasc.CorePropertiesLocator.discover Looking for 
core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores
   [junit4]   1> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, 
transient=false, schema=schema.xml, loadOnStartup=true, 
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1, collection=collection1, 
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\, coreNodeName=, 
dataDir=data\, shard=}
   [junit4]   2> 4609584 T19320 oasc.CorePropertiesLocator.discoverUnder Found 
core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\
   [junit4]   2> 4609584 T19320 oasc.CorePropertiesLocator.discover Found 1 
core definitions
   [junit4]   2> 4609590 T19381 oasc.ZkController.publish publishing 
core=collection1 state=down collection=collection1
   [junit4]   2> 4609590 T19381 oasc.ZkController.publish numShards not found 
on descriptor - reading it from system property
   [junit4]   2> 4609594 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4609596 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51018/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51018_xgp%2Fep",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"} current state version: 5
   [junit4]   2> 4609597 T19381 oasc.ZkController.preRegister Registering watch 
for external collection collection1
   [junit4]   2> 4609597 T19381 oascc.ZkStateReader.addZkWatch addZkWatch 
collection1
   [junit4]   2> 4609597 T19349 oasco.ReplicaMutator.updateState Update state 
numShards=3 message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51018/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51018_xgp%2Fep",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 4609597 T19349 oasco.ReplicaMutator.updateState Collection 
already exists with numShards=3
   [junit4]   2> 4609598 T19381 oascc.ZkStateReader.addZkWatch Updating 
collection state at /collections/collection1/state.json from ZooKeeper... 
   [junit4]   2> 4609598 T19349 oasco.ReplicaMutator.updateState Assigning new 
node to shard shard=shard2
   [junit4]   2> 4609601 T19381 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 0 
   [junit4]   2> 4609601 T19381 oasc.ZkController.waitForCoreNodeName look for 
our core node name
   [junit4]   2> 4609603 T19349 oasco.ZkStateWriter.writePendingUpdates going 
to update_collection /collections/collection1/state.json version: 0
   [junit4]   2> 4609604 T19380 oascc.ZkStateReader$7.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 4609606 T19380 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 1 
   [junit4]   2> 4610538 T19381 oasc.ZkController.waitForShardId waiting to 
find shard id in clusterstate for collection1
   [junit4]   2> 4610538 T19381 oasc.ZkController.createCollectionZkNode Check 
for collection zkNode:collection1
   [junit4]   2> 4610541 T19381 oasc.ZkController.createCollectionZkNode 
Collection zkNode exists
   [junit4]   2> 4610541 T19381 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/collection1
   [junit4]   2> 4610544 T19381 oascc.ZkStateReader.readConfigName 
path=/collections/collection1 configName=conf1 specified config exists in 
ZooKeeper
   [junit4]   2> 4610545 T19381 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\'
   [junit4]   2> 4610598 T19381 oasc.ZkController.watchZKConfDir watch zkdir 
/configs/conf1
   [junit4]   2> 4610603 T19381 oasc.Config.<init> loaded config solrconfig.xml 
with version 0 
   [junit4]   2> 4610616 T19381 oasc.SolrConfig.refreshRequestParams current 
version of requestparams : -1
   [junit4]   2> 4610626 T19381 oasc.SolrConfig.<init> Using Lucene 
MatchVersion: 6.0.0
   [junit4]   2> 4610644 T19381 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 4610648 T19381 oass.IndexSchema.readSchema Reading Solr Schema 
from /configs/conf1/schema.xml
   [junit4]   2> 4610658 T19381 oass.IndexSchema.readSchema [collection1] 
Schema name=test
   [junit4]   2> 4610817 T19381 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 4610825 T19381 oass.IndexSchema.readSchema default search 
field in schema is text
   [junit4]   2> 4610826 T19381 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 4610846 T19381 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 4610851 T19381 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 4610855 T19381 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 4610857 T19381 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 4610857 T19381 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 4610858 T19381 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 4610860 T19381 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 4610860 T19381 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 4610860 T19381 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from collection collection1
   [junit4]   2> 4610860 T19381 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 4610861 T19381 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\, 
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\data\
   [junit4]   2> 4610862 T19381 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@12f28cd
   [junit4]   2> 4610862 T19381 oasc.CachingDirectoryFactory.get return new 
directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\data\
   [junit4]   2> 4610862 T19381 oasc.SolrCore.getNewIndexDir New index 
directory detected: old=null 
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\data\index/
   [junit4]   2> 4610862 T19381 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\data\index' doesn't exist. 
Creating new index...
   [junit4]   2> 4610863 T19381 oasc.CachingDirectoryFactory.get return new 
directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-1-001\cores\collection1\data\index
   [junit4]   2> 4610863 T19381 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=57.8251953125, 
floorSegmentMB=1.5791015625, forceMergeDeletesPctAllowed=14.212839082535151, 
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2988005972702946
   [junit4]   2> 4610864 T19381 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@12e2758 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@19f07bc),segFN=segments_1,generation=1}
   [junit4]   2> 4610865 T19381 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4610873 T19381 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 4610873 T19381 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 4610873 T19381 oasup.UpdateRequestProcessorChain.init 
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 4610873 T19381 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 4610874 T19381 oasup.UpdateRequestProcessorChain.init 
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 4610874 T19381 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 4610875 T19381 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 4610876 T19381 oasup.UpdateRequestProcessorChain.init 
inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 4610877 T19381 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 4610884 T19381 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4610889 T19381 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4610894 T19381 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4610898 T19381 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 4610918 T19381 oasc.RequestHandlers.initHandlersFromConfig 
Registered paths: 
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 4610919 T19381 oasc.SolrCore.initStatsCache Using default 
statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 4610921 T19381 oasu.UpdateHandler.<init> Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 4610921 T19381 oasu.UpdateLog.init Initializing UpdateLog: 
dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 4610921 T19381 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 4610921 T19381 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 4610925 T19381 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=41, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=15.75, 
floorSegmentMB=1.177734375, forceMergeDeletesPctAllowed=15.115013245469152, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.5023377285072776
   [junit4]   2> 4610926 T19381 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=MockDirectoryWrapper(RAMDirectory@12e2758 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@19f07bc),segFN=segments_1,generation=1}
   [junit4]   2> 4610927 T19381 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 4610927 T19381 oass.SolrIndexSearcher.<init> Opening 
Searcher@169000d[collection1] main
   [junit4]   2> 4610928 T19381 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/collection1
   [junit4]   2> 4610930 T19381 oascc.ZkStateReader.readConfigName 
path=/collections/collection1 configName=conf1 specified config exists in 
ZooKeeper
   [junit4]   2> 4610931 T19381 oasr.ManagedResourceStorage.newStorageIO 
Setting up ZooKeeper-based storage for the RestManager with znodeBase: 
/configs/conf1
   [junit4]   2> 4610932 T19381 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 4610932 T19381 oasr.RestManager.init Initializing RestManager 
with initArgs: {}
   [junit4]   2> 4610932 T19381 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 4610935 T19381 
oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 4610935 T19381 oasr.ManagedResourceStorage.load Loaded null at 
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 4610936 T19381 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 4610936 T19381 oash.ReplicationHandler.inform Commits will be 
reserved for  10000
   [junit4]   2> 4610936 T19381 oasc.CoreContainer.registerCore registering 
core: collection1
   [junit4]   2> 4610937 T19382 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@169000d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 4610939 T19385 oasc.ZkController.register Register replica - 
core:collection1 address:http://127.0.0.1:51018/xgp/ep collection:collection1 
shard:shard2
   [junit4]   2> 4610940 T19320 oass.SolrDispatchFilter.init 
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 4610940 T19320 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 4610942 T19385 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leader_elect/shard2/election
   [junit4]   2> 4610962 T19385 
oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for 
shard shard2
   [junit4]   2> 4610966 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4610968 T19385 
oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found 
to continue.
   [junit4]   2> 4610968 T19385 
oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try 
and sync
   [junit4]   2> ASYNC  NEW_CORE C6703 name=collection1 
org.apache.solr.core.SolrCore@ea7f58 
url=http://127.0.0.1:51018/xgp/ep/collection1 node=127.0.0.1:51018_xgp%2Fep 
C6703_STATE=coll:collection1 core:collection1 props:{core=collection1, 
base_url=http://127.0.0.1:51018/xgp/ep, node_name=127.0.0.1:51018_xgp%2Fep, 
state=down}
   [junit4]   2> 4610968 T19385 C6703 P51018 oasc.SyncStrategy.sync Sync 
replicas to http://127.0.0.1:51018/xgp/ep/collection1/
   [junit4]   2> 4610968 T19385 C6703 P51018 oasc.SyncStrategy.syncReplicas 
Sync Success - now sync replicas to me
   [junit4]   2> 4610968 T19385 C6703 P51018 oasc.SyncStrategy.syncToMe 
http://127.0.0.1:51018/xgp/ep/collection1/ has no replicas
   [junit4]   2> 4610968 T19385 
oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: 
http://127.0.0.1:51018/xgp/ep/collection1/ shard2
   [junit4]   2> 4610969 T19385 oascc.SolrZkClient.makePath makePath: 
/collections/collection1/leaders/shard2
   [junit4]   2> 4610973 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard2",
   [junit4]   2>          "collection":"collection1"} current state version: 5
   [junit4]   2> 4610976 T19349 oasco.ZkStateWriter.writePendingUpdates going 
to update_collection /collections/collection1/state.json version: 1
   [junit4]   2> 4610979 T19380 oascc.ZkStateReader$7.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 4610979 T19380 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 2 
   [junit4]   2> 4610989 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "operation":"leader",
   [junit4]   2>          "shard":"shard2",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "base_url":"http://127.0.0.1:51018/xgp/ep";,
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "state":"active"} current state version: 5
   [junit4]   2> 4610991 T19349 oasco.ZkStateWriter.writePendingUpdates going 
to update_collection /collections/collection1/state.json version: 2
   [junit4]   2> 4610993 T19380 oascc.ZkStateReader$7.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 4610994 T19380 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 3 
   [junit4]   2> 4610997 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4611036 T19385 oasc.ZkController.register We are 
http://127.0.0.1:51018/xgp/ep/collection1/ and leader is 
http://127.0.0.1:51018/xgp/ep/collection1/
   [junit4]   2> 4611036 T19385 oasc.ZkController.register No LogReplay needed 
for core=collection1 baseURL=http://127.0.0.1:51018/xgp/ep
   [junit4]   2> 4611036 T19385 oasc.ZkController.checkRecovery I am the 
leader, no recovery necessary
   [junit4]   2> 4611036 T19385 oasc.ZkController.publish publishing 
core=collection1 state=active collection=collection1
   [junit4]   2> 4611036 T19385 oasc.ZkController.publish numShards not found 
on descriptor - reading it from system property
   [junit4]   2> 4611039 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4611042 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51018/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51018_xgp%2Fep",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "shard":"shard2",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"} current state version: 5
   [junit4]   2> 4611049 T19349 oasco.ReplicaMutator.updateState Update state 
numShards=3 message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "core_node_name":"core_node1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51018/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51018_xgp%2Fep",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "state":"active",
   [junit4]   2>          "shard":"shard2",
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 4611053 T19349 oasco.ZkStateWriter.writePendingUpdates going 
to update_collection /collections/collection1/state.json version: 3
   [junit4]   2> 4611054 T19380 oascc.ZkStateReader$7.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 4611057 T19385 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 4 
   [junit4]   2> 4611059 T19380 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 4 
   [junit4]   2> 4612498 T19320 oas.SolrTestCaseJ4.writeCoreProperties Writing 
core.properties file to 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\cores\collection1
   [junit4]   2> 4612501 T19320 oasc.AbstractFullDistribZkTestBase.createJettys 
create jetty 2 in directory 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001
   [junit4]   2> 4612503 T19320 oejs.Server.doStart jetty-9.2.9.v20150224
   [junit4]   2> 4612509 T19320 oejsh.ContextHandler.doStart Started 
o.e.j.s.ServletContextHandler@bb9f7f{/xgp/ep,null,AVAILABLE}
   [junit4]   2> 4612511 T19320 oejs.AbstractConnector.doStart Started 
ServerConnector@1b6db14{HTTP/1.1}{127.0.0.1:51029}
   [junit4]   2> 4612512 T19320 oejs.Server.doStart Started @4629017ms
   [junit4]   2> 4612512 T19320 oascse.JettySolrRunner$1.lifeCycleStarted Jetty 
properties: 
{solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\tempDir-001/jetty2, solrconfig=solrconfig.xml, 
hostContext=/xgp/ep, hostPort=51028, 
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\cores}
   [junit4]   2> 4612512 T19320 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@387f44
   [junit4]   2> 4612512 T19320 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\'
   [junit4]   2> 4612560 T19320 oasc.SolrXmlConfig.fromFile Loading container 
configuration from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\solr.xml
   [junit4]   2> 4612572 T19320 oasc.CorePropertiesLocator.<init> 
Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\cores
   [junit4]   2> 4612573 T19320 oasc.CoreContainer.<init> New CoreContainer 
4608369
   [junit4]   2> 4612573 T19320 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\]
   [junit4]   2> 4612573 T19320 oasc.CoreContainer.load loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\lib
   [junit4]   2> 4612573 T19320 oasc.SolrResourceLoader.addToClassLoader WARN 
Can't find (or read) directory to add to classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\lib).
   [junit4]   2> 4612587 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 4612588 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: 
   [junit4]   2> 4612588 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 4612589 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 4612589 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnections to: 10000
   [junit4]   2> 4612589 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 4612589 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 4612590 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 4612590 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 4612591 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 4612592 T19320 oashc.HttpShardHandlerFactory.getParameter 
Setting useRetries to: false
   [junit4]   2> 4612593 T19320 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 4612593 T19320 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 4612593 T19320 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 4612594 T19320 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 4612594 T19320 oasc.ZkContainer.initZooKeeper Zookeeper 
client=127.0.0.1:50995/solr
   [junit4]   2> 4612594 T19320 oasc.ZkController.checkChrootPath zkHost 
includes chroot
   [junit4]   2> 4612594 T19320 
oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default 
ZkCredentialsProvider
   [junit4]   2> 4612597 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4612600 T19400 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@fa7280 name:ZooKeeperConnection 
Watcher:127.0.0.1:50995 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 4612602 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4612603 T19320 oascc.SolrZkClient.createZkACLProvider Using 
default ZkACLProvider
   [junit4]   2> 4612607 T19320 oascc.ConnectionManager.waitForConnected 
Waiting for client to connect to ZooKeeper
   [junit4]   2> 4612610 T19403 oascc.ConnectionManager.process Watcher 
org.apache.solr.common.cloud.ConnectionManager@1c215e0 name:ZooKeeperConnection 
Watcher:127.0.0.1:50995/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 4612611 T19320 oascc.ConnectionManager.waitForConnected Client 
is connected to ZooKeeper
   [junit4]   2> 4612623 T19320 
oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 4613569 T19320 oasc.ZkController.createEphemeralLiveNode 
Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51028_xgp%2Fep
   [junit4]   2> 4613571 T19320 oascc.SolrZkClient.makePath makePath: 
/live_nodes/127.0.0.1:51028_xgp%2Fep
   [junit4]   2> 4613582 T19320 oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 4613589 T19320 oasc.CorePropertiesLocator.discover Looking for 
core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\cores
   [junit4]   1> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, 
transient=false, schema=schema.xml, loadOnStartup=true, 
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\cores\collection1, collection=collection1, 
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\cores\collection1\, coreNodeName=, 
dataDir=data\, shard=}
   [junit4]   2> 4613591 T19320 oasc.CorePropertiesLocator.discoverUnder Found 
core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\cores\collection1\
   [junit4]   2> 4613592 T19320 oasc.CorePropertiesLocator.discover Found 1 
core definitions
   [junit4]   2> 4613596 T19404 oasc.ZkController.publish publishing 
core=collection1 state=down collection=collection1
   [junit4]   2> 4613596 T19404 oasc.ZkController.publish numShards not found 
on descriptor - reading it from system property
   [junit4]   2> 4613599 T19348 oasc.DistributedQueue$LatchWatcher.process 
NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 4613602 T19349 oasc.Overseer$ClusterStateUpdater.run 
processMessage: queueSize: 1, message = {
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51028/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51028_xgp%2Fep",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"} current state version: 5
   [junit4]   2> 4613603 T19404 oasc.ZkController.preRegister Registering watch 
for external collection collection1
   [junit4]   2> 4613604 T19404 oascc.ZkStateReader.addZkWatch addZkWatch 
collection1
   [junit4]   2> 4613603 T19349 oasco.ReplicaMutator.updateState Update state 
numShards=3 message={
   [junit4]   2>          "core":"collection1",
   [junit4]   2>          "roles":null,
   [junit4]   2>          "base_url":"http://127.0.0.1:51028/xgp/ep";,
   [junit4]   2>          "node_name":"127.0.0.1:51028_xgp%2Fep",
   [junit4]   2>          "numShards":"3",
   [junit4]   2>          "state":"down",
   [junit4]   2>          "shard":null,
   [junit4]   2>          "collection":"collection1",
   [junit4]   2>          "operation":"state"}
   [junit4]   2> 4613604 T19349 oasco.ReplicaMutator.updateState Collection 
already exists with numShards=3
   [junit4]   2> 4613604 T19349 oasco.ReplicaMutator.updateState Assigning new 
node to shard shard=shard3
   [junit4]   2> 4613605 T19404 oascc.ZkStateReader.addZkWatch Updating 
collection state at /collections/collection1/state.json from ZooKeeper... 
   [junit4]   2> 4613607 T19349 oasco.ZkStateWriter.writePendingUpdates going 
to update_collection /collections/collection1/state.json version: 4
   [junit4]   2> 4613608 T19403 oascc.ZkStateReader$7.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 3)
   [junit4]   2> 4613608 T19380 oascc.ZkStateReader$7.process A cluster state 
change: WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 3)
   [junit4]   2> 4613609 T19404 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 5 
   [junit4]   2> 4613609 T19404 oasc.ZkController.waitForCoreNodeName look for 
our core node name
   [junit4]   2> 4613610 T19404 oasc.ZkController.waitForShardId waiting to 
find shard id in clusterstate for collection1
   [junit4]   2> 4613610 T19404 oasc.ZkController.createCollectionZkNode Check 
for collection zkNode:collection1
   [junit4]   2> 4613610 T19380 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 5 
   [junit4]   2> 4613611 T19403 oascc.ZkStateReader.updateWatchedCollection 
Updating data for collection1 to ver 5 
   [junit4]   2> 4613612 T19404 oasc.ZkController.createCollectionZkNode 
Collection zkNode exists
   [junit4]   2> 4613612 T19404 oascc.ZkStateReader.readConfigName Load 
collection config from:/collections/collection1
   [junit4]   2> 4613615 T19404 oascc.ZkStateReader.readConfigName 
path=/collections/collection1 configName=conf1 specified config exists in 
ZooKeeper
   [junit4]   2> 4613615 T19404 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ReplicationFactorTest
 DC8D5A670BAEDE0-001\shard-2-001\cores\collection1\'
   [junit4]   2> 4613641 T19404 oasc.ZkController.watchZKConfDir watch zkdir 
/configs/conf1
   [junit4]   2> 4613645 T19404 oasc.Config.<in

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

dlerTest, TestConfigOverlay, CacheHeaderTest, DateFieldTest, 
DocumentAnalysisRequestHandlerTest, SolrXmlInZkTest, TestCollapseQParserPlugin, 
ResponseHeaderTest, TestExtendedDismaxParser, StandardRequestHandlerTest, 
TestConfigSets, PluginInfoTest, TestBM25SimilarityFactory, TestLazyCores, 
TestSuggestSpellingConverter, TestReplicationHandler, CSVRequestHandlerTest, 
TestMiniSolrCloudClusterSSL, TestConfigReload, TestSimpleTrackingShardHandler, 
OutputWriterTest, HdfsChaosMonkeySafeLeaderTest, TestReplicationHandlerBackup, 
TestSchemaSimilarityResource, TestDynamicLoading, OverseerRolesTest, 
TestRangeQuery, CurrencyFieldXmlFileTest, DistanceFunctionTest, 
TestDistribDocBasedVersion, TestBinaryField, PathHierarchyTokenizerFactoryTest, 
DeleteInactiveReplicaTest, TestRandomDVFaceting, AliasIntegrationTest, 
MultiThreadedOCPTest, TestImplicitCoreProperties, TestSolrDynamicMBean, 
TestCollectionAPI, TestSolrConfigHandlerConcurrent, TestFileDictionaryLookup, 
TestWordDelimiterFilterFactory, TestHighlightDedupGrouping, 
DirectSolrConnectionTest, TestSystemIdResolver, DistributedExpandComponentTest, 
FacetPivotSmallTest, DocValuesTest, TestFaceting, CoreAdminRequestStatusTest, 
AnalyticsQueryTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, 
SignatureUpdateProcessorFactoryTest, DirectUpdateHandlerTest, 
TestManagedStopFilterFactory, MoreLikeThisHandlerTest, TestCloudManagedSchema, 
SpellingQueryConverterTest, TestPhraseSuggestions, TestRestManager, 
LoggingHandlerTest, PolyFieldTest, TestSort, TestReloadAndDeleteDocs, 
ChaosMonkeyNothingIsSafeTest, AnalysisErrorHandlingTest, TestCoreContainer, 
TestFiltering, TestPostingsSolrHighlighter, ShowFileRequestHandlerTest, 
SortByFunctionTest, BinaryUpdateRequestHandlerTest, ShardRoutingCustomTest, 
SolrInfoMBeanTest, TestCloudInspectUtil, TestJmxMonitoredMap, TestRealTimeGet, 
ShardRoutingTest, TestLFUCache, TestBinaryResponseWriter, TestUpdate, 
TimeZoneUtilsTest, UnloadDistributedZkTest, TestInitParams, 
SimpleCollectionCreateDeleteTest, SimpleFacetsTest, 
SchemaVersionSpecificBehaviorTest, TestCloudPivotFacet, 
TestComplexPhraseQParserPlugin, TestMiniSolrCloudCluster, 
OverriddenZkACLAndCredentialsProvidersTest, TestStressVersions, 
ExitableDirectoryReaderTest, TestBulkSchemaConcurrent, DistributedQueueTest, 
UUIDFieldTest, TestElisionMultitermQuery, PreAnalyzedUpdateProcessorTest, 
TestStressRecovery, AssignTest, MinimalSchemaTest, TestStressUserVersions, 
DeleteShardTest, CustomCollectionTest, HdfsRecoveryZkTest, ZkSolrClientTest, 
RecoveryZkTest, ClusterStateUpdateTest, ChaosMonkeySafeLeaderTest, 
BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, SyncSliceTest, 
OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, 
BasicZkTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, 
LeaderElectionTest, TestZkChroot, ZkCLITest, TestDistributedSearch, 
TestRecovery, TestHashPartitioner, TestStressReorder, TestJoin, TestReload, 
TestSolr4Spatial, TestGroupingSearch, SolrCmdDistributorTest, PeerSyncTest, 
TestFunctionQuery, DistributedQueryElevationComponentTest, SimplePostToolTest, 
TestCoreDiscovery, SpellCheckCollatorTest, SuggesterFSTTest, 
CoreAdminHandlerTest, SuggesterTSTTest, SuggesterTest, TestStressLucene, 
TestTrie, SpatialFilterTest, SuggesterWFSTTest, NoCacheHeaderTest, 
WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, 
DirectUpdateHandlerOptimizeTest, TestRemoteStreaming, DocValuesMultiTest, 
XsltUpdateRequestHandlerTest, DebugComponentTest, IndexBasedSpellCheckerTest, 
DisMaxRequestHandlerTest, TestWriterPerf, TestReversedWildcardFilterFactory, 
TestQueryTypes, PrimitiveFieldTypeTest, TestOmitPositions, 
FileBasedSpellCheckerTest, TermsComponentTest, RequestHandlersTest, 
DocumentBuilderTest, TermVectorComponentTest, TestIndexingPerformance, 
TestSolrQueryParser, FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, 
RegexBoostProcessorTest, SolrPluginUtilsTest, TestJmxIntegration, 
ReturnFieldsTest, JSONWriterTest, MBeansHandlerTest, QueryParsingTest, 
TestAnalyzedSuggestions, JsonLoaderTest, TestPHPSerializedResponseWriter, 
PingRequestHandlerTest, TestQuerySenderListener, UpdateParamsTest, 
TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, 
ResponseLogComponentTest, SolrIndexConfigTest, TestMergePolicyConfig, 
TestSolrDeletionPolicy2, MultiTermTest, SampleTest, TestDocSet, TestSearchPerf, 
TestConfig, TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, 
NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestCodecSupport, 
SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, 
TestSweetSpotSimilarityFactory, TestDFRSimilarityFactory, 
TestPerFieldSimilarity, TestLMDirichletSimilarityFactory, 
TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, 
TestDefaultSimilarityFactory, ResourceLoaderTest, TestFastOutputStream, 
OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, PrimUtilsTest, 
DOMUtilTest, RAMDirectoryFactoryTest, ClusterStateTest, TestSolrJ, 
ZkNodePropsTest, FileUtilsTest, DistributedMLTComponentTest, TestRTGBase, 
CursorPagingTest, DistributedIntervalFacetingTest, SolrTestCaseJ4Test, 
TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestTolerantSearch, 
TestJettySolrRunner, ActionThrottleTest, AsyncMigrateRouteKeyTest, 
CloudExitableDirectoryReaderTest, DistribCursorPagingTest, 
DistribDocExpirationUpdateProcessorTest, DistribJoinFromCollectionTest, 
ExternalCollectionsTest, LeaderFailoverAfterPartitionTest, 
LeaderInitiatedRecoveryOnCommitTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
OverseerStatusTest, RecoveryAfterSoftCommitTest, RemoteQueryErrorTest, 
ReplicationFactorTest, RollingRestartTest, SSLMigrationTest, 
SaslZkACLProviderTest, ShardSplitTest, SharedFSAutoReplicaFailoverTest, 
SharedFSAutoReplicaFailoverUtilsTest, TestCryptoKeys, TestReplicaProperties, 
TestRequestStatusCollectionAPI, TestShortCircuitedRequests, 
TriLevelCompositeIdRoutingTest, HdfsBasicDistributedZkTest, 
HdfsCollectionsAPIDistributedZkTest, HdfsSyncSliceTest, 
HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, 
TestClusterStateMutator, ZkStateWriterTest, HdfsDirectoryFactoryTest, 
QueryResultKeyTest, TestShardHandlerFactory, TestSolrConfigHandler]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestSolrConfigHandler -Dtests.seed=DC8D5A670BAEDE0 -Dtests.slow=true 
-Dtests.locale=ca_ES -Dtests.timezone=America/Phoenix -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s | TestSolrConfigHandler (suite) <<<
   [junit4]    > Throwable #1: java.io.IOException: Could not remove the 
following files (in the order of attempts):
   [junit4]    >    
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf\params.json: 
java.nio.file.FileSystemException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf\params.json: The process 
cannot access the file because it is being used by another process.
   [junit4]    >    
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf: 
java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1\conf
   [junit4]    >    
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1: 
java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010\collection1
   [junit4]    >    
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010: java.nio.file.DirectoryNotEmptyException: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.core.TestSolrConfigHandler
 DC8D5A670BAEDE0-001\tempDir-010
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([DC8D5A670BAEDE0]:0)
   [junit4]    >        at org.apache.lucene.util.IOUtils.rm(IOUtils.java:286)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed in 14.84s, 4 tests, 1 error <<< FAILURES!

[...truncated 242 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:519: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39: 
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:191: 
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:510:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1351:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:958:
 There were test failures: 471 suites, 1872 tests, 1 suite-level error, 1 
error, 57 ignored (30 assumptions)

Total time: 140 minutes 35 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_31 -client 
-XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org