You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/11/24 15:44:23 UTC
[JENKINS] Lucene-Solr-trunk-MacOSX (64bit/jdk1.7.0) - Build # 1054
- Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1054/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
5 tests failed.
REGRESSION: org.apache.solr.cloud.BasicDistributedZk2Test.testDistribSearch
Error Message:
Expected content type application/octet-stream but got text/html;charset=ISO-8859-1. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/> <title>Error 404 Can not find: /uw_p/j/onenodecollectioncore/update</title> </head> <body> <h2>HTTP ERROR: 404</h2> <p>Problem accessing /uw_p/j/onenodecollectioncore/update. Reason: <pre> Can not find: /uw_p/j/onenodecollectioncore/update</pre></p> <hr /><i><small>Powered by Jetty://</small></i> </body> </html>
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Expected content type application/octet-stream but got text/html;charset=ISO-8859-1. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
<title>Error 404 Can not find: /uw_p/j/onenodecollectioncore/update</title>
</head>
<body>
<h2>HTTP ERROR: 404</h2>
<p>Problem accessing /uw_p/j/onenodecollectioncore/update. Reason:
<pre> Can not find: /uw_p/j/onenodecollectioncore/update</pre></p>
<hr /><i><small>Powered by Jetty://</small></i>
</body>
</html>
at __randomizedtesting.SeedInfo.seed([74C9E2853FE169FB:F52F6C9D48BE09C7]:0)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:455)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:197)
at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:116)
at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:102)
at org.apache.solr.cloud.BasicDistributedZk2Test.testNodeWithoutCollectionForwarding(BasicDistributedZk2Test.java:196)
at org.apache.solr.cloud.BasicDistributedZk2Test.doTest(BasicDistributedZk2Test.java:88)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:835)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
FAILED: org.apache.solr.analytics.NoFacetTest.stddevTest
Error Message:
Oops: (double raws) 4661448815188901888 - 4628496337733101339 < 4442235333156365461 Calculated diff 4661418334251202777 Let's see what the JVM thinks these bits are. FloatResult: 4299.0 floatTest: 27.72225134241226 Diff 4271.277748657588
Stack Trace:
java.lang.AssertionError: Oops: (double raws) 4661448815188901888 - 4628496337733101339 < 4442235333156365461 Calculated diff 4661418334251202777 Let's see what the JVM thinks these bits are. FloatResult: 4299.0 floatTest: 27.72225134241226 Diff 4271.277748657588
at __randomizedtesting.SeedInfo.seed([74C9E2853FE169FB:7109A2300F826DF4]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.analytics.NoFacetTest.stddevTest(NoFacetTest.java:227)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
FAILED: org.apache.solr.analytics.facet.QueryFacetTest.queryTest
Error Message:
The query facet dependencies [float3] either do not exist or are defined in a dependency looop.
Stack Trace:
org.apache.solr.common.SolrException: The query facet dependencies [float3] either do not exist or are defined in a dependency looop.
at __randomizedtesting.SeedInfo.seed([74C9E2853FE169FB:E9D0AC64594B266E]:0)
at org.apache.solr.analytics.request.AnalyticsRequestFactory.parse(AnalyticsRequestFactory.java:148)
at org.apache.solr.analytics.request.AnalyticsStats.execute(AnalyticsStats.java:66)
at org.apache.solr.handler.component.AnalyticsComponent.process(AnalyticsComponent.java:44)
at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:209)
at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:135)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:1866)
at org.apache.solr.util.TestHarness.query(TestHarness.java:291)
at org.apache.solr.util.TestHarness.query(TestHarness.java:273)
at org.apache.solr.analytics.facet.QueryFacetTest.queryTest(QueryFacetTest.java:105)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
FAILED: org.apache.solr.cloud.UnloadDistributedZkTest.testDistribSearch
Error Message:
Still found shard2 in collection test_unload_shard_and_collection
Stack Trace:
java.lang.AssertionError: Still found shard2 in collection test_unload_shard_and_collection
at __randomizedtesting.SeedInfo.seed([74C9E2853FE169FB:F52F6C9D48BE09C7]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.cloud.UnloadDistributedZkTest.testUnloadShardAndCollection(UnloadDistributedZkTest.java:128)
at org.apache.solr.cloud.UnloadDistributedZkTest.doTest(UnloadDistributedZkTest.java:78)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:835)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
FAILED: org.apache.solr.core.TestSolrXmlPersistor.simpleCoreDescriptorIsPersisted
Error Message:
expected:<...r><cores> <core [instanceDir="instance/dir/" name="testcore]"/> </cores></solr>> but was:<...r><cores> <core [name="testcore" instanceDir="instance/dir/]"/> </cores></solr>>
Stack Trace:
org.junit.ComparisonFailure: expected:<...r><cores>
<core [instanceDir="instance/dir/" name="testcore]"/>
</cores></solr>> but was:<...r><cores>
<core [name="testcore" instanceDir="instance/dir/]"/>
</cores></solr>>
at __randomizedtesting.SeedInfo.seed([74C9E2853FE169FB:14B942F79753FD69]:0)
at org.junit.Assert.assertEquals(Assert.java:125)
at org.junit.Assert.assertEquals(Assert.java:147)
at org.apache.solr.core.TestSolrXmlPersistor.simpleCoreDescriptorIsPersisted(TestSolrXmlPersistor.java:81)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
Build Log:
[...truncated 9867 lines...]
[junit4] Suite: org.apache.solr.analytics.facet.QueryFacetTest
[junit4] 2> log4j:WARN No such property [conversionPattern] in org.apache.solr.util.SolrLogLayout.
[junit4] 2> 2413 T11 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880
[junit4] 2> 2573 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 2581 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 2582 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 3513 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 3767 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 3788 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema-analytics.xml
[junit4] 2> 3826 T11 oass.IndexSchema.readSchema [null] Schema name=schema-docValues
[junit4] 2> 4341 T11 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 4370 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 4370 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr
[junit4] 2> 4371 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/'
[junit4] 2> 4482 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 4482 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr
[junit4] 2> 4483 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/'
[junit4] 2> 4744 T11 oasc.CoreContainer.<init> New CoreContainer 1470757647
[junit4] 2> 4748 T11 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/]
[junit4] 2> 4846 T11 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 4847 T11 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 4848 T11 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 4848 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 4850 T11 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 4850 T11 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 4851 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 4851 T11 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 4852 T11 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 5545 T11 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 5549 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 5557 T11 oasc.CoreContainer.load Host Name:
[junit4] 2> 5970 T12 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 5975 T12 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 5980 T12 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 5982 T12 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 6227 T12 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 6337 T12 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 6340 T12 oass.IndexSchema.readSchema Reading Solr Schema from schema-analytics.xml
[junit4] 2> 6365 T12 oass.IndexSchema.readSchema [collection1] Schema name=schema-docValues
[junit4] 2> 6450 T12 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 6593 T12 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 6628 T12 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880/
[junit4] 2> 6629 T12 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 6718 T12 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880
[junit4] 2> 6719 T12 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880/index/
[junit4] 2> 6720 T12 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880/index' doesn't exist. Creating new index...
[junit4] 2> 6738 T12 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880/index
[junit4] 2> 6741 T12 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=35, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=0.560546875, floorSegmentMB=0.6806640625, forceMergeDeletesPctAllowed=8.903328486429542, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6622220803292017
[junit4] 2> 6920 T12 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@465f396f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4d3a956),segFN=segments_1,generation=1}
[junit4] 2> 6924 T12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 7719 T12 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 7779 T12 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 7807 T12 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 7927 T12 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 7995 T12 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 7996 T12 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 7997 T12 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=698841335, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 8001 T12 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@465f396f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4d3a956),segFN=segments_1,generation=1}
[junit4] 2> 8001 T12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 8060 T12 oass.SolrIndexSearcher.<init> Opening Searcher@3444dd73 main
[junit4] 2> 8168 T12 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 8168 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3444dd73 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 8198 T11 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 8244 T11 oas.SolrTestCaseJ4.setUp ###Starting queryTest
[junit4] 2> ASYNC NEW_CORE C0 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 8772 T11 C0 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 8795 T11 C0 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 449
[junit4] 2> ASYNC NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9296 T11 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10000]} 0 449
[junit4] 2> ASYNC NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9336 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10001]} 0 3
[junit4] 2> 9352 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10002]} 0 3
[junit4] 2> 9368 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10003]} 0 4
[junit4] 2> ASYNC NEW_CORE C3 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9391 T11 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10004]} 0 3
[junit4] 2> 9406 T11 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10005]} 0 2
[junit4] 2> 9421 T11 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10006]} 0 2
[junit4] 2> ASYNC NEW_CORE C4 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9439 T11 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10007]} 0 4
[junit4] 2> 9453 T11 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10008]} 0 3
[junit4] 2> ASYNC NEW_CORE C5 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9483 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10009]} 0 3
[junit4] 2> 9501 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100010]} 0 0
[junit4] 2> 9513 T11 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100011]} 0 2
[junit4] 2> ASYNC NEW_CORE C6 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9539 T11 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100012]} 0 1
[junit4] 2> 9553 T11 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100013]} 0 3
[junit4] 2> 9570 T11 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100014]} 0 4
[junit4] 2> ASYNC NEW_CORE C7 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9586 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100015]} 0 3
[junit4] 2> 9599 T11 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100016]} 0 2
[junit4] 2> ASYNC NEW_CORE C8 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9614 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100017]} 0 2
[junit4] 2> 9628 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100018]} 0 2
[junit4] 2> 9644 T11 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100019]} 0 3
[junit4] 2> ASYNC NEW_CORE C9 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9661 T11 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100020]} 0 2
[junit4] 2> 9676 T11 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100021]} 0 3
[junit4] 2> 9689 T11 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100022]} 0 3
[junit4] 2> ASYNC NEW_CORE C10 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9712 T11 C10 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100023]} 0 1
[junit4] 2> 9725 T11 C10 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100024]} 0 2
[junit4] 2> ASYNC NEW_CORE C11 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9745 T11 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100025]} 0 0
[junit4] 2> 9762 T11 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100026]} 0 2
[junit4] 2> 9780 T11 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100027]} 0 4
[junit4] 2> ASYNC NEW_CORE C12 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9796 T11 C12 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100028]} 0 3
[junit4] 2> 9811 T11 C12 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100029]} 0 3
[junit4] 2> 9823 T11 C12 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100030]} 0 1
[junit4] 2> ASYNC NEW_CORE C13 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9842 T11 C13 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100031]} 0 3
[junit4] 2> 9857 T11 C13 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100032]} 0 3
[junit4] 2> ASYNC NEW_CORE C14 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9876 T11 C14 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100033]} 0 3
[junit4] 2> 9900 T11 C14 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100034]} 0 3
[junit4] 2> 9915 T11 C14 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100035]} 0 3
[junit4] 2> ASYNC NEW_CORE C15 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9931 T11 C15 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100036]} 0 3
[junit4] 2> 9963 T11 C15 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100037]} 0 1
[junit4] 2> ASYNC NEW_CORE C16 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 9997 T11 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100038]} 0 1
[junit4] 2> 10012 T11 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100039]} 0 2
[junit4] 2> 10024 T11 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100040]} 0 1
[junit4] 2> ASYNC NEW_CORE C17 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10038 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100041]} 0 0
[junit4] 2> 10051 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100042]} 0 2
[junit4] 2> 10064 T11 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100043]} 0 0
[junit4] 2> ASYNC NEW_CORE C18 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10080 T11 C18 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100044]} 0 1
[junit4] 2> 10094 T11 C18 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100045]} 0 2
[junit4] 2> ASYNC NEW_CORE C19 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10113 T11 C19 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100046]} 0 2
[junit4] 2> 10136 T11 C19 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100047]} 0 3
[junit4] 2> 10149 T11 C19 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100048]} 0 2
[junit4] 2> ASYNC NEW_CORE C20 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10166 T11 C20 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100049]} 0 1
[junit4] 2> 10185 T11 C20 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100050]} 0 5
[junit4] 2> 10198 T11 C20 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100051]} 0 2
[junit4] 2> ASYNC NEW_CORE C21 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10212 T11 C21 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100052]} 0 3
[junit4] 2> 10224 T11 C21 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100053]} 0 2
[junit4] 2> ASYNC NEW_CORE C22 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10241 T11 C22 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100054]} 0 3
[junit4] 2> 10255 T11 C22 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100055]} 0 3
[junit4] 2> 10272 T11 C22 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100056]} 0 4
[junit4] 2> ASYNC NEW_CORE C23 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10286 T11 C23 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100057]} 0 3
[junit4] 2> 10298 T11 C23 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100058]} 0 1
[junit4] 2> 10311 T11 C23 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100059]} 0 3
[junit4] 2> ASYNC NEW_CORE C24 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10325 T11 C24 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100060]} 0 3
[junit4] 2> 10337 T11 C24 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100061]} 0 3
[junit4] 2> ASYNC NEW_CORE C25 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10352 T11 C25 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100062]} 0 3
[junit4] 2> 10364 T11 C25 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100063]} 0 3
[junit4] 2> 10377 T11 C25 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100064]} 0 2
[junit4] 2> ASYNC NEW_CORE C26 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10392 T11 C26 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100065]} 0 3
[junit4] 2> 10405 T11 C26 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100066]} 0 3
[junit4] 2> 10418 T11 C26 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100067]} 0 2
[junit4] 2> ASYNC NEW_CORE C27 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10432 T11 C27 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100068]} 0 2
[junit4] 2> 10444 T11 C27 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100069]} 0 1
[junit4] 2> ASYNC NEW_CORE C28 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10460 T11 C28 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100070]} 0 1
[junit4] 2> 10471 T11 C28 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100071]} 0 2
[junit4] 2> 10484 T11 C28 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100072]} 0 2
[junit4] 2> ASYNC NEW_CORE C29 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10500 T11 C29 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100073]} 0 3
[junit4] 2> 10512 T11 C29 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100074]} 0 3
[junit4] 2> 10525 T11 C29 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100075]} 0 1
[junit4] 2> ASYNC NEW_CORE C30 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10543 T11 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100076]} 0 1
[junit4] 2> 10561 T11 C30 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100077]} 0 3
[junit4] 2> ASYNC NEW_CORE C31 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10575 T11 C31 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100078]} 0 2
[junit4] 2> 10588 T11 C31 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100079]} 0 3
[junit4] 2> 10601 T11 C31 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100080]} 0 3
[junit4] 2> ASYNC NEW_CORE C32 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10616 T11 C32 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100081]} 0 3
[junit4] 2> 10629 T11 C32 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100082]} 0 2
[junit4] 2> 10640 T11 C32 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100083]} 0 2
[junit4] 2> ASYNC NEW_CORE C33 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10654 T11 C33 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100084]} 0 3
[junit4] 2> 10667 T11 C33 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100085]} 0 2
[junit4] 2> ASYNC NEW_CORE C34 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10681 T11 C34 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100086]} 0 3
[junit4] 2> 10695 T11 C34 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100087]} 0 1
[junit4] 2> 10712 T11 C34 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100088]} 0 3
[junit4] 2> ASYNC NEW_CORE C35 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10724 T11 C35 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100089]} 0 2
[junit4] 2> 10736 T11 C35 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100090]} 0 2
[junit4] 2> 10747 T11 C35 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100091]} 0 2
[junit4] 2> ASYNC NEW_CORE C36 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10762 T11 C36 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100092]} 0 3
[junit4] 2> 10777 T11 C36 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100093]} 0 2
[junit4] 2> ASYNC NEW_CORE C37 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10793 T11 C37 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100094]} 0 2
[junit4] 2> 10806 T11 C37 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100095]} 0 0
[junit4] 2> 10817 T11 C37 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100096]} 0 2
[junit4] 2> ASYNC NEW_CORE C38 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10832 T11 C38 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100097]} 0 2
[junit4] 2> 10844 T11 C38 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100098]} 0 2
[junit4] 2> 10856 T11 C38 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100099]} 0 2
[junit4] 2> ASYNC NEW_CORE C39 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 10868 T11 C39 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C40 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 11525 T11 C40 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@465f396f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4d3a956),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@465f396f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4d3a956),segFN=segments_2,generation=2}
[junit4] 2> 11526 T11 C40 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> ASYNC NEW_CORE C41 name=collection1 org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 11737 T11 C41 oass.SolrIndexSearcher.<init> Opening Searcher@7cb60018 main
[junit4] 2> 11745 T11 C41 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 11751 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7cb60018 main{StandardDirectoryReader(segments_2:4:nrt _0(5.0):C100)}
[junit4] 2> 11753 T11 C41 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 886
[junit4] 2> 11891 T11 C41 oasc.SolrException.log ERROR org.apache.solr.common.SolrException: The query facet dependencies [float3] either do not exist or are defined in a dependency looop.
[junit4] 2> at org.apache.solr.analytics.request.AnalyticsRequestFactory.parse(AnalyticsRequestFactory.java:148)
[junit4] 2> at org.apache.solr.analytics.request.AnalyticsStats.execute(AnalyticsStats.java:66)
[junit4] 2> at org.apache.solr.handler.component.AnalyticsComponent.process(AnalyticsComponent.java:44)
[junit4] 2> at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:209)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:135)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:1866)
[junit4] 2> at org.apache.solr.util.TestHarness.query(TestHarness.java:291)
[junit4] 2> at org.apache.solr.util.TestHarness.query(TestHarness.java:273)
[junit4] 2> at org.apache.solr.analytics.facet.QueryFacetTest.queryTest(QueryFacetTest.java:105)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:606)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4] 2> at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 11893 T11 C41 oasc.SolrCore.execute [collection1] webapp=null path=null params={o.ir.qf.float1.q=float_fd:[*+TO+50]&q=*:*&o.lr.s.mean=mean(long_ld)&o.lr.s.sum=sum(long_ld)&o.pr.ff=string_sd&olap=true&o.pr.qf=float3&o.pr.qf=float4&o.pr.qf.float4.d=float3&o.ir.s.percentile_8=percentile(8,int_id)&o.pr.s.sum=sum(int_id)&o.ir.ff.string_sd.h=true&o.ir.s.median=median(int_id)&o.lr.qf=string&o.ir.s.sum=sum(int_id)&o.pr.hs.q3=concat(const_str(float_fd:[),+percentile(40,int_id),+const_str(+TO+),+median(int_id),+const_str(]))&o.ir.qf.float2.q=float_fd:[*+TO+30]&o.pr.s.mean=mean(int_id)&o.pr.s.percentile_8=percentile(8,int_id)&o.pr.hs.q2=concat(const_str(float_fd:[),+percentile(30,int_id),+const_str(+TO+),+median(int_id),+const_str(]))&o.fr.s.percentile_8=percentile(8,float_fd)&o.pr.s.median=median(int_id)&o.fr.s.sum=sum(float_fd)&o.pr.qf.float4.q=qresult(q1,float3,result(q1))&o.fr.qf.lad.q=long_ld:[20+TO+*]&o.fr.qf.lad.q=long_ld:[30+TO+*]&o.fr.qf.lad.q=double_dd:[*+TO+50]&o.ir.qf=float1&o.ir.qf=float2&o.pr.s.q1=concat(const_str(float_fd:[),+percentile(10,int_id),+const_str(+TO+),+median(int_id),+const_str(]))&o.pr.ff.string_sd.h=true&o.lr.s.percentile_8=percentile(8,long_ld)&o.pr.qf.float3.q=result(q1)&o.pr.qf.float3.q=result(q2)&o.pr.qf.float3.q=result(q3)&o.pr.qf.float3.q=result(q1,string_sd,abc2)&o.fr.s.median=median(float_fd)&indent=true&o.lr.s.median=median(long_ld)&rows=0&o.ir.s.mean=mean(int_id)&o.lr.qf.string.q=string_sd:abc1&o.lr.qf.string.q=string_sd:abc2&o.ir.ff=string_sd&o.fr.qf=lad&o.fr.s.mean=mean(float_fd)} hits=100 status=400 QTime=111
[junit4] 2> 11894 T11 oas.SolrTestCaseJ4.tearDown ###Ending queryTest
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=QueryFacetTest -Dtests.method=queryTest -Dtests.seed=74C9E2853FE169FB -Dtests.slow=true -Dtests.locale=ar_AE -Dtests.timezone=America/Santo_Domingo -Dtests.file.encoding=UTF-8
[junit4] ERROR 3.77s | QueryFacetTest.queryTest <<<
[junit4] > Throwable #1: org.apache.solr.common.SolrException: The query facet dependencies [float3] either do not exist or are defined in a dependency looop.
[junit4] > at __randomizedtesting.SeedInfo.seed([74C9E2853FE169FB:E9D0AC64594B266E]:0)
[junit4] > at org.apache.solr.analytics.request.AnalyticsRequestFactory.parse(AnalyticsRequestFactory.java:148)
[junit4] > at org.apache.solr.analytics.request.AnalyticsStats.execute(AnalyticsStats.java:66)
[junit4] > at org.apache.solr.handler.component.AnalyticsComponent.process(AnalyticsComponent.java:44)
[junit4] > at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:209)
[junit4] > at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:135)
[junit4] > at org.apache.solr.core.SolrCore.execute(SolrCore.java:1866)
[junit4] > at org.apache.solr.util.TestHarness.query(TestHarness.java:291)
[junit4] > at org.apache.solr.util.TestHarness.query(TestHarness.java:273)
[junit4] > at org.apache.solr.analytics.facet.QueryFacetTest.queryTest(QueryFacetTest.java:105)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] 2> 11972 T11 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 11972 T11 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1470757647
[junit4] 2> 11973 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5a8c8e1c
[junit4] 2> 11974 T11 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=100,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4] 2> 11975 T11 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 11976 T11 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 11976 T11 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 11978 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 11979 T11 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 11981 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880/index;done=false>>]
[junit4] 2> 11981 T11 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880/index
[junit4] 2> 11982 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880 [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880;done=false>>]
[junit4] 2> 11982 T11 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-QueryFacetTest-1385300853880
[junit4] 2> NOTE: test params are: codec=Lucene46: {id=PostingsFormat(name=Lucene41VarGapFixedInterval), int_id=PostingsFormat(name=NestedPulsing), float_fd=PostingsFormat(name=NestedPulsing), date_dtd=PostingsFormat(name=Lucene41VarGapFixedInterval), double_dd=TestBloomFilteredLucene41Postings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), long_ld=PostingsFormat(name=Lucene41VarGapFixedInterval), string_sd=PostingsFormat(name=NestedPulsing)}, docValues:{int_id=DocValuesFormat(name=Memory), doubledv=DocValuesFormat(name=Lucene45), intdv=DocValuesFormat(name=Memory), datedv=DocValuesFormat(name=Disk), stringdv=DocValuesFormat(name=Lucene45), float_fd=DocValuesFormat(name=Memory), date_dtd=DocValuesFormat(name=Lucene45), double_dd=DocValuesFormat(name=SimpleText), long_ld=DocValuesFormat(name=Lucene45), string_sd=DocValuesFormat(name=Memory), floatdv=DocValuesFormat(name=SimpleText), longdv=DocValuesFormat(name=SimpleText), stringdvm=DocValuesFormat(name=SimpleText)}, sim=DefaultSimilarity, locale=ar_AE, timezone=America/Santo_Domingo
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_45 (64-bit)/cpus=2,threads=1,free=7935120,total=40566784
[junit4] 2> NOTE: All tests run in this JVM: [QueryFacetTest]
[junit4] Completed in 12.49s, 1 test, 1 error <<< FAILURES!
[...truncated 34 lines...]
[junit4] Suite: org.apache.solr.analytics.NoFacetTest
[junit4] 2> 84548 T134 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385300935999
[junit4] 2> 84552 T134 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 84554 T134 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 84555 T134 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 84648 T134 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 84702 T134 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 84703 T134 oass.IndexSchema.readSchema Reading Solr Schema from schema-analytics.xml
[junit4] 2> 84710 T134 oass.IndexSchema.readSchema [null] Schema name=schema-docValues
[junit4] 2> 84808 T134 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 84817 T134 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 84822 T134 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr
[junit4] 2> 84822 T134 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/'
[junit4] 2> 84846 T134 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 84846 T134 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr
[junit4] 2> 84847 T134 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/'
[junit4] 2> 84934 T134 oasc.CoreContainer.<init> New CoreContainer 762479039
[junit4] 2> 84934 T134 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/]
[junit4] 2> 84936 T134 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 84936 T134 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 84936 T134 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 84936 T134 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 84937 T134 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 84937 T134 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 84937 T134 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 84938 T134 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 84938 T134 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 84954 T134 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 84954 T134 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 84955 T134 oasc.CoreContainer.load Host Name:
[junit4] 2> 84962 T135 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 84963 T135 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 84964 T135 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 84964 T135 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 85021 T135 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 85075 T135 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 85076 T135 oass.IndexSchema.readSchema Reading Solr Schema from schema-analytics.xml
[junit4] 2> 85083 T135 oass.IndexSchema.readSchema [collection1] Schema name=schema-docValues
[junit4] 2> 85136 T135 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 85138 T135 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 85138 T135 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385300935999/
[junit4] 2> 85139 T135 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 85140 T135 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385300935999
[junit4] 2> 85140 T135 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385300935999/index/
[junit4] 2> 85140 T135 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385300935999/index' doesn't exist. Creating new index...
[junit4] 2> 85141 T135 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385300935999/index
[junit4] 2> 85142 T135 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=40, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7829893680082892]
[junit4] 2> 85143 T135 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_1,generation=1}
[junit4] 2> 85143 T135 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 85144 T135 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 85145 T135 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 85145 T135 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 85155 T135 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 85163 T135 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 85164 T135 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 85165 T135 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=41, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=43.513671875, floorSegmentMB=1.1953125, forceMergeDeletesPctAllowed=14.877484562986659, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.33835717330594384
[junit4] 2> 85166 T135 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_1,generation=1}
[junit4] 2> 85166 T135 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 85167 T135 oass.SolrIndexSearcher.<init> Opening Searcher@3f37333a main
[junit4] 2> 85167 T135 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 85168 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3f37333a main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 85172 T134 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> ASYNC NEW_CORE C533 name=collection1 org.apache.solr.core.SolrCore@235e11a8
[junit4] 2> 85178 T134 C533 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 85179 T134 C533 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> ASYNC NEW_CORE C534 name=collection1 org.apache.solr.core.SolrCore@235e11a8
[junit4] 2> 85193 T134 C534 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10000]} 0 3
[junit4] 2> 85203 T134 C534 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 85217 T134 C534 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_2,generation=2}
[junit4] 2> 85217 T134 C534 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 85225 T134 C534 oass.SolrIndexSearcher.<init> Opening Searcher@31d73f05 main
[junit4] 2> 85226 T134 C534 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85226 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@31d73f05 main{StandardDirectoryReader(segments_2:4:nrt _0(5.0):c1)}
[junit4] 2> 85227 T134 C534 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 24
[junit4] 2> 85237 T134 C534 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10001]} 0 2
[junit4] 2> ASYNC NEW_CORE C535 name=collection1 org.apache.solr.core.SolrCore@235e11a8
[junit4] 2> 85249 T134 C535 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 85258 T134 C535 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_3,generation=3}
[junit4] 2> 85260 T134 C535 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 85262 T134 C535 oass.SolrIndexSearcher.<init> Opening Searcher@599b4ae9 main
[junit4] 2> 85263 T134 C535 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85263 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@599b4ae9 main{StandardDirectoryReader(segments_3:6:nrt _0(5.0):c1 _1(5.0):c1)}
[junit4] 2> 85264 T134 C535 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 15
[junit4] 2> 85279 T134 C535 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10002]} 0 2
[junit4] 2> 85288 T134 C535 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 85314 T134 C535 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_4,generation=4}
[junit4] 2> 85315 T134 C535 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 85326 T134 C535 oass.SolrIndexSearcher.<init> Opening Searcher@2051b2d4 main
[junit4] 2> 85327 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2051b2d4 main{StandardDirectoryReader(segments_4:8:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1)}
[junit4] 2> 85328 T134 C535 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85329 T134 C535 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 41
[junit4] 2> ASYNC NEW_CORE C536 name=collection1 org.apache.solr.core.SolrCore@235e11a8
[junit4] 2> 85343 T134 C536 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10003]} 0 2
[junit4] 2> 85351 T134 C536 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 85360 T134 C536 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_5,generation=5}
[junit4] 2> 85360 T134 C536 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 85363 T134 C536 oass.SolrIndexSearcher.<init> Opening Searcher@55e18fa main
[junit4] 2> 85364 T134 C536 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85364 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@55e18fa main{StandardDirectoryReader(segments_5:10:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1)}
[junit4] 2> 85365 T134 C536 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 14
[junit4] 2> 85375 T134 C536 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10004]} 0 2
[junit4] 2> ASYNC NEW_CORE C537 name=collection1 org.apache.solr.core.SolrCore@235e11a8
[junit4] 2> 85388 T134 C537 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 85396 T134 C537 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_6,generation=6}
[junit4] 2> 85397 T134 C537 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 85401 T134 C537 oass.SolrIndexSearcher.<init> Opening Searcher@2158326 main
[junit4] 2> 85403 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2158326 main{StandardDirectoryReader(segments_6:12:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1)}
[junit4] 2> 85403 T134 C537 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85404 T134 C537 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 16
[junit4] 2> 85414 T134 C537 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10005]} 0 3
[junit4] 2> 85422 T134 C537 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C538 name=collection1 org.apache.solr.core.SolrCore@235e11a8
[junit4] 2> 85438 T134 C538 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_7,generation=7}
[junit4] 2> 85439 T134 C538 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 85443 T134 C538 oass.SolrIndexSearcher.<init> Opening Searcher@6791d020 main
[junit4] 2> 85444 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6791d020 main{StandardDirectoryReader(segments_7:14:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1)}
[junit4] 2> 85446 T134 C538 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85446 T134 C538 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 24
[junit4] 2> 85461 T134 C538 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10006]} 0 3
[junit4] 2> 85472 T134 C538 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 85484 T134 C538 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_8,generation=8}
[junit4] 2> 85485 T134 C538 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 85489 T134 C538 oass.SolrIndexSearcher.<init> Opening Searcher@17c257da main
[junit4] 2> 85491 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@17c257da main{StandardDirectoryReader(segments_8:16:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1)}
[junit4] 2> 85492 T134 C538 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85492 T134 C538 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 20
[junit4] 2> ASYNC NEW_CORE C539 name=collection1 org.apache.solr.core.SolrCore@235e11a8
[junit4] 2> 85512 T134 C539 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10007]} 0 3
[junit4] 2> 85524 T134 C539 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 85536 T134 C539 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_9,generation=9}
[junit4] 2> 85537 T134 C539 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 85542 T134 C539 oass.SolrIndexSearcher.<init> Opening Searcher@396cc27f main
[junit4] 2> 85543 T134 C539 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85544 T136 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@396cc27f main{StandardDirectoryReader(segments_9:18:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1)}
[junit4] 2> 85545 T134 C539 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 22
[junit4] 2> 85556 T134 C539 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10008]} 0 1
[junit4] 2> ASYNC NEW_CORE C540 name=collection1 org.apache.solr.core.SolrCore@235e11a8
[junit4] 2> 85570 T134 C540 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 85585 T134 C540 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@18a7cf86 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@51182d70),segFN=segments_a,generation=10}
[junit4] 2> 85585 T134 C540 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
[junit4] 2> 85592 T134 C540 oass.SolrIndexSearcher.<init> Opening Searcher@37bedde6 main
[junit4] 2> 85594 T134 C540 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85595
[...truncated too long message...]
4] 1> /solr/overseer_elect/election/90787213556711436-127.0.0.1:50800_uw_p%2Fj-n_0000000004 (0)
[junit4] 1> /solr/live_nodes (5)
[junit4] 1> /solr/live_nodes/127.0.0.1:50786_uw_p%2Fj (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:50796_uw_p%2Fj (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:50793_uw_p%2Fj (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:50800_uw_p%2Fj (0)
[junit4] 1> /solr/live_nodes/127.0.0.1:50790_uw_p%2Fj (0)
[junit4] 1> /zookeeper (1)
[junit4] 1> DATA:
[junit4] 1>
[junit4] 1>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=BasicDistributedZk2Test -Dtests.method=testDistribSearch -Dtests.seed=74C9E2853FE169FB -Dtests.slow=true -Dtests.locale=ar_IQ -Dtests.timezone=Etc/GMT+9 -Dtests.file.encoding=UTF-8
[junit4] ERROR 32.9s | BasicDistributedZk2Test.testDistribSearch <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Expected content type application/octet-stream but got text/html;charset=ISO-8859-1. <html>
[junit4] > <head>
[junit4] > <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
[junit4] > <title>Error 404 Can not find: /uw_p/j/onenodecollectioncore/update</title>
[junit4] > </head>
[junit4] > <body>
[junit4] > <h2>HTTP ERROR: 404</h2>
[junit4] > <p>Problem accessing /uw_p/j/onenodecollectioncore/update. Reason:
[junit4] > <pre> Can not find: /uw_p/j/onenodecollectioncore/update</pre></p>
[junit4] > <hr /><i><small>Powered by Jetty://</small></i>
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] >
[junit4] > </body>
[junit4] > </html>
[junit4] > at __randomizedtesting.SeedInfo.seed([74C9E2853FE169FB:F52F6C9D48BE09C7]:0)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:455)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:197)
[junit4] > at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
[junit4] > at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:116)
[junit4] > at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:102)
[junit4] > at org.apache.solr.cloud.BasicDistributedZk2Test.testNodeWithoutCollectionForwarding(BasicDistributedZk2Test.java:196)
[junit4] > at org.apache.solr.cloud.BasicDistributedZk2Test.doTest(BasicDistributedZk2Test.java:88)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:835)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] 2> 2122705 T5365 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 32945 T5364 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 3 leaked thread(s).
[junit4] 2> 2122911 T5439 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 2124015 T5456 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> NOTE: test params are: codec=Asserting, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=ar_IQ, timezone=Etc/GMT+9
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_45 (64-bit)/cpus=2,threads=2,free=143241416,total=372277248
[junit4] 2> NOTE: All tests run in this JVM: [QueryFacetTest, TestDocBasedVersionConstraints, TestSystemIdResolver, DeleteShardTest, DocValuesMultiTest, StatsComponentTest, AbstractAnalyticsStatsTest, SpellCheckCollatorTest, FastVectorHighlighterTest, HighlighterConfigTest, ResponseLogComponentTest, NoFacetTest, TestNoOpRegenerator, SolrTestCaseJ4Test, TestSolr4Spatial, SolrIndexSplitterTest, TestUniqueKeyFieldResource, CopyFieldTest, TestDynamicFieldCollectionResource, DirectSolrConnectionTest, TestSurroundQueryParser, SimplePostToolTest, BadCopyFieldTest, ClusterStateUpdateTest, TestTrie, DOMUtilTest, TestReload, TestSolrQueryParserResource, TestQuerySenderListener, StressHdfsTest, HdfsRecoveryZkTest, TestRemoteStreaming, QueryEqualityTest, TestReplicationHandler, TestSolrQueryParserDefaultOperatorResource, TestSearchPerf, TestIndexSearcher, SchemaVersionSpecificBehaviorTest, TestRandomMergePolicy, TestShardHandlerFactory, StatelessScriptUpdateProcessorFactoryTest, TestWordDelimiterFilterFactory, TestCloudManagedSchemaAddField, TestBinaryResponseWriter, DirectUpdateHandlerOptimizeTest, SolrCmdDistributorTest, XmlUpdateRequestHandlerTest, TestFieldTypeCollectionResource, RAMDirectoryFactoryTest, SearchHandlerTest, UnloadDistributedZkTest, TestCSVLoader, SynonymTokenizerTest, DebugComponentTest, TestAddFieldRealTimeGet, CachingDirectoryFactoryTest, TestZkChroot, MigrateRouteKeyTest, ExternalFileFieldSortTest, TestSolrCoreProperties, TestQuerySenderNoQuery, TestStressVersions, TestJmxMonitoredMap, ReturnFieldsTest, CircularListTest, TestFieldTypeResource, TestFieldCollectionResource, TestNumberUtils, FieldFacetExtrasTest, TestCopyFieldCollectionResource, TestValueSourceCache, LoggingHandlerTest, IndexSchemaRuntimeFieldTest, TestCoreContainer, TestRandomDVFaceting, DistanceFunctionTest, SuggesterTest, ModifyConfFileTest, ZkNodePropsTest, IndexSchemaTest, SolrCoreTest, RangeFacetTest, TriLevelCompositeIdRoutingTest, TestHighFrequencyDictionaryFactory, HdfsDirectoryTest, ZkSolrClientTest, UpdateRequestProcessorFactoryTest, TestCloudManagedSchema, TestIndexingPerformance, HighlighterTest, TestLazyCores, DistributedQueryElevationComponentTest, XsltUpdateRequestHandlerTest, MultiTermTest, TestPartialUpdateDeduplication, TestBadConfig, ZkCLITest, LeaderElectionIntegrationTest, TestSolrQueryParser, SuggesterFSTTest, TestRecovery, PathHierarchyTokenizerFactoryTest, PreAnalyzedFieldTest, LukeRequestHandlerTest, TestPhraseSuggestions, AutoCommitTest, HardAutoCommitTest, TestCollationField, TermVectorComponentTest, TestPostingsSolrHighlighter, ShardRoutingTest, DateMathParserTest, TestNonNRTOpen, TestMaxScoreQueryParser, TestSolrIndexConfig, TestSolrXml, CSVRequestHandlerTest, DateFieldTest, FieldAnalysisRequestHandlerTest, CoreContainerCoreInitFailuresTest, BasicZkTest, FullSolrCloudDistribCmdsTest, ExpressionTest, ChaosMonkeySafeLeaderTest, CoreAdminHandlerTest, TestDistributedSearch, MinimalSchemaTest, TestStressRecovery, BasicDistributedZkTest, FileUtilsTest, TestRealTimeGet, TestCodecSupport, CacheHeaderTest, TestJmxIntegration, EnumFieldTest, TestFileDictionaryLookup, SolrCoreCheckLockOnStartupTest, NumericFieldsTest, ChaosMonkeyNothingIsSafeTest, TestDFRSimilarityFactory, TermsComponentTest, SoftAutoCommitTest, AbstractAnalyticsFacetTest, QueryElevationComponentTest, TestRangeQuery, TestPHPSerializedResponseWriter, TestPseudoReturnFields, LeaderElectionTest, TestExtendedDismaxParser, TestAnalyzeInfixSuggestions, CoreMergeIndexesAdminHandlerTest, TestArbitraryIndexDir, QueryResultKeyTest, TestAtomicUpdateErrorCases, PeerSyncTest, ScriptEngineTest, TestXIncludeConfig, TestSchemaSimilarityResource, SliceStateTest, FieldFacetTest, DisMaxRequestHandlerTest, MoreLikeThisHandlerTest, WordBreakSolrSpellCheckerTest, TestSolrXmlPersistor, BasicDistributedZk2Test]
[junit4] Completed in 34.53s, 1 test, 1 error <<< FAILURES!
[...truncated 566 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:420: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:400: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:39: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:37: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:189: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:492: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1275: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:908: There were test failures: 353 suites, 1558 tests, 2 errors, 3 failures, 40 ignored (6 assumptions)
Total time: 89 minutes 49 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-trunk-MacOSX (64bit/jdk1.7.0) - Build # 1055
- Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1055/
Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseSerialGC
4 tests failed.
REGRESSION: org.apache.solr.analytics.util.valuesource.FunctionTest.dateMathTest
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([F11095F97E260249:544004ABF6E663A6]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at org.apache.solr.analytics.util.valuesource.FunctionTest.dateMathTest(FunctionTest.java:172)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
REGRESSION: org.apache.solr.analytics.util.valuesource.FunctionTest.constantDateTest
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([F11095F97E260249:B4FC125F48354E0B]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at org.apache.solr.analytics.util.valuesource.FunctionTest.constantDateTest(FunctionTest.java:183)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
REGRESSION: org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.testDistribSearch
Error Message:
No live SolrServers available to handle this request:[http://127.0.0.1:50431/collection1, http://127.0.0.1:50393/collection1, http://127.0.0.1:50390/collection1, http://127.0.0.1:50413/collection1, http://127.0.0.1:50387/collection1, http://127.0.0.1:50396/collection1, http://127.0.0.1:50400/collection1]
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:50431/collection1, http://127.0.0.1:50393/collection1, http://127.0.0.1:50390/collection1, http://127.0.0.1:50413/collection1, http://127.0.0.1:50387/collection1, http://127.0.0.1:50396/collection1, http://127.0.0.1:50400/collection1]
at __randomizedtesting.SeedInfo.seed([F11095F97E260249:70F61BE109796275]:0)
at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:354)
at org.apache.solr.client.solrj.impl.CloudSolrServer.request(CloudSolrServer.java:640)
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.checkShardConsistency(AbstractFullDistribZkTestBase.java:1159)
at org.apache.solr.cloud.ChaosMonkeySafeLeaderTest.doTest(ChaosMonkeySafeLeaderTest.java:135)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:835)
at sun.reflect.GeneratedMethodAccessor39.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:50393/collection1
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:491)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:197)
at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:285)
... 45 more
FAILED: org.apache.solr.cloud.BasicDistributedZk2Test.testDistribSearch
Error Message:
Could not find the new collection - 404 : http://127.0.0.1:49817/i_vq/k/onenodecollectioncore
Stack Trace:
java.lang.AssertionError: Could not find the new collection - 404 : http://127.0.0.1:49817/i_vq/k/onenodecollectioncore
at __randomizedtesting.SeedInfo.seed([F11095F97E260249:70F61BE109796275]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForNon403or404or503(AbstractFullDistribZkTestBase.java:1797)
at org.apache.solr.cloud.BasicDistributedZk2Test.addAndQueryDocs(BasicDistributedZk2Test.java:206)
at org.apache.solr.cloud.BasicDistributedZk2Test.testNodeWithoutCollectionForwarding(BasicDistributedZk2Test.java:195)
at org.apache.solr.cloud.BasicDistributedZk2Test.doTest(BasicDistributedZk2Test.java:90)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:835)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
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:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
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:46)
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:744)
Build Log:
[...truncated 10085 lines...]
[junit4] Suite: org.apache.solr.cloud.BasicDistributedZk2Test
[junit4] 2> 998138 T2628 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /i_vq/k
[junit4] 2> 998149 T2628 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./solrtest-BasicDistributedZk2Test-1385324404638
[junit4] 2> 998154 T2628 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 2> 998156 T2629 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 998263 T2628 oasc.ZkTestServer.run start zk server on port:49807
[junit4] 2> 998265 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 998275 T2635 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@698759e5 name:ZooKeeperConnection Watcher:127.0.0.1:49807 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 998276 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 998276 T2628 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 998296 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 998303 T2637 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@451f905e name:ZooKeeperConnection Watcher:127.0.0.1:49807/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 998303 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 998304 T2628 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 998316 T2628 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 998328 T2628 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 998336 T2628 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 998346 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 998347 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 998363 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 998364 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 998375 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 998376 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 998392 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 998393 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4] 2> 998404 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 998405 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4] 2> 998419 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 998420 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4] 2> 998434 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 998435 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 998446 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 998447 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 998464 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 998464 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 998473 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 998474 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 998493 T2628 oasc.AbstractZkTestCase.putConfig put /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 998494 T2628 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4] 2> 998907 T2628 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 998923 T2628 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49810
[junit4] 2> 998924 T2628 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 998925 T2628 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 998926 T2628 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ./org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994
[junit4] 2> 998926 T2628 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994/'
[junit4] 2> 998966 T2628 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994/solr.xml
[junit4] 2> 999063 T2628 oasc.CoreContainer.<init> New CoreContainer 2071467605
[junit4] 2> 999063 T2628 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=./org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994/]
[junit4] 2> 999066 T2628 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 999066 T2628 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 999067 T2628 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 999067 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 999068 T2628 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 999069 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 999069 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 999069 T2628 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 999070 T2628 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 999090 T2628 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 999091 T2628 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 999091 T2628 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 999092 T2628 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49807/solr
[junit4] 2> 999092 T2628 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 999094 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 999098 T2648 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@26fedb03 name:ZooKeeperConnection Watcher:127.0.0.1:49807 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 999099 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 999108 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 999115 T2650 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7f3f3028 name:ZooKeeperConnection Watcher:127.0.0.1:49807/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 999115 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 999120 T2628 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 999140 T2628 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 999157 T2628 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 999162 T2628 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49810_i_vq%2Fk
[junit4] 2> 999165 T2628 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49810_i_vq%2Fk
[junit4] 2> 999176 T2628 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 999193 T2628 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 999200 T2628 oasc.Overseer.start Overseer (id=90788620183207939-127.0.0.1:49810_i_vq%2Fk-n_0000000000) starting
[junit4] 2> 999215 T2628 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 999228 T2652 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 999229 T2628 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 999237 T2628 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 999251 T2628 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 999260 T2651 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 999268 T2653 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 999269 T2653 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 999272 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 999272 T2653 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 999277 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 999278 T2651 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49810/i_vq/k",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49810_i_vq%2Fk",
[junit4] 2> "shard":null,
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "numShards":"1",
[junit4] 2> "core_node_name":null}
[junit4] 2> 999278 T2651 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with shards [shard1]
[junit4] 2> 999279 T2651 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4] 2> 999287 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 999290 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1000274 T2653 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 1000274 T2653 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ./org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994/collection1
[junit4] 2> 1000275 T2653 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
[junit4] 2> 1000278 T2653 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1000279 T2653 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
[junit4] 2> 1000287 T2653 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: './org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994/collection1/'
[junit4] 2> 1000289 T2653 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994/collection1/lib/classes/' to classloader
[junit4] 2> 1000290 T2653 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994/collection1/lib/README' to classloader
[junit4] 2> 1000359 T2653 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 1000421 T2653 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1000427 T2653 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1000439 T2653 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1001058 T2653 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1001072 T2653 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1001076 T2653 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1001126 T2653 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1001133 T2653 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1001140 T2653 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1001144 T2653 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1001145 T2653 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1001145 T2653 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1001149 T2653 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1001149 T2653 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1001149 T2653 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1001150 T2653 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ./org.apache.solr.cloud.BasicDistributedZk2Test-controljetty-1385324404994/collection1/, dataDir=./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/control/data/
[junit4] 2> 1001150 T2653 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@75fdc07f
[junit4] 2> 1001151 T2653 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/control/data
[junit4] 2> 1001151 T2653 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/control/data/index/
[junit4] 2> 1001151 T2653 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 1001152 T2653 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/control/data/index
[junit4] 2> 1001152 T2653 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=89.7060546875, floorSegmentMB=1.8994140625, forceMergeDeletesPctAllowed=26.814715707782103, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.24165324281530218
[junit4] 2> 1001153 T2653 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@7998150c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@27827296),segFN=segments_1,generation=1}
[junit4] 2> 1001153 T2653 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1001158 T2653 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 1001159 T2653 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1001159 T2653 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1001159 T2653 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1001160 T2653 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1001160 T2653 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1001161 T2653 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1001161 T2653 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1001161 T2653 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1001162 T2653 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1001162 T2653 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1001162 T2653 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1001163 T2653 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1001163 T2653 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1001164 T2653 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1001164 T2653 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1001173 T2653 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1001178 T2653 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1001178 T2653 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1001179 T2653 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1324226150, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1001179 T2653 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@7998150c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@27827296),segFN=segments_1,generation=1}
[junit4] 2> 1001179 T2653 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1001180 T2653 oass.SolrIndexSearcher.<init> Opening Searcher@190454aa main
[junit4] 2> 1001185 T2654 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@190454aa main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1001187 T2653 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1001187 T2653 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:49810/i_vq/k collection:control_collection shard:shard1
[junit4] 2> 1001189 T2653 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1001209 T2653 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 1001214 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1001216 T2653 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 1001216 T2653 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2209 name=collection1 org.apache.solr.core.SolrCore@39db891c url=http://127.0.0.1:49810/i_vq/k/collection1 node=127.0.0.1:49810_i_vq%2Fk C2209_STATE=coll:control_collection core:collection1 props:{state=down, base_url=http://127.0.0.1:49810/i_vq/k, core=collection1, node_name=127.0.0.1:49810_i_vq%2Fk}
[junit4] 2> 1001217 T2653 C2209 P49810 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:49810/i_vq/k/collection1/
[junit4] 2> 1001217 T2653 C2209 P49810 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 1001218 T2653 C2209 P49810 oasc.SyncStrategy.syncToMe http://127.0.0.1:49810/i_vq/k/collection1/ has no replicas
[junit4] 2> 1001219 T2653 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:49810/i_vq/k/collection1/ shard1
[junit4] 2> 1001219 T2653 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 1001218 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1001234 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1001236 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1001251 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1001263 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1001375 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1001398 T2653 oasc.ZkController.register We are http://127.0.0.1:49810/i_vq/k/collection1/ and leader is http://127.0.0.1:49810/i_vq/k/collection1/
[junit4] 2> 1001398 T2653 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:49810/i_vq/k
[junit4] 2> 1001398 T2653 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 1001398 T2653 oasc.ZkController.publish publishing core=collection1 state=active
[junit4] 2> 1001399 T2653 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1001402 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1001402 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1001402 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1001403 T2653 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1001406 T2628 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 1001407 T2628 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1001406 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1001408 T2651 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:49810/i_vq/k",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49810_i_vq%2Fk",
[junit4] 2> "shard":"shard1",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "numShards":"1",
[junit4] 2> "core_node_name":"core_node1"}
[junit4] 2> 1001410 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1001414 T2657 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@39885635 name:ZooKeeperConnection Watcher:127.0.0.1:49807/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1001415 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1001415 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1001419 T2628 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 1001426 T2628 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 1001521 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1001522 T2657 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1001799 T2628 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1001804 T2628 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49814
[junit4] 2> 1001804 T2628 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1001804 T2628 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1001805 T2628 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913
[junit4] 2> 1001805 T2628 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913/'
[junit4] 2> 1001833 T2628 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913/solr.xml
[junit4] 2> 1001932 T2628 oasc.CoreContainer.<init> New CoreContainer 120883903
[junit4] 2> 1001932 T2628 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913/]
[junit4] 2> 1001933 T2628 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 1001934 T2628 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1001934 T2628 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1001934 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1001934 T2628 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1001935 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1001935 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1001935 T2628 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1001935 T2628 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1001948 T2628 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1001948 T2628 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1001948 T2628 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1001948 T2628 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49807/solr
[junit4] 2> 1001949 T2628 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 1001950 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1001954 T2668 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@642b425 name:ZooKeeperConnection Watcher:127.0.0.1:49807 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1001954 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1001960 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1001964 T2670 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@53e7a6a9 name:ZooKeeperConnection Watcher:127.0.0.1:49807/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1001964 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1001979 T2628 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 1002994 T2628 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49814_i_vq%2Fk
[junit4] 2> 1002997 T2628 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49814_i_vq%2Fk
[junit4] 2> 1003004 T2657 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 1003006 T2670 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 1003006 T2650 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 1003022 T2671 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 1003022 T2671 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1003025 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1003026 T2671 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1003026 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1003026 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1003030 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1003032 T2651 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49814/i_vq/k",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49814_i_vq%2Fk",
[junit4] 2> "shard":null,
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 1003032 T2651 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2]
[junit4] 2> 1003032 T2651 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2
[junit4] 2> 1003040 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1003042 T2670 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1003042 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1003043 T2657 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1004028 T2671 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 1004028 T2671 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913/collection1
[junit4] 2> 1004029 T2671 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 1004032 T2671 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1004032 T2671 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 1004039 T2671 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913/collection1/'
[junit4] 2> 1004042 T2671 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913/collection1/lib/classes/' to classloader
[junit4] 2> 1004043 T2671 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913/collection1/lib/README' to classloader
[junit4] 2> 1004134 T2671 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 1004184 T2671 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1004188 T2671 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1004198 T2671 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1004809 T2671 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1004816 T2671 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1004819 T2671 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1004862 T2671 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1004868 T2671 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1004874 T2671 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1004878 T2671 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1004878 T2671 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1004879 T2671 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1004882 T2671 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1004882 T2671 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1004882 T2671 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1004882 T2671 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty1-1385324407913/collection1/, dataDir=./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty1/
[junit4] 2> 1004883 T2671 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@75fdc07f
[junit4] 2> 1004883 T2671 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty1
[junit4] 2> 1004884 T2671 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty1/index/
[junit4] 2> 1004884 T2671 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty1/index' doesn't exist. Creating new index...
[junit4] 2> 1004884 T2671 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty1/index
[junit4] 2> 1004885 T2671 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=89.7060546875, floorSegmentMB=1.8994140625, forceMergeDeletesPctAllowed=26.814715707782103, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.24165324281530218
[junit4] 2> 1004886 T2671 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@146fdcd5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@46e585b3),segFN=segments_1,generation=1}
[junit4] 2> 1004886 T2671 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1004905 T2671 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 1004906 T2671 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1004906 T2671 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1004907 T2671 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1004907 T2671 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1004908 T2671 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1004908 T2671 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1004909 T2671 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1004909 T2671 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1004911 T2671 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1004912 T2671 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1004912 T2671 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1004912 T2671 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1004913 T2671 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1004914 T2671 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1004914 T2671 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1004925 T2671 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1004929 T2671 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1004929 T2671 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1004930 T2671 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1324226150, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1004931 T2671 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@146fdcd5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@46e585b3),segFN=segments_1,generation=1}
[junit4] 2> 1004931 T2671 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1004931 T2671 oass.SolrIndexSearcher.<init> Opening Searcher@6d12e1a2 main
[junit4] 2> 1004936 T2672 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d12e1a2 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1004939 T2671 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1004939 T2671 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:49814/i_vq/k collection:collection1 shard:shard2
[junit4] 2> 1004940 T2671 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election
[junit4] 2> 1004962 T2671 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard2
[junit4] 2> 1004968 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1004970 T2671 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 1004970 T2671 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2210 name=collection1 org.apache.solr.core.SolrCore@55fb4e20 url=http://127.0.0.1:49814/i_vq/k/collection1 node=127.0.0.1:49814_i_vq%2Fk C2210_STATE=coll:collection1 core:collection1 props:{state=down, base_url=http://127.0.0.1:49814/i_vq/k, core=collection1, node_name=127.0.0.1:49814_i_vq%2Fk}
[junit4] 2> 1004970 T2671 C2210 P49814 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:49814/i_vq/k/collection1/
[junit4] 2> 1004970 T2671 C2210 P49814 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 1004971 T2671 C2210 P49814 oasc.SyncStrategy.syncToMe http://127.0.0.1:49814/i_vq/k/collection1/ has no replicas
[junit4] 2> 1004971 T2671 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:49814/i_vq/k/collection1/ shard2
[junit4] 2> 1004971 T2671 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
[junit4] 2> 1004971 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1004978 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1004981 T2657 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1004981 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1004982 T2670 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1004994 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1005003 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1005113 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1005114 T2670 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1005114 T2657 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1005143 T2671 oasc.ZkController.register We are http://127.0.0.1:49814/i_vq/k/collection1/ and leader is http://127.0.0.1:49814/i_vq/k/collection1/
[junit4] 2> 1005144 T2671 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:49814/i_vq/k
[junit4] 2> 1005145 T2671 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
[junit4] 2> 1005145 T2671 oasc.ZkController.publish publishing core=collection1 state=active
[junit4] 2> 1005146 T2671 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1005150 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1005151 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1005151 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1005153 T2671 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1005158 T2628 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 1005159 T2628 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1005159 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1005163 T2651 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"active",
[junit4] 2> "base_url":"http://127.0.0.1:49814/i_vq/k",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49814_i_vq%2Fk",
[junit4] 2> "shard":"shard2",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":"core_node1"}
[junit4] 2> 1005175 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1005281 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1005284 T2657 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1005284 T2670 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
[junit4] 2> 1005537 T2628 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1005541 T2628 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49817
[junit4] 2> 1005541 T2628 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1005541 T2628 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1005542 T2628 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649
[junit4] 2> 1005543 T2628 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649/'
[junit4] 2> 1005572 T2628 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649/solr.xml
[junit4] 2> 1005659 T2628 oasc.CoreContainer.<init> New CoreContainer 1653095137
[junit4] 2> 1005659 T2628 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649/]
[junit4] 2> 1005661 T2628 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 1005661 T2628 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 1005661 T2628 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1005661 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1005662 T2628 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1005662 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1005663 T2628 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1005663 T2628 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1005663 T2628 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1005676 T2628 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1005677 T2628 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1005677 T2628 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1005678 T2628 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49807/solr
[junit4] 2> 1005678 T2628 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 1005679 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1005684 T2684 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@28d461f3 name:ZooKeeperConnection Watcher:127.0.0.1:49807 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1005684 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1005690 T2628 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 1005695 T2686 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@64f683ad name:ZooKeeperConnection Watcher:127.0.0.1:49807/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1005695 T2628 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 1005707 T2628 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 1006720 T2628 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49817_i_vq%2Fk
[junit4] 2> 1006724 T2628 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49817_i_vq%2Fk
[junit4] 2> 1006741 T2686 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 1006742 T2650 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 1006742 T2657 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 1006742 T2670 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 1006776 T2687 oasc.ZkController.publish publishing core=collection1 state=down
[junit4] 2> 1006776 T2687 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4] 2> 1006781 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1006782 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1006782 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1006781 T2687 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 1006790 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1006794 T2651 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=2 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49817/i_vq/k",
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49817_i_vq%2Fk",
[junit4] 2> "shard":null,
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "core_node_name":null}
[junit4] 2> 1006795 T2651 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=2
[junit4] 2> 1006795 T2651 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4] 2> 1006809 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1006815 T2657 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1006815 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1006815 T2686 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1006815 T2670 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1007785 T2687 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
[junit4] 2> 1007786 T2687 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649/collection1
[junit4] 2> 1007786 T2687 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4] 2> 1007790 T2687 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 1007790 T2687 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1
[junit4] 2> 1007796 T2687 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649/collection1/'
[junit4] 2> 1007799 T2687 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649/collection1/lib/classes/' to classloader
[junit4] 2> 1007799 T2687 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649/collection1/lib/README' to classloader
[junit4] 2> 1007869 T2687 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 1007936 T2687 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1007941 T2687 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1007949 T2687 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1008562 T2687 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1008570 T2687 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1008573 T2687 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1008612 T2687 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1008618 T2687 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1008623 T2687 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1008627 T2687 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1008627 T2687 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1008627 T2687 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1008630 T2687 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1008630 T2687 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1008631 T2687 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1008631 T2687 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/./org.apache.solr.cloud.BasicDistributedZk2Test-jetty2-1385324411649/collection1/, dataDir=./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty2/
[junit4] 2> 1008631 T2687 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@75fdc07f
[junit4] 2> 1008632 T2687 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty2
[junit4] 2> 1008632 T2687 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty2/index/
[junit4] 2> 1008632 T2687 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty2/index' doesn't exist. Creating new index...
[junit4] 2> 1008632 T2687 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.cloud.BasicDistributedZk2Test-1385324404636/jetty2/index
[junit4] 2> 1008633 T2687 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=89.7060546875, floorSegmentMB=1.8994140625, forceMergeDeletesPctAllowed=26.814715707782103, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.24165324281530218
[junit4] 2> 1008634 T2687 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4dc0fd0b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@50373304),segFN=segments_1,generation=1}
[junit4] 2> 1008634 T2687 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1008641 T2687 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 1008642 T2687 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1008642 T2687 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1008643 T2687 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1008643 T2687 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1008643 T2687 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1008644 T2687 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1008644 T2687 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1008645 T2687 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1008646 T2687 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1008646 T2687 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1008647 T2687 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1008647 T2687 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1008648 T2687 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1008649 T2687 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1008650 T2687 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1008662 T2687 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1008666 T2687 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1008667 T2687 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1008668 T2687 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1324226150, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1008669 T2687 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@4dc0fd0b lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@50373304),segFN=segments_1,generation=1}
[junit4] 2> 1008669 T2687 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1008669 T2687 oass.SolrIndexSearcher.<init> Opening Searcher@58afdaac main
[junit4] 2> 1008674 T2688 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@58afdaac main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1008678 T2687 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1008678 T2687 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:49817/i_vq/k collection:collection1 shard:shard1
[junit4] 2> 1008680 T2687 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4] 2> 1008702 T2687 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
[junit4] 2> 1008712 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1008714 T2687 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4] 2> 1008714 T2687 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4] 2> ASYNC NEW_CORE C2211 name=collection1 org.apache.solr.core.SolrCore@50901d1f url=http://127.0.0.1:49817/i_vq/k/collection1 node=127.0.0.1:49817_i_vq%2Fk C2211_STATE=coll:collection1 core:collection1 props:{state=down, base_url=http://127.0.0.1:49817/i_vq/k, core=collection1, node_name=127.0.0.1:49817_i_vq%2Fk}
[junit4] 2> 1008714 T2687 C2211 P49817 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:49817/i_vq/k/collection1/
[junit4] 2> 1008715 T2687 C2211 P49817 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
[junit4] 2> 1008715 T2687 C2211 P49817 oasc.SyncStrategy.syncToMe http://127.0.0.1:49817/i_vq/k/collection1/ has no replicas
[junit4] 2> 1008715 T2687 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:49817/i_vq/k/collection1/ shard1
[junit4] 2> 1008716 T2687 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4] 2> 1008716 T2651 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 1008725 T2650 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 1008729 T2657 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1008730 T2650 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1008732 T2670 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3)
[junit4] 2> 1008733 T2686 oascc
[...truncated too long message...]
pleText), mult_ldf_dd=PostingsFormat(name=Memory doPackFST= true), neg_i_dd=PostingsFormat(name=Memory doPackFST= false)}, docValues:{int_id=DocValuesFormat(name=Disk), div_if_dd=DocValuesFormat(name=Memory), datedv=DocValuesFormat(name=Memory), const_04_dtd=DocValuesFormat(name=Lucene45), neg_l_dd=DocValuesFormat(name=SimpleText), const_8_dd=DocValuesFormat(name=Disk), string_sd=DocValuesFormat(name=Disk), date_dtd=DocValuesFormat(name=Disk), add_if_dd=DocValuesFormat(name=Memory), rev_sd=DocValuesFormat(name=Lucene45), longdv=DocValuesFormat(name=Memory), pow_ld_dd=DocValuesFormat(name=Memory), concat_first_sd=DocValuesFormat(name=Disk), floatdv=DocValuesFormat(name=Memory), dm_2m_dtd=DocValuesFormat(name=Memory), dm_2y_dtd=DocValuesFormat(name=Memory), pow_if_dd=DocValuesFormat(name=Disk), long_ld=DocValuesFormat(name=Disk), stringdvm=DocValuesFormat(name=Memory), const_10_dd=DocValuesFormat(name=Memory), intdv=DocValuesFormat(name=Lucene45), div_ld_dd=DocValuesFormat(name=Lucene45), const_first_sd=DocValuesFormat(name=SimpleText), doubledv=DocValuesFormat(name=Disk), add_ldf_dd=DocValuesFormat(name=Disk), const_second_sd=DocValuesFormat(name=Memory), mult_if_dd=DocValuesFormat(name=Disk), stringdv=DocValuesFormat(name=Disk), const_00_dtd=DocValuesFormat(name=Lucene45), float_fd=DocValuesFormat(name=Lucene45), miss_dd=DocValuesFormat(name=Disk), concat_second_sd=DocValuesFormat(name=Lucene45), double_dd=DocValuesFormat(name=Memory), neg_i_dd=DocValuesFormat(name=Lucene45), mult_ldf_dd=DocValuesFormat(name=Memory)}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ja_JP_JP_#u-ca-japanese, timezone=America/Antigua
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_45 (64-bit)/cpus=2,threads=1,free=59280040,total=256602112
[junit4] 2> NOTE: All tests run in this JVM: [TestSolrQueryParserResource, DefaultValueUpdateProcessorTest, TestSolrDeletionPolicy1, TestDefaultSimilarityFactory, HdfsRecoveryZkTest, InfoHandlerTest, TestFieldCollectionResource, TestCloudManagedSchemaAddField, OverseerCollectionProcessorTest, TestCollationField, EnumFieldTest, SolrTestCaseJ4Test, TestUtils, FieldFacetExtrasTest, TestRealTimeGet, TestPHPSerializedResponseWriter, QueryFacetTest, TestSchemaVersionResource, SimplePostToolTest, DateMathParserTest, TestLFUCache, LukeRequestHandlerTest, TestQueryUtils, UpdateParamsTest, SuggesterTest, SyncSliceTest, StatsComponentTest, TestSolrXml, XsltUpdateRequestHandlerTest, SpellCheckCollatorTest, FullSolrCloudDistribCmdsTest, HdfsCollectionsAPIDistributedZkTest, TestDefaultSearchFieldResource, NoCacheHeaderTest, TestClassNameShortening, TestCodecSupport, HdfsUnloadDistributedZkTest, TestFaceting, TestJmxMonitoredMap, TestSimpleQParserPlugin, BadComponentTest, SOLR749Test, DocValuesTest, CoreAdminHandlerTest, TestFunctionQuery, WordBreakSolrSpellCheckerTest, TestCoreDiscovery, TestLMJelinekMercerSimilarityFactory, SearchHandlerTest, BasicZkTest, ScriptEngineTest, TestQuerySenderListener, TestZkChroot, PrimUtilsTest, TestReplicationHandler, PeerSyncTest, DeleteShardTest, TestSerializedLuceneMatchVersion, TestFoldingMultitermQuery, TestSolrXMLSerializer, TestLazyCores, RecoveryZkTest, TestBinaryField, MigrateRouteKeyTest, LegacyHTMLStripCharFilterTest, TestDynamicFieldCollectionResource, MoreLikeThisHandlerTest, TermsComponentTest, SolrIndexConfigTest, BJQParserTest, TestCharFilters, PolyFieldTest, RequiredFieldsTest, TestWriterPerf, LeaderElectionTest, TestQuerySenderNoQuery, ClusterStateUpdateTest, TestExtendedDismaxParser, SliceStateUpdateTest, UnloadDistributedZkTest, TestRecoveryHdfs, TestDocSet, TestStressVersions, SuggesterWFSTTest, BasicDistributedZk2Test, AlternateDirectoryTest, URLClassifyProcessorTest, TestSurroundQueryParser, StressHdfsTest, SliceStateTest, TestAnalyzeInfixSuggestions, TestSort, DistributedSpellCheckComponentTest, DistributedTermsComponentTest, HdfsDirectoryTest, TestFiltering, ExternalFileFieldSortTest, TestSolrXmlPersistor, HdfsBasicDistributedZkTest, PingRequestHandlerTest, RangeFacetTest, RegexBoostProcessorTest, ChangedSchemaMergeTest, TestStressLucene, QueryResultKeyTest, DocumentAnalysisRequestHandlerTest, TestOmitPositions, CSVRequestHandlerTest, CacheHeaderTest, TestDFRSimilarityFactory, TestFieldResource, DOMUtilTest, TestRangeQuery, TestDistributedGrouping, TestLuceneMatchVersion, TestFuzzyAnalyzedSuggestions, DirectSolrConnectionTest, DocValuesMultiTest, LeaderElectionIntegrationTest, DirectUpdateHandlerOptimizeTest, TestLMDirichletSimilarityFactory, TestFastWriter, TestWordDelimiterFilterFactory, TestAnalyzedSuggestions, HdfsLockFactoryTest, ModifyConfFileTest, OpenExchangeRatesOrgProviderTest, DistanceFunctionTest, FieldAnalysisRequestHandlerTest, TestSolrIndexConfig, HdfsChaosMonkeySafeLeaderTest, UniqFieldsUpdateProcessorFactoryTest, TestIndexingPerformance, TestSolrCoreProperties, TestSolr4Spatial, TestManagedSchemaFieldResource, TestSchemaSimilarityResource, TestImplicitCoreProperties, SchemaVersionSpecificBehaviorTest, ShardRoutingCustomTest, TestSchemaNameResource, TestMaxScoreQueryParser, TestFieldTypeResource, SolrPluginUtilsTest, SignatureUpdateProcessorFactoryTest, MBeansHandlerTest, SolrRequestParserTest, SpellingQueryConverterTest, TestAddFieldRealTimeGet, HighlighterConfigTest, FieldFacetTest, ShardRoutingTest, CoreContainerCoreInitFailuresTest, QueryElevationComponentTest, TestReloadAndDeleteDocs, TestSuggestSpellingConverter, TestConfig, SuggestComponentTest, AbstractAnalyticsStatsTest, CurrencyFieldOpenExchangeTest, TestPhraseSuggestions, TimeZoneUtilsTest, PathHierarchyTokenizerFactoryTest, TestHashPartitioner, SolrInfoMBeanTest, TestCopyFieldCollectionResource, TestNonNRTOpen, DocumentBuilderTest, DisMaxRequestHandlerTest, TestInfoStreamLogging, UpdateRequestProcessorFactoryTest, AssignTest, TestSchemaResource, TestDistributedSearch, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, TestRandomFaceting, ZkSolrClientTest, TestRandomDVFaceting, ZkCLITest, AutoCommitTest, TestRecovery, TermVectorComponentDistributedTest, ZkControllerTest, TestStressReorder, TestJoin, TestMultiCoreConfBootstrap, TestReload, HardAutoCommitTest, TestCoreContainer, SimpleFacetsTest, SolrCoreTest, SpellCheckComponentTest, TestGroupingSearch, SolrCmdDistributorTest, BadIndexSchemaTest, ConvertedLegacyTest, BasicFunctionalityTest, DirectUpdateHandlerTest, TestBadConfig, TestIndexSearcher, HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, SolrIndexSplitterTest, AnalysisAfterCoreReloadTest, SuggesterFSTTest, SuggesterTSTTest, TestTrie, SpatialFilterTest, TestCSVLoader, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, QueryEqualityTest, StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest, TestRemoteStreaming, DebugComponentTest, IndexBasedSpellCheckerTest, StandardRequestHandlerTest, DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory, TestQueryTypes, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, RequestHandlersTest, TestValueSourceCache, TermVectorComponentTest, TestSolrQueryParser, TestArbitraryIndexDir, FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, IndexSchemaTest, TestJmxIntegration, ReturnFieldsTest, JSONWriterTest, TestCSVResponseWriter, QueryParsingTest, JsonLoaderTest, BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication, TestComponentsName, TestBinaryResponseWriter, CopyFieldTest, ResponseLogComponentTest, TestStressRecovery, TestMergePolicyConfig, TestSolrDeletionPolicy2, MultiTermTest, SampleTest, TestSearchPerf, NumericFieldsTest, MinimalSchemaTest, TestElisionMultitermQuery, OutputWriterTest, TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest, SpellPossibilityIteratorTest, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, TestSweetSpotSimilarityFactory, TestPerFieldSimilarity, TestNumberUtils, TestIBSimilarityFactory, TestBM25SimilarityFactory, ResourceLoaderTest, TestFastOutputStream, PluginInfoTest, TestFastLRUCache, ChaosMonkeyNothingIsSafeTest, PreAnalyzedFieldTest, TestSystemIdResolver, DateFieldTest, RAMDirectoryFactoryTest, ClusterStateTest, TestSolrJ, TestLRUCache, TestDocumentBuilder, ZkNodePropsTest, SystemInfoHandlerTest, UUIDFieldTest, FileUtilsTest, CircularListTest, TestRTGBase, NoFacetTest, ExpressionTest, AbstractAnalyticsFacetTest, FunctionTest]
[junit4] Completed in 1.96s, 13 tests, 2 failures <<< FAILURES!
[...truncated 142 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:420: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:400: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:39: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:37: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:189: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:492: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1275: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:908: There were test failures: 353 suites, 1558 tests, 1 error, 3 failures, 40 ignored (5 assumptions)
Total time: 84 minutes 6 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure