lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-4.x-Linux (64bit/ibm-j9-jdk7) - Build # 2067 - Failure!
Date Mon, 29 Oct 2012 18:06:05 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/2067/
Java: 64bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}

6 tests failed.
REGRESSION:  org.apache.solr.TestDistributedGrouping.testDistribSearch

Error Message:
Server at http://127.0.0.1:45574/solr returned non ok status:500, message:Server Error

Stack Trace:
org.apache.solr.common.SolrException: Server at http://127.0.0.1:45574/solr returned non ok status:500, message:Server Error
	at __randomizedtesting.SeedInfo.seed([41CFEF62A1A6517:85FA70EE5D45052B]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:372)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
	at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:371)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:394)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:376)
	at org.apache.solr.TestDistributedGrouping.doTest(TestDistributedGrouping.java:146)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:701)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
	at java.lang.reflect.Method.invoke(Method.java:613)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:779)


REGRESSION:  org.apache.solr.TestDistributedSearch.testDistribSearch

Error Message:
Server at http://127.0.0.1:57806/solr returned non ok status:500, message:Server Error

Stack Trace:
org.apache.solr.common.SolrException: Server at http://127.0.0.1:57806/solr returned non ok status:500, message:Server Error
	at __randomizedtesting.SeedInfo.seed([41CFEF62A1A6517:85FA70EE5D45052B]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:372)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
	at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:371)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:394)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:376)
	at org.apache.solr.TestDistributedSearch.doTest(TestDistributedSearch.java:134)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:701)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
	at java.lang.reflect.Method.invoke(Method.java:613)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:779)


REGRESSION:  org.apache.solr.cloud.BasicDistributedZk2Test.testDistribSearch

Error Message:
.response[id=1][range_facet_si]==null

Stack Trace:
junit.framework.AssertionFailedError: .response[id=1][range_facet_si]==null
	at __randomizedtesting.SeedInfo.seed([41CFEF62A1A6517:85FA70EE5D45052B]:0)
	at junit.framework.Assert.fail(Assert.java:50)
	at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:686)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:396)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:376)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.checkQueries(AbstractFullDistribZkTestBase.java:664)
	at org.apache.solr.cloud.BasicDistributedZk2Test.doTest(BasicDistributedZk2Test.java:77)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
	at java.lang.reflect.Method.invoke(Method.java:613)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:779)


REGRESSION:  org.apache.solr.cloud.BasicDistributedZkTest.testDistribSearch

Error Message:
No live SolrServers available to handle this request:[http://127.0.0.1:33048/solr/collection1, http://127.0.0.1:48026/solr/collection1, http://127.0.0.1:34208/solr/collection1, http://127.0.0.1:37947/solr/collection1]

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:33048/solr/collection1, http://127.0.0.1:48026/solr/collection1, http://127.0.0.1:34208/solr/collection1, http://127.0.0.1:37947/solr/collection1]
	at __randomizedtesting.SeedInfo.seed([41CFEF62A1A6517:85FA70EE5D45052B]:0)
	at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:324)
	at org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:269)
	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
	at org.apache.solr.cloud.AbstractFullDistribZkTestBase.queryServer(AbstractFullDistribZkTestBase.java:994)
	at org.apache.solr.cloud.BasicDistributedZkTest.queryServer(BasicDistributedZkTest.java:1357)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:394)
	at org.apache.solr.cloud.BasicDistributedZkTest.doTest(BasicDistributedZkTest.java:273)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
	at java.lang.reflect.Method.invoke(Method.java:613)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:779)
Caused by: org.apache.solr.common.SolrException: Server at http://127.0.0.1:48026/solr/collection1 returned non ok status:500, message:Server Error
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:372)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
	at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:255)
	... 48 more


REGRESSION:  org.apache.solr.handler.component.DistributedQueryElevationComponentTest.testDistribSearch

Error Message:
Server at http://127.0.0.1:33092/solr returned non ok status:500, message:Server Error

Stack Trace:
org.apache.solr.common.SolrException: Server at http://127.0.0.1:33092/solr returned non ok status:500, message:Server Error
	at __randomizedtesting.SeedInfo.seed([41CFEF62A1A6517:85FA70EE5D45052B]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:372)
	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
	at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:90)
	at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
	at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:371)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:394)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:376)
	at org.apache.solr.handler.component.DistributedQueryElevationComponentTest.doTest(DistributedQueryElevationComponentTest.java:83)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:695)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
	at java.lang.reflect.Method.invoke(Method.java:613)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:779)


REGRESSION:  org.apache.solr.handler.component.StatsComponentTest.testStats

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
	at __randomizedtesting.SeedInfo.seed([41CFEF62A1A6517:9E9DA74942C6AB34]:0)
	at org.apache.solr.util.AbstractSolrTestCase.assertQ(AbstractSolrTestCase.java:283)
	at org.apache.solr.handler.component.StatsComponentTest.doTestFacetStatisticsResult(StatsComponentTest.java:239)
	at org.apache.solr.handler.component.StatsComponentTest.testStats(StatsComponentTest.java:68)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
	at java.lang.reflect.Method.invoke(Method.java:613)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	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:358)
	at java.lang.Thread.run(Thread.java:779)
Caused by: java.lang.NullPointerException
	at org.apache.solr.util.NumberUtils.SortableStr2int(NumberUtils.java:162)
	at org.apache.solr.schema.SortableIntField.toObject(SortableIntField.java:96)
	at org.apache.solr.schema.SortableIntField.toObject(SortableIntField.java:55)
	at org.apache.solr.schema.FieldType.toObject(FieldType.java:342)
	at org.apache.solr.handler.component.AbstractStatsValues.accumulate(StatsValuesFactory.java:129)
	at org.apache.solr.handler.component.SimpleStats.getFieldCacheStats(StatsComponent.java:281)
	at org.apache.solr.handler.component.SimpleStats.getStatsFields(StatsComponent.java:227)
	at org.apache.solr.handler.component.SimpleStats.getStatsCounts(StatsComponent.java:201)
	at org.apache.solr.handler.component.StatsComponent.process(StatsComponent.java:70)
	at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:206)
	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:129)
	at org.apache.solr.core.SolrCore.execute(SolrCore.java:1750)
	at org.apache.solr.util.TestHarness.query(TestHarness.java:364)
	at org.apache.solr.util.TestHarness.query(TestHarness.java:346)
	at org.apache.solr.util.AbstractSolrTestCase.assertQ(AbstractSolrTestCase.java:273)
	... 42 more




Build Log:
[...truncated 13075 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.BasicDistributedZkTest
[junit4:junit4]   2> 4 T709 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-BasicDistributedZkTest-1351532599383
[junit4:junit4]   2> 4 T709 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 6 T710 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 6 T710 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 7 T710 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 105 T709 oasc.ZkTestServer.run start zk server on port:60056
[junit4:junit4]   2> 106 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@54847208
[junit4:junit4]   2> 107 T715 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 107 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 108 T715 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 109 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35059
[junit4:junit4]   2> 109 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35059
[junit4:junit4]   2> 110 T713 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 263 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0000 with negotiated timeout 10000 for client /127.0.0.1:35059
[junit4:junit4]   2> 263 T715 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0000, negotiated timeout = 10000
[junit4:junit4]   2> 264 T716 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@54847208 name:ZooKeeperConnection Watcher:127.0.0.1:60056 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 264 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 265 T709 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 270 T714 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13aad9ed85a0000
[junit4:junit4]   2> 271 T716 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 271 T709 oaz.ZooKeeper.close Session: 0x13aad9ed85a0000 closed
[junit4:junit4]   2> 271 T711 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35059 which had sessionid 0x13aad9ed85a0000
[junit4:junit4]   2> 272 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@e2e9b324
[junit4:junit4]   2> 273 T717 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 273 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 274 T717 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 274 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35060
[junit4:junit4]   2> 275 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35060
[junit4:junit4]   2> 276 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0001 with negotiated timeout 10000 for client /127.0.0.1:35060
[junit4:junit4]   2> 276 T717 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0001, negotiated timeout = 10000
[junit4:junit4]   2> 277 T718 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@e2e9b324 name:ZooKeeperConnection Watcher:127.0.0.1:60056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 278 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 279 T709 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 284 T709 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 288 T709 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 292 T709 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 296 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 301 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 309 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 315 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 321 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 325 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 332 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 333 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 338 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 339 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 343 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 344 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 346 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 347 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 350 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 350 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 353 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 354 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 357 T709 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 358 T709 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 361 T714 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13aad9ed85a0001
[junit4:junit4]   2> 362 T718 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 362 T709 oaz.ZooKeeper.close Session: 0x13aad9ed85a0001 closed
[junit4:junit4]   2> 362 T711 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35060 which had sessionid 0x13aad9ed85a0001
[junit4:junit4]   2> 363 T709 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 367 T709 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:47338
[junit4:junit4]   2> 368 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 368 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 368 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 378 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 379 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 379 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 379 T709 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 380 T709 oasc.CoreContainer.<init> New CoreContainer -2014825366
[junit4:junit4]   2> 380 T709 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 381 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 393 T709 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 403 T709 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:60056/solr
[junit4:junit4]   2> 404 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@936380d2
[junit4:junit4]   2> 405 T728 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 405 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 405 T728 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 406 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35061
[junit4:junit4]   2> 406 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35061
[junit4:junit4]   2> 407 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0002 with negotiated timeout 5000 for client /127.0.0.1:35061
[junit4:junit4]   2> 408 T728 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0002, negotiated timeout = 5000
[junit4:junit4]   2> 408 T729 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@936380d2 name:ZooKeeperConnection Watcher:127.0.0.1:60056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 409 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 411 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 413 T709 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 415 T709 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47338_solr
[junit4:junit4]   2> 416 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:47338_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:47338_solr
[junit4:junit4]   2> 417 T709 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:47338_solr
[junit4:junit4]   2> 420 T709 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 421 T709 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 422 T709 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 423 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 424 T709 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 425 T709 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 426 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 427 T709 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 428 T709 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 429 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 436 T709 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 444 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:delete cxid:0x15 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 445 T709 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 449 T709 oasc.Overseer.start Overseer (id=88574040433360898-127.0.0.1:47338_solr-n_0000000000) starting
[junit4:junit4]   2> 451 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 452 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 453 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 454 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 456 T731 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4:junit4]   2> 456 T709 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 460 T709 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 464 T730 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 470 T709 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 471 T709 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4:junit4]   2> 472 T709 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 473 T709 oasc.ZkController.readConfigName Load collection config from:/collections/control_collection
[junit4:junit4]   2> 475 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 477 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 478 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 516 T709 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 563 T709 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 564 T709 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 569 T709 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 928 T709 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 933 T709 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 936 T709 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 951 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 958 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 964 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 967 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 969 T709 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/control/data/
[junit4:junit4]   2> 969 T709 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@a22424f2
[junit4:junit4]   2> 973 T709 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/control/data/index/
[junit4:junit4]   2> 974 T709 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 974 T709 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/control/data/index forceNew:false
[junit4:junit4]   2> 977 T709 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 978 T709 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 979 T709 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 981 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 981 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 982 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 983 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 983 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 984 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 984 T709 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 985 T709 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 986 T709 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 987 T709 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 988 T709 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 989 T709 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 990 T709 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 991 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 992 T709 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 993 T709 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 994 T709 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 995 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 996 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 997 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 998 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 999 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1001 T709 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1002 T709 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1002 T709 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1004 T709 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1006 T709 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1007 T709 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, STOPWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, CURRENCY.XML, SCHEMA.XML, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 1009 T709 oass.SolrIndexSearcher.<init> Opening Searcher@bde2aa4d main
[junit4:junit4]   2> 1010 T709 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1011 T709 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1012 T709 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1018 T709 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1059 T732 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bde2aa4d main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1064 T709 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 1066 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x53 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 1068 T709 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 1069 T709 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:47338/solr shardId:control_shard
[junit4:junit4]   2> 1072 T709 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/control_shard/election
[junit4:junit4]   2> 1088 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:delete cxid:0x62 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/control_collection/leaders Error:KeeperErrorCode = NoNode for /solr/collections/control_collection/leaders
[junit4:junit4]   2> 1089 T709 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 1091 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x63 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1469 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1470 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:47338/solr",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:47338_solr",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"control_collection",
[junit4:junit4]   2> 	  "shard":"control_shard",
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 1470 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x6a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 1476 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 1596 T709 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 1597 T709 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 1598 T709 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:47338/solr/collection1/
[junit4:junit4]   2> 1599 T709 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 1600 T709 oasc.SyncStrategy.syncToMe http://127.0.0.1:47338/solr/collection1/ has no replicas
[junit4:junit4]   2> 1601 T709 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:47338/solr/collection1/
[junit4:junit4]   2> 1602 T709 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/control_shard
[junit4:junit4]   2> 1607 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0002 type:create cxid:0x88 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 1981 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 1984 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 2011 T709 oasc.ZkController.register We are http://127.0.0.1:47338/solr/collection1/ and leader is http://127.0.0.1:47338/solr/collection1/
[junit4:junit4]   2> 2012 T709 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:47338/solr
[junit4:junit4]   2> 2012 T709 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 2013 T709 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 2014 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2016 T709 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 2016 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 2017 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 2077 T709 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 2079 T709 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:37947
[junit4:junit4]   2> 2080 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2081 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401
[junit4:junit4]   2> 2081 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401/'
[junit4:junit4]   2> 2091 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 2092 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2092 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401
[junit4:junit4]   2> 2092 T709 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401/solr.xml
[junit4:junit4]   2> 2093 T709 oasc.CoreContainer.<init> New CoreContainer 1471158182
[junit4:junit4]   2> 2093 T709 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401/'
[junit4:junit4]   2> 2094 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401/'
[junit4:junit4]   2> 2106 T709 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2116 T709 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:60056/solr
[junit4:junit4]   2> 2117 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@f34a9ebf
[junit4:junit4]   2> 2118 T742 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 2118 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 2118 T742 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 2119 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35065
[junit4:junit4]   2> 2119 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35065
[junit4:junit4]   2> 2120 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0003 with negotiated timeout 5000 for client /127.0.0.1:35065
[junit4:junit4]   2> 2120 T742 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0003, negotiated timeout = 5000
[junit4:junit4]   2> 2120 T743 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@f34a9ebf name:ZooKeeperConnection Watcher:127.0.0.1:60056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 2120 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 2121 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2123 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2124 T709 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37947_solr
[junit4:junit4]   2> 2125 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:37947_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:37947_solr
[junit4:junit4]   2> 2125 T709 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:37947_solr
[junit4:junit4]   2> 2129 T729 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 2129 T709 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2130 T709 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2130 T709 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2131 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2131 T709 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2131 T709 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2132 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2132 T709 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2133 T709 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2133 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2138 T709 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 2143 T709 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401/collection1
[junit4:junit4]   2> 2144 T709 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 2144 T709 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 2145 T709 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 2146 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401/collection1/'
[junit4:junit4]   2> 2147 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty1-1351532601401/collection1/lib/README' to classloader
[junit4:junit4]   2> 2148 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty1-1351532601401/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2179 T709 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 2222 T709 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2223 T709 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2228 T709 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2487 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2488 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:47338/solr",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:47338_solr",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"control_collection",
[junit4:junit4]   2> 	  "shard":"control_shard",
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 2491 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 2492 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 2611 T709 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2617 T709 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2619 T709 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2631 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2635 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2640 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2642 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2643 T709 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty1-1351532601401/collection1/, dataDir=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty1/
[junit4:junit4]   2> 2644 T709 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@a22424f2
[junit4:junit4]   2> 2645 T709 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty1/index/
[junit4:junit4]   2> 2645 T709 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty1/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2646 T709 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty1/index forceNew:false
[junit4:junit4]   2> 2654 T709 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2655 T709 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 2656 T709 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2658 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2658 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2659 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2659 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2660 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2661 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2661 T709 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2663 T709 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2663 T709 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2664 T709 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2665 T709 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2665 T709 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2666 T709 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2667 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2667 T709 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2668 T709 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2668 T709 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2669 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2670 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2671 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2672 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2672 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2673 T709 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2674 T709 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2675 T709 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2677 T709 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2679 T709 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2680 T709 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, STOPWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, CURRENCY.XML, SCHEMA.XML, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 2683 T709 oass.SolrIndexSearcher.<init> Opening Searcher@d624b729 main
[junit4:junit4]   2> 2684 T709 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2684 T709 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2685 T709 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2692 T709 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2721 T744 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d624b729 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2724 T709 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 2994 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2995 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:37947/solr",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:37947_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":null,
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 2995 T730 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with numShards 2
[junit4:junit4]   2> 2998 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 2998 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 3226 T709 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 3226 T709 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:37947/solr shardId:shard1
[junit4:junit4]   2> 3228 T709 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 3233 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0003 type:delete cxid:0x43 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders
[junit4:junit4]   2> 3233 T709 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 3234 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0003 type:create cxid:0x44 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3235 T709 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 3235 T709 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 3236 T709 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:37947/solr/collection1/
[junit4:junit4]   2> 3236 T709 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 3237 T709 oasc.SyncStrategy.syncToMe http://127.0.0.1:37947/solr/collection1/ has no replicas
[junit4:junit4]   2> 3237 T709 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:37947/solr/collection1/
[junit4:junit4]   2> 3238 T709 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 3241 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0003 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3503 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3513 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 3513 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 3543 T709 oasc.ZkController.register We are http://127.0.0.1:37947/solr/collection1/ and leader is http://127.0.0.1:37947/solr/collection1/
[junit4:junit4]   2> 3544 T709 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:37947/solr
[junit4:junit4]   2> 3545 T709 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 3545 T709 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 3548 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3550 T709 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 3551 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3551 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 3618 T709 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 3620 T709 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:33048
[junit4:junit4]   2> 3621 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3621 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936
[junit4:junit4]   2> 3622 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936/'
[junit4:junit4]   2> 3632 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 3632 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3633 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936
[junit4:junit4]   2> 3633 T709 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936/solr.xml
[junit4:junit4]   2> 3633 T709 oasc.CoreContainer.<init> New CoreContainer -1733356443
[junit4:junit4]   2> 3634 T709 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936/'
[junit4:junit4]   2> 3634 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936/'
[junit4:junit4]   2> 3646 T709 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3656 T709 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:60056/solr
[junit4:junit4]   2> 3657 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@53b4cde6
[junit4:junit4]   2> 3658 T754 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 3658 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3659 T754 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 3659 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35068
[junit4:junit4]   2> 3659 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35068
[junit4:junit4]   2> 3660 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0004 with negotiated timeout 5000 for client /127.0.0.1:35068
[junit4:junit4]   2> 3660 T754 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0004, negotiated timeout = 5000
[junit4:junit4]   2> 3660 T755 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@53b4cde6 name:ZooKeeperConnection Watcher:127.0.0.1:60056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3660 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3661 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3662 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3663 T709 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33048_solr
[junit4:junit4]   2> 3663 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:33048_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:33048_solr
[junit4:junit4]   2> 3664 T709 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:33048_solr
[junit4:junit4]   2> 3665 T729 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 3666 T743 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 3666 T709 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3667 T709 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3667 T709 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3667 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3668 T709 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3668 T709 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3669 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3669 T709 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3670 T709 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3670 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3675 T709 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 3680 T709 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936/collection1
[junit4:junit4]   2> 3680 T709 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 3681 T709 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 3681 T709 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 3682 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936/collection1/'
[junit4:junit4]   2> 3683 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty2-1351532602936/collection1/lib/README' to classloader
[junit4:junit4]   2> 3684 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty2-1351532602936/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 3714 T709 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 3764 T709 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3765 T709 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3770 T709 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4018 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4019 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:37947/solr",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:37947_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 4022 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4022 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4022 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4170 T709 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 4176 T709 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 4180 T709 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4190 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4195 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4199 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4201 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4202 T709 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty2-1351532602936/collection1/, dataDir=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty2/
[junit4:junit4]   2> 4202 T709 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@a22424f2
[junit4:junit4]   2> 4203 T709 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty2/index/
[junit4:junit4]   2> 4203 T709 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty2/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 4204 T709 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty2/index forceNew:false
[junit4:junit4]   2> 4208 T709 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4209 T709 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4209 T709 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 4211 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 4212 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 4212 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 4213 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 4214 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 4215 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 4216 T709 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 4217 T709 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4218 T709 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 4218 T709 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 4219 T709 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 4219 T709 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 4220 T709 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 4220 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 4221 T709 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 4222 T709 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4222 T709 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4223 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4223 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4224 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4225 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4225 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4226 T709 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4227 T709 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 4227 T709 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 4229 T709 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4230 T709 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 4232 T709 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, STOPWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, CURRENCY.XML, SCHEMA.XML, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 4234 T709 oass.SolrIndexSearcher.<init> Opening Searcher@15bf87e6 main
[junit4:junit4]   2> 4235 T709 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4236 T709 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4236 T709 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 4241 T709 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 4264 T756 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15bf87e6 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 4268 T709 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 4525 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4526 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:33048/solr",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:33048_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":null,
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 4529 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4529 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4529 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4769 T709 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 4770 T709 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:33048/solr shardId:shard2
[junit4:junit4]   2> 4771 T709 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election
[junit4:junit4]   2> 4777 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0004 type:delete cxid:0x42 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard2 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard2
[junit4:junit4]   2> 4777 T709 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 4778 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0004 type:create cxid:0x43 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4780 T709 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 4780 T709 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 4781 T709 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:33048/solr/collection1/
[junit4:junit4]   2> 4781 T709 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4:junit4]   2> 4782 T709 oasc.SyncStrategy.syncToMe http://127.0.0.1:33048/solr/collection1/ has no replicas
[junit4:junit4]   2> 4782 T709 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:33048/solr/collection1/
[junit4:junit4]   2> 4783 T709 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
[junit4:junit4]   2> 4786 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0004 type:create cxid:0x4c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5032 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5038 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 5038 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 5040 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 5088 T709 oasc.ZkController.register We are http://127.0.0.1:33048/solr/collection1/ and leader is http://127.0.0.1:33048/solr/collection1/
[junit4:junit4]   2> 5089 T709 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:33048/solr
[junit4:junit4]   2> 5090 T709 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4:junit4]   2> 5090 T709 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 5092 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5093 T709 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 5093 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 5094 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 5142 T709 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 5144 T709 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:48026
[junit4:junit4]   2> 5144 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5145 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476
[junit4:junit4]   2> 5145 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476/'
[junit4:junit4]   2> 5156 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 5157 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5157 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476
[junit4:junit4]   2> 5157 T709 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476/solr.xml
[junit4:junit4]   2> 5158 T709 oasc.CoreContainer.<init> New CoreContainer -1485537887
[junit4:junit4]   2> 5158 T709 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476/'
[junit4:junit4]   2> 5159 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476/'
[junit4:junit4]   2> 5172 T709 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5183 T709 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:60056/solr
[junit4:junit4]   2> 5183 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@8b9f584f
[junit4:junit4]   2> 5184 T766 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 5184 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5185 T766 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 5185 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35069
[junit4:junit4]   2> 5185 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35069
[junit4:junit4]   2> 5186 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0005 with negotiated timeout 5000 for client /127.0.0.1:35069
[junit4:junit4]   2> 5186 T766 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0005, negotiated timeout = 5000
[junit4:junit4]   2> 5187 T767 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8b9f584f name:ZooKeeperConnection Watcher:127.0.0.1:60056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5187 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5188 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0005 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5188 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0005 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5189 T709 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:48026_solr
[junit4:junit4]   2> 5189 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0005 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:48026_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:48026_solr
[junit4:junit4]   2> 5190 T709 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:48026_solr
[junit4:junit4]   2> 5192 T729 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 5192 T743 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 5192 T755 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 5192 T709 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5193 T709 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5194 T709 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5195 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5195 T709 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5196 T709 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5197 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5198 T709 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5198 T709 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5199 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 5208 T709 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5214 T709 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476/collection1
[junit4:junit4]   2> 5215 T709 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 5216 T709 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 5217 T709 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 5218 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476/collection1/'
[junit4:junit4]   2> 5219 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty3-1351532604476/collection1/lib/README' to classloader
[junit4:junit4]   2> 5220 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty3-1351532604476/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 5267 T709 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 5315 T709 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 5316 T709 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 5322 T709 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 5548 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5549 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:33048/solr",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:33048_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":"shard2",
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 5552 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5552 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5552 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5554 T767 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5823 T709 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 5833 T709 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 5838 T709 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5852 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5859 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5872 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5874 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5877 T709 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty3-1351532604476/collection1/, dataDir=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty3/
[junit4:junit4]   2> 5877 T709 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@a22424f2
[junit4:junit4]   2> 5879 T709 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty3/index/
[junit4:junit4]   2> 5879 T709 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty3/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 5880 T709 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty3/index forceNew:false
[junit4:junit4]   2> 6084 T709 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty3/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6085 T709 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 6085 T709 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 6087 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 6088 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 6088 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 6089 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 6089 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 6090 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 6090 T709 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 6091 T709 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 6092 T709 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 6092 T709 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 6093 T709 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 6094 T709 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 6094 T709 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 6095 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 6095 T709 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 6096 T709 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 6096 T709 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6097 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6098 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6098 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6099 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6100 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6100 T709 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6101 T709 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 6102 T709 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 6103 T709 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 6105 T709 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 6107 T709 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, STOPWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, CURRENCY.XML, SCHEMA.XML, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 6112 T709 oass.SolrIndexSearcher.<init> Opening Searcher@2421eeb4 main
[junit4:junit4]   2> 6113 T709 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 6114 T709 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 6115 T709 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 6119 T709 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 6141 T768 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2421eeb4 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 6145 T709 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 6557 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6557 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:48026/solr",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:48026_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":null,
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 6581 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 6581 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 6581 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 6581 T767 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 6647 T709 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 6647 T709 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:48026/solr shardId:shard1
[junit4:junit4]   2> 6650 T709 oasc.ZkController.register We are http://127.0.0.1:48026/solr/collection1/ and leader is http://127.0.0.1:37947/solr/collection1/
[junit4:junit4]   2> 6651 T709 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:48026/solr
[junit4:junit4]   2> 6651 T709 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 6651 T709 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C54 name=collection1 org.apache.solr.core.SolrCore@cd5f923 url=http://127.0.0.1:48026/solr/collection1 node=127.0.0.1:48026_solr
[junit4:junit4]   2> 6652 T769 C54 P48026 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 6653 T769 C54 P48026 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 6652 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6653 T769 C54 P48026 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 6654 T709 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 6654 T769 C54 P48026 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:37947/solr/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4]   2> 6654 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 6655 T769 C54 P48026 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:48026/solr START replicas=[http://127.0.0.1:37947/solr/collection1/] nUpdates=100
[junit4:junit4]   2> 6656 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 6656 T769 C54 P48026 oasu.PeerSync.sync WARNING no frame of reference to tell of we've missed updates
[junit4:junit4]   2> 6656 T769 C54 P48026 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4]   2> 6657 T769 C54 P48026 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4]   2> 6658 T769 C54 P48026 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C55 name=collection1 org.apache.solr.core.SolrCore@8863e8ca url=http://127.0.0.1:37947/solr/collection1 node=127.0.0.1:37947_solr
[junit4:junit4]   2> 6668 T739 C55 P37947 REQ /get {version=2&getVersions=100&qt=/get&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 6717 T709 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 6719 T709 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:34208
[junit4:junit4]   2> 6720 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 6721 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045
[junit4:junit4]   2> 6721 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045/'
[junit4:junit4]   2> 6740 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 6741 T709 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 6742 T709 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045
[junit4:junit4]   2> 6742 T709 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045/solr.xml
[junit4:junit4]   2> 6743 T709 oasc.CoreContainer.<init> New CoreContainer -1158066410
[junit4:junit4]   2> 6743 T709 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045/'
[junit4:junit4]   2> 6744 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045/'
[junit4:junit4]   2> 6756 T709 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 6766 T709 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:60056/solr
[junit4:junit4]   2> 6766 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056/solr sessionTimeout=5000 watcher=org.apache.solr.common.cloud.ConnectionManager@849d2645
[junit4:junit4]   2> 6767 T780 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 6767 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 6768 T780 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 6768 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35072
[junit4:junit4]   2> 6768 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35072
[junit4:junit4]   2> 6769 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0006 with negotiated timeout 5000 for client /127.0.0.1:35072
[junit4:junit4]   2> 6769 T780 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0006, negotiated timeout = 5000
[junit4:junit4]   2> 6770 T781 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@849d2645 name:ZooKeeperConnection Watcher:127.0.0.1:60056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 6770 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 6771 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0006 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 6772 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0006 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 6773 T709 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34208_solr
[junit4:junit4]   2> 6774 T714 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13aad9ed85a0006 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:34208_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:34208_solr
[junit4:junit4]   2> 6774 T709 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:34208_solr
[junit4:junit4]   2> 6776 T767 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 6776 T729 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 6776 T755 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 6776 T709 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 6777 T709 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 6777 T709 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 6776 T743 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 6778 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 6778 T709 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 6779 T709 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 6779 T709 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 6779 T709 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 6780 T709 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 6780 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 6786 T709 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 6791 T709 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045/collection1
[junit4:junit4]   2> 6792 T709 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 6792 T709 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 6793 T709 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 6794 T709 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045/collection1/'
[junit4:junit4]   2> 6795 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty4-1351532606045/collection1/lib/README' to classloader
[junit4:junit4]   2> 6795 T709 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/solrtest-jetty4-1351532606045/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 6826 T709 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 6875 T709 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 6877 T709 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 6884 T709 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 7085 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7086 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:48026/solr",
[junit4:junit4]   2> 	  "state":"recovering",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:48026_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 7089 T781 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7089 T767 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7089 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7089 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7089 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7309 T709 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 7317 T709 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 7320 T709 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 7330 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 7335 T709 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 7340 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 7341 T709 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 7342 T709 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-jetty4-1351532606045/collection1/, dataDir=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty4/
[junit4:junit4]   2> 7343 T709 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@a22424f2
[junit4:junit4]   2> 7344 T709 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty4/index/
[junit4:junit4]   2> 7344 T709 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty4/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 7345 T709 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty4/index forceNew:false
[junit4:junit4]   2> 7402 T709 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty4/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7403 T709 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 7404 T709 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 7405 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 7406 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 7406 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 7407 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 7407 T709 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 7408 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 7408 T709 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 7409 T709 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 7410 T709 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 7411 T709 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 7411 T709 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 7412 T709 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 7413 T709 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 7413 T709 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 7414 T709 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 7414 T709 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 7415 T709 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7415 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7416 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7417 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7417 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7418 T709 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7418 T709 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7419 T709 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 7420 T709 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 7421 T709 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 7423 T709 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 7424 T709 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, STOPWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, CURRENCY.XML, SCHEMA.XML, SYNONYMS.TXT, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 7427 T709 oass.SolrIndexSearcher.<init> Opening Searcher@b86098ce main
[junit4:junit4]   2> 7428 T709 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 7428 T709 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 7429 T709 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 7433 T709 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 7461 T782 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b86098ce main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 7465 T709 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 7592 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7593 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:34208/solr",
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:34208_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":null,
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 7596 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7596 T767 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7596 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7596 T781 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7596 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7967 T709 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 7968 T709 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:34208/solr shardId:shard2
[junit4:junit4]   2> 7970 T709 oasc.ZkController.register We are http://127.0.0.1:34208/solr/collection1/ and leader is http://127.0.0.1:33048/solr/collection1/
[junit4:junit4]   2> 7970 T709 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:34208/solr
[junit4:junit4]   2> 7971 T709 oasc.ZkController.checkRecovery Core needs to recover:collection1
[junit4:junit4]   2> 7971 T709 oasu.DefaultSolrCoreState.doRecovery Running recovery - first canceling any ongoing recovery
[junit4:junit4]   2> ASYNC  NEW_CORE C56 name=collection1 org.apache.solr.core.SolrCore@6be15d9 url=http://127.0.0.1:34208/solr/collection1 node=127.0.0.1:34208_solr
[junit4:junit4]   2> 7972 T783 C56 P34208 oasc.RecoveryStrategy.run Starting recovery process.  core=collection1 recoveringAfterStartup=true
[junit4:junit4]   2> 7972 T783 C56 P34208 oasc.RecoveryStrategy.doRecovery ###### startupVersions=[]
[junit4:junit4]   2> 7972 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7972 T783 C56 P34208 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 7973 T709 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 7973 T783 C56 P34208 oasc.RecoveryStrategy.doRecovery Attempting to PeerSync from http://127.0.0.1:33048/solr/collection1/ core=collection1 - recoveringAfterStartup=true
[junit4:junit4]   2> 7974 T709 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 7974 T783 C56 P34208 oasu.PeerSync.sync PeerSync: core=collection1 url=http://127.0.0.1:34208/solr START replicas=[http://127.0.0.1:33048/solr/collection1/] nUpdates=100
[junit4:junit4]   2> 7974 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 7975 T783 C56 P34208 oasu.PeerSync.sync WARNING no frame of reference to tell of we've missed updates
[junit4:junit4]   2> 7975 T783 C56 P34208 oasc.RecoveryStrategy.doRecovery PeerSync Recovery was not successful - trying replication. core=collection1
[junit4:junit4]   2> 7975 T783 C56 P34208 oasc.RecoveryStrategy.doRecovery Starting Replication Recovery. core=collection1
[junit4:junit4]   2> 7976 T783 C56 P34208 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 7980 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@458e042e
[junit4:junit4]   2> 7981 T785 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 7981 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> ASYNC  NEW_CORE C57 name=collection1 org.apache.solr.core.SolrCore@7fd68b23 url=http://127.0.0.1:33048/solr/collection1 node=127.0.0.1:33048_solr
[junit4:junit4]   2> 7982 T751 C57 P33048 REQ /get {version=2&getVersions=100&qt=/get&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 7984 T785 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 7984 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35076
[junit4:junit4]   2> 7984 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35076
[junit4:junit4]   2> 7986 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0007 with negotiated timeout 10000 for client /127.0.0.1:35076
[junit4:junit4]   2> 7986 T785 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0007, negotiated timeout = 10000
[junit4:junit4]   2> 7986 T786 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@458e042e name:ZooKeeperConnection Watcher:127.0.0.1:60056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7987 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7987 T709 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 7989 T709 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:true cause connection loss:true
[junit4:junit4]   2> 7989 T709 oascsi.HttpClientUtil.createClient Creating new http client, config:
[junit4:junit4]   2> 7992 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7994 T709 oasc.AbstractDistribZkTestBase.waitForRecoveriesToFinish Wait for recoveries to finish - collection: collection1 failOnTimeout:true timeout (sec):540
[junit4:junit4]   2> 7994 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 8100 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 8101 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:34208/solr",
[junit4:junit4]   2> 	  "state":"recovering",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:34208_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":"shard2",
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 8141 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 8141 T767 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 8141 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 8141 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 8141 T781 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 8142 T786 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 8996 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2>  C54_STATE=coll:collection1 core:collection1 props:{base_url=http://127.0.0.1:48026/solr, state=recovering, node_name=127.0.0.1:48026_solr, roles=null, collection=collection1, shard=shard1, core=collection1}
[junit4:junit4]   2> 9670 T769 C54 P48026 oasc.RecoveryStrategy.doRecovery Begin buffering updates. core=collection1
[junit4:junit4]   2> 9670 T769 C54 P48026 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 9671 T769 C54 P48026 oasc.RecoveryStrategy.replicate Attempting to replicate from http://127.0.0.1:37947/solr/collection1/. core=collection1
[junit4:junit4]   2> 9671 T769 C54 P48026 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 9675 T739 C55 P37947 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 9677 T739 C55 P37947 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty1/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 9678 T739 C55 P37947 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 9679 T739 C55 P37947 oass.SolrIndexSearcher.<init> Opening Searcher@d1bc4d46 realtime
[junit4:junit4]   2> 9679 T739 C55 P37947 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 9680 T739 C55 P37947 /update {softCommit=false&commit_end_point=true&commit=true&version=2&waitSearcher=true&wt=javabin&openSearcher=false} {commit=} 0 5
[junit4:junit4]   2> 9681 T769 C54 P48026 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 9681 T769 C54 P48026 oash.SnapPuller.<init>  No value set for 'pollInterval'. Timer Task not started.
[junit4:junit4]   2> 9683 T738 C55 P37947 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 9683 T738 C55 P37947 REQ /replication {version=2&command=indexversion&qt=/replication&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 9685 T769 C54 P48026 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty3/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 9685 T769 C54 P48026 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 9686 T769 C54 P48026 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 9691 T769 C54 P48026 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty3/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty3/index,segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 9691 T769 C54 P48026 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 9693 T769 C54 P48026 oass.SolrIndexSearcher.<init> Opening Searcher@e0a89788 main
[junit4:junit4]   2> 9693 T769 C54 P48026 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 9694 T768 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e0a89788 main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 9695 T769 C54 P48026 oasc.RecoveryStrategy.replay No replay needed. core=collection1
[junit4:junit4]   2> 9695 T769 C54 P48026 oasc.RecoveryStrategy.doRecovery Replication Recovery was successful - registering as Active. core=collection1
[junit4:junit4]   2> 9695 T769 C54 P48026 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 9697 T769 C54 P48026 oasc.RecoveryStrategy.doRecovery Finished recovery process. core=collection1
[junit4:junit4]   2> 9997 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 10152 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 10153 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:48026/solr",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:48026_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 10155 T786 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 10155 T767 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 10155 T781 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 10155 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 10155 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 10155 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2>  C56_STATE=coll:collection1 core:collection1 props:{base_url=http://127.0.0.1:34208/solr, state=recovering, node_name=127.0.0.1:34208_solr, roles=null, collection=collection1, shard=shard2, core=collection1}
[junit4:junit4]   2> 10984 T783 C56 P34208 oasc.RecoveryStrategy.doRecovery Begin buffering updates. core=collection1
[junit4:junit4]   2> 10984 T783 C56 P34208 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 10984 T783 C56 P34208 oasc.RecoveryStrategy.replicate Attempting to replicate from http://127.0.0.1:33048/solr/collection1/. core=collection1
[junit4:junit4]   2> 10984 T783 C56 P34208 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 10989 T750 C57 P33048 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 10991 T750 C57 P33048 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty2/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 10992 T750 C57 P33048 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 10993 T750 C57 P33048 oass.SolrIndexSearcher.<init> Opening Searcher@c1391592 realtime
[junit4:junit4]   2> 10994 T750 C57 P33048 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 10994 T750 C57 P33048 /update {softCommit=false&commit_end_point=true&commit=true&version=2&waitSearcher=true&wt=javabin&openSearcher=false} {commit=} 0 6
[junit4:junit4]   2> 10995 T783 C56 P34208 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 10995 T783 C56 P34208 oash.SnapPuller.<init>  No value set for 'pollInterval'. Timer Task not started.
[junit4:junit4]   2> 10997 T751 C57 P33048 oash.ReplicationHandler.inform Commits will be reserved for  10000
[junit4:junit4]   2> 10998 T751 C57 P33048 REQ /replication {version=2&command=indexversion&qt=/replication&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 10999 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 11000 T783 C56 P34208 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty4/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 11000 T783 C56 P34208 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 11000 T783 C56 P34208 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 11061 T783 C56 P34208 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty4/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/jetty4/index,segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 11061 T783 C56 P34208 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 11062 T783 C56 P34208 oass.SolrIndexSearcher.<init> Opening Searcher@972f41c7 main
[junit4:junit4]   2> 11063 T783 C56 P34208 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 11064 T782 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@972f41c7 main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 11064 T783 C56 P34208 oasc.RecoveryStrategy.replay No replay needed. core=collection1
[junit4:junit4]   2> 11064 T783 C56 P34208 oasc.RecoveryStrategy.doRecovery Replication Recovery was successful - registering as Active. core=collection1
[junit4:junit4]   2> 11065 T783 C56 P34208 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 11066 T783 C56 P34208 oasc.RecoveryStrategy.doRecovery Finished recovery process. core=collection1
[junit4:junit4]   2> 11159 T730 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 11160 T730 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:34208/solr",
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:34208_solr",
[junit4:junit4]   2> 	  "numShards":"2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "shard":"shard2",
[junit4:junit4]   2> 	  "core":"collection1"}
[junit4:junit4]   2> 11173 T729 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 11173 T743 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 11174 T755 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 11173 T786 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 11173 T767 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 11173 T781 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12001 T709 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> ASYNC  NEW_CORE C58 name=collection1 org.apache.solr.core.SolrCore@6a869442 url=http://127.0.0.1:47338/solr/collection1 node=127.0.0.1:47338_solr
[junit4:junit4]   2> 12015 T726 C58 P47338 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZkTest-1351532599383/control/data/index,segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 12017 T726 C58 P47338 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 12019 T726 C58 P47338 oass.SolrIndexSearcher.<init> Opening Searcher@a81ef090 realtime
[junit4:junit4]   2> 12020 T726 C58 P47338 /update {version=2&wt=javabin} {deleteByQuery=*:* (-1417184659521929216)} 0 9
[junit4:junit4]   2> 12021 T709 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:60056/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@dcfcf3be
[junit4:junit4]   2> 12022 T787 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:60056
[junit4:junit4]   2> 12022 T709 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 12023 T787 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:60056, initiating session
[junit4:junit4]   2> 12023 T711 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35085
[junit4:junit4]   2> 12023 T711 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35085
[junit4:junit4]   2> 12024 T713 oazs.NIOServerCnxn.finishSessionInit Established session 0x13aad9ed85a0008 with negotiated timeout 10000 for client /127.0.0.1:35085
[junit4:junit4]   2> 12024 T787 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:60056, sessionid = 0x13aad9ed85a0008, negotiated timeout = 10000
[junit4:junit4]   2> 12024 T788 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@dcfcf3be name:ZooKeeperConnection Watcher:127.0.0.1:60056/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 12025 T709 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 12025 T709 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2>  C56_STATE=coll:collection1 core:collection1 props:{base_url=http://127.0.0.1:34208/solr, state=active, node_name=127.0.0.1:34208_solr, roles=null, collection=collection1, shard=shard2, core=collection1}
[junit4:junit4]   2> 12037 T779 C56 P34208 oass.SolrIndexSearcher.<init> Opening Searcher@c302a34b realtime
[junit4:junit4]   2> 12038 T779 C56 P34208 REQ /update {update.distrib=FROMLEADER&_version_=-1417184659538706432&version=2&wt=javabin&update.from=http://127.0.0.1:33048/solr/collection1/} status=0 QTime=3 
[junit4:junit4]   2>  C54_STATE=coll:collection1 core:collection1 props:{base_url=http://127.0.0.1:48026/solr, state=active, node_name=127.0.0.1:48026_solr, roles=null, collection=collection1, shard=shard1, core=collection1}
[junit4:junit4]   2> 12043 T762 C54 P48026 oass.SolrIndexSearcher.<init> Opening Searcher@bc110e9c realtime
[junit4:junit4]   2> 12044 T762 C54 P48026 REQ /update {update.distrib=FROMLEADER&_version_=-1417184659541852160&version=2&wt=javabin&update.from=http://127.0.0.1:37947/solr/collection1/} status=0 QTime=2 
[junit4:junit4]   2> 12045 T739 C55 P37947 REQ /update {update.distrib=TOLEADER&version=2&wt=javabin} status=0 QTime=14 
[junit4:junit4]   2> 12045 T751 C57 P33048 /update {version=2&wt=javabin} {deleteByQuery=*:* (-1417184659538706432)} 0 17
[junit4:junit4]   2> 12051 T725 C58 P47338 /update {version=2&wt=javabin} {add=[1 (1417184659560726528)]} 0 3
[junit4:junit4]   2> 12060 T764 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12061 T740 C55 P37947 /update {version=2&wt=javabin} {add=[1 (1417184659565969408)]} 0 8
[junit4:junit4]   2> 12065 T727 C58 P47338 /update {version=2&wt=javabin} {add=[2 (1417184659575406592)]} 0 2
[junit4:junit4]   2> 12084 T778 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=3 
[junit4:junit4]   2> 12085 T752 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=16 
[junit4:junit4]   2> 12085 T738 C55 P37947 /update {version=2&wt=javabin} {add=[2]} 0 18
[junit4:junit4]   2> 12089 T724 C58 P47338 /update {version=2&wt=javabin} {add=[3 (1417184659601620992)]} 0 1
[junit4:junit4]   2> 12098 T777 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12099 T753 C57 P33048 /update {version=2&wt=javabin} {add=[3 (1417184659605815296)]} 0 7
[junit4:junit4]   2> 12103 T726 C58 P47338 /update {version=2&wt=javabin} {add=[4 (1417184659616301056)]} 0 1
[junit4:junit4]   2> 12111 T765 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12112 T739 C55 P37947 /update {version=2&wt=javabin} {add=[4 (1417184659621543936)]} 0 6
[junit4:junit4]   2> 12117 T725 C58 P47338 /update {version=2&wt=javabin} {add=[5 (1417184659630981120)]} 0 2
[junit4:junit4]   2> 12126 T776 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12127 T751 C57 P33048 /update {version=2&wt=javabin} {add=[5 (1417184659636224000)]} 0 7
[junit4:junit4]   2> 12131 T727 C58 P47338 /update {version=2&wt=javabin} {add=[6 (1417184659645661184)]} 0 1
[junit4:junit4]   2> 12140 T779 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12141 T750 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12142 T741 C55 P37947 /update {version=2&wt=javabin} {add=[6]} 0 8
[junit4:junit4]   2> 12146 T724 C58 P47338 /update {version=2&wt=javabin} {add=[7 (1417184659661389824)]} 0 2
[junit4:junit4]   2> 12154 T778 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12155 T752 C57 P33048 /update {version=2&wt=javabin} {add=[7 (1417184659665584128)]} 0 6
[junit4:junit4]   2> 12159 T726 C58 P47338 /update {version=2&wt=javabin} {add=[8 (1417184659673972736)]} 0 2
[junit4:junit4]   2> 12169 T763 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12170 T740 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 12170 T753 C57 P33048 /update {version=2&wt=javabin} {add=[8]} 0 9
[junit4:junit4]   2> 12174 T725 C58 P47338 /update {version=2&wt=javabin} {add=[9 (1417184659690749952)]} 0 1
[junit4:junit4]   2> 12181 T777 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12182 T751 C57 P33048 /update {version=2&wt=javabin} {add=[9 (1417184659694944256)]} 0 5
[junit4:junit4]   2> 12192 T727 C58 P47338 /update {version=2&wt=javabin} {add=[10 (1417184659703332864)]} 0 7
[junit4:junit4]   2> 12201 T762 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12202 T738 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12203 T750 C57 P33048 /update {version=2&wt=javabin} {add=[10]} 0 8
[junit4:junit4]   2> 12208 T724 C58 P47338 /update {version=2&wt=javabin} {add=[11 (1417184659725352960)]} 0 2
[junit4:junit4]   2> 12216 T764 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12218 T739 C55 P37947 /update {version=2&wt=javabin} {add=[11 (1417184659730595840)]} 0 6
[junit4:junit4]   2> 12222 T726 C58 P47338 /update {version=2&wt=javabin} {add=[12 (1417184659740033024)]} 0 2
[junit4:junit4]   2> 12229 T765 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12229 T741 C55 P37947 /update {version=2&wt=javabin} {add=[12 (1417184659744227328)]} 0 5
[junit4:junit4]   2> 12234 T725 C58 P47338 /update {version=2&wt=javabin} {add=[13 (1417184659752615936)]} 0 2
[junit4:junit4]   2> 12244 T763 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12244 T740 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12245 T752 C57 P33048 /update {version=2&wt=javabin} {add=[13]} 0 8
[junit4:junit4]   2> 12249 T727 C58 P47338 /update {version=2&wt=javabin} {add=[14 (1417184659769393152)]} 0 1
[junit4:junit4]   2> 12256 T762 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12257 T738 C55 P37947 /update {version=2&wt=javabin} {add=[14 (1417184659773587456)]} 0 5
[junit4:junit4]   2> 12261 T724 C58 P47338 /update {version=2&wt=javabin} {add=[15 (1417184659781976064)]} 0 2
[junit4:junit4]   2> 12269 T764 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12269 T739 C55 P37947 /update {version=2&wt=javabin} {add=[15 (1417184659786170368)]} 0 5
[junit4:junit4]   2> 12273 T726 C58 P47338 /update {version=2&wt=javabin} {add=[16 (1417184659794558976)]} 0 1
[junit4:junit4]   2> 12311 T765 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=20 
[junit4:junit4]   2> 12313 T741 C55 P37947 /update {version=2&wt=javabin} {add=[16 (1417184659798753280)]} 0 37
[junit4:junit4]   2> 12320 T725 C58 P47338 /update {version=2&wt=javabin} {add=[17 (1417184659842793472)]} 0 3
[junit4:junit4]   2> 12340 T776 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=11 
[junit4:junit4]   2> 12341 T753 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=16 
[junit4:junit4]   2> 12342 T740 C55 P37947 /update {version=2&wt=javabin} {add=[17]} 0 20
[junit4:junit4]   2> 12346 T727 C58 P47338 /update {version=2&wt=javabin} {add=[100 (1417184659871105024)]} 0 1
[junit4:junit4]   2> 12354 T762 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12355 T738 C55 P37947 /update {version=2&wt=javabin} {add=[100 (1417184659874250752)]} 0 7
[junit4:junit4]   2> 12359 T724 C58 P47338 /update {version=2&wt=javabin} {add=[101 (1417184659884736512)]} 0 1
[junit4:junit4]   2> 12367 T764 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12368 T739 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12368 T751 C57 P33048 /update {version=2&wt=javabin} {add=[101]} 0 7
[junit4:junit4]   2> 12378 T726 C58 P47338 /update {version=2&wt=javabin} {add=[102 (1417184659898368000)]} 0 7
[junit4:junit4]   2> 12387 T765 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12387 T741 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=4 
[junit4:junit4]   2> 12388 T750 C57 P33048 /update {version=2&wt=javabin} {add=[102]} 0 7
[junit4:junit4]   2> 12392 T724 C58 P47338 /update {version=2&wt=javabin} {add=[103 (1417184659919339520)]} 0 2
[junit4:junit4]   2> 12400 T779 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12401 T752 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12401 T740 C55 P37947 /update {version=2&wt=javabin} {add=[103]} 0 7
[junit4:junit4]   2> 12405 T725 C58 P47338 /update {version=2&wt=javabin} {add=[104 (1417184659932971008)]} 0 1
[junit4:junit4]   2> 12412 T778 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12413 T753 C57 P33048 /update {version=2&wt=javabin} {add=[104 (1417184659937165312)]} 0 6
[junit4:junit4]   2> 12416 T726 C58 P47338 /update {version=2&wt=javabin} {add=[105 (1417184659944505344)]} 0 1
[junit4:junit4]   2> 12440 T777 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=11 
[junit4:junit4]   2> 12441 T751 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=21 
[junit4:junit4]   2> 12441 T738 C55 P37947 /update {version=2&wt=javabin} {add=[105]} 0 23
[junit4:junit4]   2> 12445 T727 C58 P47338 /update {version=2&wt=javabin} {add=[106 (1417184659974914048)]} 0 1
[junit4:junit4]   2> 12455 T779 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=3 
[junit4:junit4]   2> 12456 T750 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 12456 T739 C55 P37947 /update {version=2&wt=javabin} {add=[106]} 0 9
[junit4:junit4]   2> 12460 T724 C58 P47338 /update {version=2&wt=javabin} {add=[107 (1417184659990642688)]} 0 1
[junit4:junit4]   2> 12466 T763 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12467 T740 C55 P37947 /update {version=2&wt=javabin} {add=[107 (1417184659994836992)]} 0 4
[junit4:junit4]   2> 12471 T725 C58 P47338 /update {version=2&wt=javabin} {add=[108 (1417184660002177024)]} 0 1
[junit4:junit4]   2> 12477 T764 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 12478 T738 C55 P37947 /update {version=2&wt=javabin} {add=[108 (1417184660006371328)]} 0 4
[junit4:junit4]   2> 12482 T726 C58 P47338 /update {version=2&wt=javabin} {add=[109 (1417184660013711360)]} 0 1
[junit4:junit4]   2> 12489 T765 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12489 T739 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=4 
[junit4:junit4]   2> 12490 T752 C57 P33048 /update {version=2&wt=javabin} {add=[109]} 0 6
[junit4:junit4]   2> 12493 T727 C58 P47338 /update {version=2&wt=javabin} {add=[110 (1417184660026294272)]} 0 0
[junit4:junit4]   2> 12499 T762 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12500 T740 C55 P37947 /update {version=2&wt=javabin} {add=[110 (1417184660029440000)]} 0 4
[junit4:junit4]   2> 12503 T724 C58 P47338 /update {version=2&wt=javabin} {add=[111 (1417184660036780032)]} 0 1
[junit4:junit4]   2> 12512 T763 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12513 T738 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12514 T751 C57 P33048 /update {version=2&wt=javabin} {add=[111]} 0 8
[junit4:junit4]   2> 12526 T725 C58 P47338 /update {version=2&wt=javabin} {add=[112 (1417184660051460096)]} 0 10
[junit4:junit4]   2> 12535 T778 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12535 T750 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=4 
[junit4:junit4]   2> 12536 T741 C55 P37947 /update {version=2&wt=javabin} {add=[112]} 0 7
[junit4:junit4]   2> 12542 T726 C58 P47338 /update {version=2&wt=javabin} {add=[113 (1417184660074528768)]} 0 3
[junit4:junit4]   2> 12553 T764 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12554 T739 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 12555 T752 C57 P33048 /update {version=2&wt=javabin} {add=[113]} 0 10
[junit4:junit4]   2> 12560 T727 C58 P47338 /update {version=2&wt=javabin} {add=[114 (1417184660095500288)]} 0 2
[junit4:junit4]   2> 12590 T765 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=12 
[junit4:junit4]   2> 12592 T740 C55 P37947 /update {version=2&wt=javabin} {add=[114 (1417184660099694592)]} 0 29
[junit4:junit4]   2> 12597 T724 C58 P47338 /update {version=2&wt=javabin} {add=[115 (1417184660134297600)]} 0 2
[junit4:junit4]   2> 12608 T777 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=3 
[junit4:junit4]   2> 12609 T751 C57 P33048 /update {version=2&wt=javabin} {add=[115 (1417184660139540480)]} 0 9
[junit4:junit4]   2> 12615 T725 C58 P47338 /update {version=2&wt=javabin} {add=[116 (1417184660152123392)]} 0 2
[junit4:junit4]   2> 12628 T776 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12630 T753 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 12631 T738 C55 P37947 /update {version=2&wt=javabin} {add=[116]} 0 12
[junit4:junit4]   2> 12637 T726 C58 P47338 /update {version=2&wt=javabin} {add=[117 (1417184660175192064)]} 0 2
[junit4:junit4]   2> 12646 T779 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12648 T750 C57 P33048 /update {version=2&wt=javabin} {add=[117 (1417184660180434944)]} 0 8
[junit4:junit4]   2> 12653 T727 C58 P47338 /update {version=2&wt=javabin} {add=[118 (1417184660193017856)]} 0 1
[junit4:junit4]   2> 12671 T762 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12673 T741 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=13 
[junit4:junit4]   2> 12674 T752 C57 P33048 /update {version=2&wt=javabin} {add=[118]} 0 17
[junit4:junit4]   2> 12680 T724 C58 P47338 /update {version=2&wt=javabin} {add=[119 (1417184660220280832)]} 0 2
[junit4:junit4]   2> 12686 T778 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12686 T751 C57 P33048 /update {version=2&wt=javabin} {add=[119 (1417184660225523712)]} 0 4
[junit4:junit4]   2> 12689 T725 C58 P47338 /update {version=2&wt=javabin} {add=[120 (1417184660231815168)]} 0 0
[junit4:junit4]   2> 12696 T777 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12696 T753 C57 P33048 /update {version=2&wt=javabin} {add=[120 (1417184660234960896)]} 0 4
[junit4:junit4]   2> 12700 T726 C58 P47338 /update {version=2&wt=javabin} {add=[121 (1417184660242300928)]} 0 1
[junit4:junit4]   2> 12706 T776 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12707 T750 C57 P33048 /update {version=2&wt=javabin} {add=[121 (1417184660245446656)]} 0 5
[junit4:junit4]   2> 12716 T727 C58 P47338 /update {version=2&wt=javabin} {add=[122 (1417184660252786688)]} 0 7
[junit4:junit4]   2> 12724 T763 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12725 T739 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12725 T752 C57 P33048 /update {version=2&wt=javabin} {add=[122]} 0 7
[junit4:junit4]   2> 12730 T724 C58 P47338 /update {version=2&wt=javabin} {add=[123 (1417184660272709632)]} 0 2
[junit4:junit4]   2> 12738 T764 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12739 T740 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12740 T751 C57 P33048 /update {version=2&wt=javabin} {add=[123]} 0 7
[junit4:junit4]   2> 12743 T725 C58 P47338 /update {version=2&wt=javabin} {add=[124 (1417184660287389696)]} 0 1
[junit4:junit4]   2> 12751 T765 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12752 T738 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12753 T753 C57 P33048 /update {version=2&wt=javabin} {add=[124]} 0 8
[junit4:junit4]   2> 12756 T726 C58 P47338 /update {version=2&wt=javabin} {add=[125 (1417184660301021184)]} 0 1
[junit4:junit4]   2> 12762 T762 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12763 T741 C55 P37947 /update {version=2&wt=javabin} {add=[125 (1417184660304166912)]} 0 5
[junit4:junit4]   2> 12767 T727 C58 P47338 /update {version=2&wt=javabin} {add=[126 (1417184660312555520)]} 0 1
[junit4:junit4]   2> 12772 T778 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12773 T750 C57 P33048 /update {version=2&wt=javabin} {add=[126 (1417184660315701248)]} 0 4
[junit4:junit4]   2> 12776 T724 C58 P47338 /update {version=2&wt=javabin} {add=[127 (1417184660321992704)]} 0 1
[junit4:junit4]   2> 12795 T777 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=7 
[junit4:junit4]   2> 12796 T752 C57 P33048 /update {version=2&wt=javabin} {add=[127 (1417184660326187008)]} 0 18
[junit4:junit4]   2> 12800 T725 C58 P47338 /update {version=2&wt=javabin} {add=[128 (1417184660348207104)]} 0 1
[junit4:junit4]   2> 12809 T776 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12811 T751 C57 P33048 /update {version=2&wt=javabin} {add=[128 (1417184660351352832)]} 0 8
[junit4:junit4]   2> 12814 T727 C58 P47338 /update {version=2&wt=javabin} {add=[129 (1417184660361838592)]} 0 1
[junit4:junit4]   2> 12821 T763 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12822 T739 C55 P37947 /update {version=2&wt=javabin} {add=[129 (1417184660366032896)]} 0 6
[junit4:junit4]   2> 12825 T724 C58 P47338 /update {version=2&wt=javabin} {add=[130 (1417184660374421504)]} 0 1
[junit4:junit4]   2> 12833 T779 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12834 T753 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=4 
[junit4:junit4]   2> 12835 T740 C55 P37947 /update {version=2&wt=javabin} {add=[130]} 0 7
[junit4:junit4]   2> 12838 T726 C58 P47338 /update {version=2&wt=javabin} {add=[131 (1417184660387004416)]} 0 1
[junit4:junit4]   2> 12846 T778 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12846 T750 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=4 
[junit4:junit4]   2> 12847 T738 C55 P37947 /update {version=2&wt=javabin} {add=[131]} 0 7
[junit4:junit4]   2> 12862 T725 C58 P47338 /update {version=2&wt=javabin} {add=[132 (1417184660400635904)]} 0 12
[junit4:junit4]   2> 12871 T764 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12872 T741 C55 P37947 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12873 T752 C57 P33048 /update {version=2&wt=javabin} {add=[132]} 0 8
[junit4:junit4]   2> 12877 T727 C58 P47338 /update {version=2&wt=javabin} {add=[133 (1417184660426850304)]} 0 2
[junit4:junit4]   2> 12883 T762 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12884 T739 C55 P37947 /update {version=2&wt=javabin} {add=[133 (1417184660432093184)]} 0 5
[junit4:junit4]   2> 12888 T724 C58 P47338 /update {version=2&wt=javabin} {add=[134 (1417184660439433216)]} 0 1
[junit4:junit4]   2> 12895 T776 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=2 
[junit4:junit4]   2> 12896 T751 C57 P33048 /update {version=2&wt=javabin} {add=[134 (1417184660443627520)]} 0 6
[junit4:junit4]   2> 12900 T726 C58 P47338 /update {version=2&wt=javabin} {add=[135 (1417184660452016128)]} 0 1
[junit4:junit4]   2> 12906 T763 C54 P48026 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12907 T738 C55 P37947 /update {version=2&wt=javabin} {add=[135 (1417184660455161856)]} 0 5
[junit4:junit4]   2> 12910 T725 C58 P47338 /update {version=2&wt=javabin} {add=[136 (1417184660462501888)]} 0 1
[junit4:junit4]   2> 12919 T779 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=1 
[junit4:junit4]   2> 12920 T750 C57 P33048 REQ /update {update.distrib=TOLEADER&distrib.from=http://127.0.0.1:37947/solr/collection1/&version=2&wt=javabin} status=0 QTime=5 
[junit4:junit4]   2> 12920 T741 C55 P37947 /update {version=2&wt=javabin} {add=[136]} 0 7
[junit4:junit4]   2> 12924 T727 C58 P47338 /update {version=2&wt=javabin} {add=[137 (1417184660477181952)]} 0 1
[junit4:junit4]   2> 12929 T777 C56 P34208 REQ /update {update.distrib=FROMLEADER&distrib.from=http://127.0.0.1:33048/solr/collection1/&version=2&wt=javabin} status=0 QTime=0 
[junit4:junit4]   2> 12930 T752 C57 P33048 /update {version=2&wt=javabin} {add=[137 (1417184660480327680)]} 0 4
[junit4:junit4]   2> 12933 T724 C58 P47338

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

YPE.XML, SCHEMA-SPATIAL.XML, SOLRCONFIG-XINCLUDE.XML, SCHEMA-SPELLCHECKER.XML, XSLT, SOLRCONFIG-DELPOLICY2.XML, TRIVIAL.UPDATEPROCESSOR0.JS, KEEP-1.TXT, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA-TRIE.XML, SCHEMA-BINARYFIELD.XML, SCHEMA-COLLATEFILTER.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SCHEMA-MINIMAL.XML, STOPTYPES-2.TXT, SCHEMA_CODEC.XML, STEMDICT.TXT, ELEVATE.XML, SCHEMA-COLLATE.XML, PROTWORDS.TXT, SCHEMA-XINCLUDE.XML, SCHEMA-SNIPPET-FIELD.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMA-PHRASESUGGEST.XML, SCHEMA-DFR.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SOLRCONFIG-MASTER1.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-MASTER3.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-ALTDIRECTORY.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML]
[junit4:junit4]   2> 11742 T1676 oass.SolrIndexSearcher.<init> Opening Searcher@6e8e8b4a main
[junit4:junit4]   2> 11742 T1676 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 11743 T1676 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 11743 T1676 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 11744 T1676 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 11848 T1676 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 11864 T1676 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 11865 T1676 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 11865 T1676 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 11865 T1676 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 11866 T1676 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 11866 T1676 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 11867 T1676 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 11867 T1676 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 11867 T1676 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 11868 T1676 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 11874 T1683 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6e8e8b4a main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 11876 T1676 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 11877 T1676 oasu.AbstractSolrTestCase.setUp ####SETUP_END testFieldStatisticsResultsStringField
[junit4:junit4]   2> ASYNC  NEW_CORE C102 name=collection1 org.apache.solr.core.SolrCore@380f21a5
[junit4:junit4]   2> 11882 T1676 C102 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/index4660646611tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@32c6d8c8),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 11882 T1676 C102 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 11883 T1676 C102 UPDATE [collection1] webapp=null path=null params={} {add=[1]} 0 3
[junit4:junit4]   2> 11889 T1676 C102 UPDATE [collection1] webapp=null path=null params={} {add=[2]} 0 0
[junit4:junit4]   2> 11893 T1676 C102 UPDATE [collection1] webapp=null path=null params={} {add=[3]} 0 0
[junit4:junit4]   2> 11896 T1676 C102 UPDATE [collection1] webapp=null path=null params={} {add=[4]} 0 0
[junit4:junit4]   2> 11900 T1676 C102 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 11904 T1676 C102 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/index4660646611tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@32c6d8c8),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/index4660646611tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@32c6d8c8),segFN=segments_2,generation=2,filenames=[_0.tis, _0.si, segments_2, _0.tii, _0.frq, _0.fnm, _0.fdt, _0.prx, _0.fdx]
[junit4:junit4]   2> 11905 T1676 C102 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 11908 T1676 C102 oass.SolrIndexSearcher.<init> Opening Searcher@cdcf30fb main
[junit4:junit4]   2> 11908 T1676 C102 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 11909 T1676 C102 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 11910 T1683 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@cdcf30fb main{StandardDirectoryReader(segments_2:3 _0(4.1):C4)}
[junit4:junit4]   2> 11910 T1676 C102 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 10
[junit4:junit4]   2> 11913 T1676 C102 REQ [collection1] webapp=null path=null params={q=*:*&stats.field=active_s&indent=true&stats=true} hits=4 status=0 QTime=0 
[junit4:junit4]   2> 11915 T1676 oasu.AbstractSolrTestCase.tearDown ####TEARDOWN_START testFieldStatisticsResultsStringField
[junit4:junit4]   2> 11916 T1676 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=-1198162437
[junit4:junit4]   2> 11916 T1676 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@380f21a5
[junit4:junit4]   2> 11923 T1676 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 11924 T1676 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 11924 T1676 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 11925 T1676 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 11925 T1676 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> NOTE: test params are: codec=Lucene3x, sim=DefaultSimilarity, locale=en_CA, timezone=Iran
[junit4:junit4]   2> NOTE: Linux 3.2.0-32-generic amd64/IBM Corporation 1.7.0 (64-bit)/cpus=8,threads=1,free=82123232,total=165478400
[junit4:junit4]   2> NOTE: All tests run in this JVM: [UUIDFieldTest, TestTrie, TimeZoneUtilsTest, SuggesterTest, PrimitiveFieldTypeTest, TestRemoteStreaming, TermVectorComponentTest, TestMultiCoreConfBootstrap, FileUtilsTest, TestReplicationHandler, TestOmitPositions, TestDFRSimilarityFactory, UpdateParamsTest, TestDocSet, BasicDistributedZk2Test, XmlUpdateRequestHandlerTest, OverseerTest, TestSolrDeletionPolicy2, TestValueSourceCache, TestPhraseSuggestions, TestFastWriter, LukeRequestHandlerTest, EchoParamsTest, CoreContainerCoreInitFailuresTest, TestJmxIntegration, DocumentAnalysisRequestHandlerTest, TestBM25SimilarityFactory, ZkSolrClientTest, ZkCLITest, LegacyHTMLStripCharFilterTest, TestSolrDeletionPolicy1, TestPluginEnable, StandardRequestHandlerTest, TestReversedWildcardFilterFactory, TestCSVResponseWriter, TestDistributedSearch, DistributedQueryElevationComponentTest, FullSolrCloudDistribCmdsTest, DirectSolrSpellCheckerTest, FieldMutatingUpdateProcessorTest, ScriptEngineTest, RecoveryZkTest, IndexSchemaTest, IndexSchemaRuntimeFieldTest, TestSurroundQueryParser, DebugComponentTest, BasicFunctionalityTest, TestDistributedGrouping, OutputWriterTest, TestCSVLoader, TestRecovery, TestArbitraryIndexDir, ZkNodePropsTest, ConvertedLegacyTest, PingRequestHandlerTest, SpellCheckCollatorTest, SoftAutoCommitTest, AutoCommitTest, BasicZkTest, TestFaceting, StatsComponentTest]
[junit4:junit4] Completed on J1 in 3.09s, 7 tests, 1 error <<< FAILURES!

[...truncated 347 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:348: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:178: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/module-build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1159: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:827: There were test failures: 233 suites, 965 tests, 5 errors, 1 failure, 7 ignored (2 assumptions)

Total time: 40 minutes 30 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 64bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message