Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.x-Java7/2807/
4 tests failed. REGRESSION: org.apache.solr.search.function.TestFunctionQuery.testPseudoFieldFunctions Error Message: unexpected map keys [e] @ response/docs/[0] Stack Trace: java.lang.RuntimeException: unexpected map keys [e] @ response/docs/[0] at __randomizedtesting.SeedInfo.seed([FD655FAB80F513F4:A35FBDD6BC63EFB8]:0) at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:882) at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:829) at org.apache.solr.search.function.TestFunctionQuery.testPseudoFieldFunctions(TestFunctionQuery.java:739) 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:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.cloud.LeaderInitiatedRecoveryOnCommitTest.test Error Message: IOException occured when talking to server at: http://127.0.0.1:45323/c8n_1x3_commits_shard1_replica2 Stack Trace: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: http://127.0.0.1:45323/c8n_1x3_commits_shard1_replica2 at __randomizedtesting.SeedInfo.seed([FD655FAB80F513F4:753160712E097E0C]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:598) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:236) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:228) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:483) at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:464) at org.apache.solr.cloud.LeaderInitiatedRecoveryOnCommitTest.oneShardTest(LeaderInitiatedRecoveryOnCommitTest.java:130) at org.apache.solr.cloud.LeaderInitiatedRecoveryOnCommitTest.test(LeaderInitiatedRecoveryOnCommitTest.java:62) 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:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:958) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:933) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:490) ... 48 more FAILED: org.apache.solr.cloud.RecoveryAfterSoftCommitTest.test Error Message: org.apache.http.NoHttpResponseException: The target server failed to respond Stack Trace: org.apache.solr.client.solrj.SolrServerException: org.apache.http.NoHttpResponseException: The target server failed to respond at __randomizedtesting.SeedInfo.seed([FD655FAB80F513F4:753160712E097E0C]:0) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:929) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:782) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:174) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:139) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:153) at org.apache.solr.cloud.RecoveryAfterSoftCommitTest.test(RecoveryAfterSoftCommitTest.java:88) 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:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:958) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:933) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:490) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:236) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:228) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:370) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) at org.apache.solr.client.solrj.impl.CloudSolrClient$2.call(CloudSolrClient.java:596) at org.apache.solr.client.solrj.impl.CloudSolrClient$2.call(CloudSolrClient.java:593) at java.util.concurrent.FutureTask.run(FutureTask.java:262) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) ... 1 more FAILED: org.apache.solr.cloud.ReplicationFactorTest.test Error Message: org.apache.http.NoHttpResponseException: The target server failed to respond Stack Trace: org.apache.solr.client.solrj.SolrServerException: org.apache.http.NoHttpResponseException: The target server failed to respond at __randomizedtesting.SeedInfo.seed([FD655FAB80F513F4:753160712E097E0C]:0) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:929) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:782) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.ReplicationFactorTest.sendDoc(ReplicationFactorTest.java:308) at org.apache.solr.cloud.ReplicationFactorTest.testRf3(ReplicationFactorTest.java:234) at org.apache.solr.cloud.ReplicationFactorTest.test(ReplicationFactorTest.java:113) 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:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:958) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:933) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:490) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:236) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:228) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:370) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) at org.apache.solr.client.solrj.impl.CloudSolrClient$2.call(CloudSolrClient.java:596) at org.apache.solr.client.solrj.impl.CloudSolrClient$2.call(CloudSolrClient.java:593) at java.util.concurrent.FutureTask.run(FutureTask.java:262) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) ... 1 more Build Log: [...truncated 9327 lines...] [junit4] Suite: org.apache.solr.cloud.ReplicationFactorTest [junit4] 2> Creating dataDir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/init-core-data-001 [junit4] 2> 192707 T717 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: / [junit4] 2> 192714 T717 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 192715 T718 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 192814 T717 oasc.ZkTestServer.run start zk server on port:28322 [junit4] 2> 192815 T717 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 192816 T717 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 192821 T725 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6949e128 name:ZooKeeperConnection Watcher:127.0.0.1:28322 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 192822 T717 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 192822 T717 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 192823 T717 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 192826 T717 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 192827 T717 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 192829 T728 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5348dc06 name:ZooKeeperConnection Watcher:127.0.0.1:28322/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 192829 T717 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 192829 T717 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 192830 T717 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 192832 T717 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 192834 T717 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 192836 T717 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 192838 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 192839 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 192842 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 192843 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 192845 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 192846 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 192848 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 192849 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 192852 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 192853 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 192857 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 192858 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 192861 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 192862 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 192865 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 192866 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 192868 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 192869 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 192872 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 192873 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 192876 T717 oasc.AbstractZkTestCase.putConfig put /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 192877 T717 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 196205 T717 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1 [junit4] 2> 196210 T717 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 196216 T717 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:28347 [junit4] 2> 196217 T717 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostPort=28346, hostContext=/, coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores, solr.data.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/tempDir-001/control/data} [junit4] 2> 196218 T717 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@17072b90 [junit4] 2> 196218 T717 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/' [junit4] 2> 196262 T717 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/solr.xml [junit4] 2> 196334 T717 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores [junit4] 2> 196335 T717 oasc.CoreContainer.<init> New CoreContainer 1255981604 [junit4] 2> 196335 T717 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/] [junit4] 2> 196335 T717 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/lib [junit4] 2> 196336 T717 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/lib). [junit4] 2> 196349 T717 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 196350 T717 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 196350 T717 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 196350 T717 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 196351 T717 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 196351 T717 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 196351 T717 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 196352 T717 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 196352 T717 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 196352 T717 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 196353 T717 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 196353 T717 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 196354 T717 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 196355 T717 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 196355 T717 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 196356 T717 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:28322/solr [junit4] 2> 196356 T717 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 196357 T717 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 196358 T717 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 196361 T740 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3104da22 name:ZooKeeperConnection Watcher:127.0.0.1:28322 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 196361 T717 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 196362 T717 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 196365 T717 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 196367 T743 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@9ee1041 name:ZooKeeperConnection Watcher:127.0.0.1:28322/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 196367 T717 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 196369 T717 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 196372 T717 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 196376 T717 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 196379 T717 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 196383 T717 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 196388 T717 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 196391 T717 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 196394 T717 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 196396 T717 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:28346_ [junit4] 2> 196397 T717 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:28346_ [junit4] 2> 196399 T717 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 196402 T717 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 196404 T717 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 196407 T717 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:28346_ [junit4] 2> 196407 T717 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 196410 T717 oasc.Overseer.start Overseer (id=93513140082114563-127.0.0.1:28346_-n_0000000000) starting [junit4] 2> 196413 T717 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 196425 T717 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 196426 T745 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 196426 T717 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 196427 T744 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 196433 T717 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores [junit4] 2> 196441 T717 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {dataDir=data/, loadOnStartup=true, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/, shard=, coreNodeName=, collection=control_collection, name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1} [junit4] 2> 196442 T717 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/ [junit4] 2> 196442 T717 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 196444 T747 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection [junit4] 2> 196444 T747 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 196446 T743 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 196446 T747 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 196447 T744 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = { [junit4] 2> "shard":null, [junit4] 2> "operation":"state", [junit4] 2> "collection":"control_collection", [junit4] 2> "numShards":"1", [junit4] 2> "base_url":"http://127.0.0.1:28346", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:28346_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down"} current state version: 0 [junit4] 2> 196448 T744 oasco.ReplicaMutator.updateState Update state numShards=1 message={ [junit4] 2> "shard":null, [junit4] 2> "operation":"state", [junit4] 2> "collection":"control_collection", [junit4] 2> "numShards":"1", [junit4] 2> "base_url":"http://127.0.0.1:28346", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:28346_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down"} [junit4] 2> 196449 T744 oasco.ClusterStateMutator.createCollection building a new cName: control_collection [junit4] 2> 196450 T744 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1 [junit4] 2> 196452 T743 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> 197449 T747 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 197449 T747 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection [junit4] 2> 197450 T747 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 197450 T747 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 197451 T747 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 197451 T747 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/' [junit4] 2> 197478 T747 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1 [junit4] 2> 197482 T747 oasc.Config.<init> loaded config solrconfig.xml with version 0 [junit4] 2> 197510 T747 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 197552 T747 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.1.0 [junit4] 2> 197653 T747 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 197654 T747 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 197669 T747 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 198386 T747 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 198407 T747 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 198410 T747 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 198424 T747 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 198429 T747 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 198433 T747 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 198434 T747 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 198434 T747 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 198435 T747 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 198435 T747 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 198436 T747 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 198436 T747 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 198436 T747 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 198437 T747 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/data/ [junit4] 2> 198437 T747 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d4b307a [junit4] 2> 198438 T747 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/data [junit4] 2> 198438 T747 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/data/index/ [junit4] 2> 198438 T747 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 198439 T747 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/control-001/cores/collection1/data/index [junit4] 2> 198439 T747 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=28, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=46.85546875, floorSegmentMB=2.056640625, forceMergeDeletesPctAllowed=29.795733490044757, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 198440 T747 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@9802ccb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3dfcc84c),segFN=segments_1,generation=1} [junit4] 2> 198440 T747 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 198447 T747 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 198447 T747 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 198448 T747 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 198448 T747 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 198448 T747 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 198448 T747 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 198449 T747 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 198449 T747 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 198449 T747 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 198477 T747 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 198480 T747 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 198483 T747 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 198485 T747 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 198491 T747 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /get,/update/json/docs,/admin/system,/admin/mbeans,/admin/file,/admin/ping,/update,/admin/plugins,/admin/segments,/update/json,/config,/schema,standard,/admin/properties,/admin/threads,/admin/logging,/update/csv,/admin/luke,/replication [junit4] 2> 198494 T747 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 198498 T747 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 198499 T747 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 198502 T747 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 198502 T747 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 198503 T747 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=11, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.796074430601503] [junit4] 2> 198504 T747 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@9802ccb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3dfcc84c),segFN=segments_1,generation=1} [junit4] 2> 198505 T747 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 198505 T747 oass.SolrIndexSearcher.<init> Opening Searcher@5c11280b[collection1] main [junit4] 2> 198506 T747 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 198507 T747 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 198507 T747 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 198508 T747 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 198508 T747 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 198508 T747 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 198509 T747 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 198510 T747 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 198510 T747 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 198511 T747 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 198512 T748 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5c11280b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 198513 T747 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 198514 T751 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:28346 collection:control_collection shard:shard1 [junit4] 2> 198515 T717 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0 [junit4] 2> 198515 T717 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 198515 T751 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 198522 T717 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 198523 T717 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 198524 T751 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1 [junit4] 2> 198526 T755 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@25d54fd3 name:ZooKeeperConnection Watcher:127.0.0.1:28322/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 198526 T717 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 198527 T717 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 198527 T743 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 198528 T717 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 198528 T751 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 198530 T751 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> 198530 T744 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection"} current state version: 1 [junit4] 2> ASYNC NEW_CORE C133 name=collection1 org.apache.solr.core.SolrCore@4823d6ee url=http://127.0.0.1:28346/collection1 node=127.0.0.1:28346_ C133_STATE=coll:control_collection core:collection1 props:{base_url=http://127.0.0.1:28346, node_name=127.0.0.1:28346_, core=collection1, state=down} [junit4] 2> 198530 T751 C133 P28346 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:28346/collection1/ [junit4] 2> 198531 T751 C133 P28346 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 198531 T751 C133 P28346 oasc.SyncStrategy.syncToMe http://127.0.0.1:28346/collection1/ has no replicas [junit4] 2> 198532 T751 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:28346/collection1/ shard1 [junit4] 2> 198532 T751 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 198532 T743 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> 198532 T755 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 0) [junit4] 2> 198534 T717 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 198541 T743 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 198543 T744 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "base_url":"http://127.0.0.1:28346", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 2 [junit4] 2> 198648 T743 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> 198648 T755 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> 198705 T751 oasc.ZkController.register We are http://127.0.0.1:28346/collection1/ and leader is http://127.0.0.1:28346/collection1/ [junit4] 2> 198706 T751 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:28346 [junit4] 2> 198706 T751 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 198706 T751 oasc.ZkController.publish publishing core=collection1 state=active collection=control_collection [junit4] 2> 198707 T751 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 198708 T743 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 198709 T744 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = { [junit4] 2> "shard":"shard1", [junit4] 2> "operation":"state", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "collection":"control_collection", [junit4] 2> "numShards":"3", [junit4] 2> "base_url":"http://127.0.0.1:28346", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:28346_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 3 [junit4] 2> 198710 T744 oasco.ReplicaMutator.updateState Update state numShards=3 message={ [junit4] 2> "shard":"shard1", [junit4] 2> "operation":"state", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "collection":"control_collection", [junit4] 2> "numShards":"3", [junit4] 2> "base_url":"http://127.0.0.1:28346", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:28346_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} [junit4] 2> 198814 T743 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> 198814 T755 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> 201848 T717 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1 [junit4] 2> 201854 T717 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1 in directory /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001 [junit4] 2> 201857 T717 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 201860 T717 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:28389 [junit4] 2> 201863 T717 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores, hostContext=/, solr.data.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostPort=28388} [junit4] 2> 201864 T717 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@17072b90 [junit4] 2> 201865 T717 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/' [junit4] 2> 201930 T717 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/solr.xml [junit4] 2> 202002 T717 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores [junit4] 2> 202003 T717 oasc.CoreContainer.<init> New CoreContainer 2001211830 [junit4] 2> 202003 T717 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/] [junit4] 2> 202003 T717 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/lib [junit4] 2> 202004 T717 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/lib). [junit4] 2> 202017 T717 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 202017 T717 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 202017 T717 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 202018 T717 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 202018 T717 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 202018 T717 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 202019 T717 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 202019 T717 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 202019 T717 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 202020 T717 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 202020 T717 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 202021 T717 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 202021 T717 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 202021 T717 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 202022 T717 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 202022 T717 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:28322/solr [junit4] 2> 202022 T717 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 202022 T717 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 202024 T717 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 202026 T767 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6a594e7e name:ZooKeeperConnection Watcher:127.0.0.1:28322 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 202026 T717 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 202027 T717 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 202029 T717 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 202031 T770 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@30105abf name:ZooKeeperConnection Watcher:127.0.0.1:28322/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 202031 T717 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 202036 T717 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 203040 T717 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:28388_ [junit4] 2> 203041 T717 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:28388_ [junit4] 2> 203043 T717 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 203046 T717 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores [junit4] 2> 203049 T717 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {shard=, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/, config=solrconfig.xml, collection=collection1, loadOnStartup=true, dataDir=data/, schema=schema.xml, transient=false, name=collection1, coreNodeName=} [junit4] 2> 203049 T717 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/ [junit4] 2> 203050 T717 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 203051 T771 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 203051 T771 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 203052 T771 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 203052 T743 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 203053 T744 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = { [junit4] 2> "shard":null, [junit4] 2> "operation":"state", [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"3", [junit4] 2> "base_url":"http://127.0.0.1:28388", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:28388_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down"} current state version: 4 [junit4] 2> 203053 T744 oasco.ReplicaMutator.updateState Update state numShards=3 message={ [junit4] 2> "shard":null, [junit4] 2> "operation":"state", [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"3", [junit4] 2> "base_url":"http://127.0.0.1:28388", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:28388_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down"} [junit4] 2> 203054 T744 oasco.ClusterStateMutator.createCollection building a new cName: collection1 [junit4] 2> 203054 T744 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard3 [junit4] 2> 203055 T770 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> 203055 T743 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> 203055 T755 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> 204052 T771 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 204053 T771 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 204054 T771 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 204054 T771 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 204055 T771 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 204055 T771 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/' [junit4] 2> 204073 T771 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1 [junit4] 2> 204076 T771 oasc.Config.<init> loaded config solrconfig.xml with version 0 [junit4] 2> 204088 T771 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 204111 T771 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.1.0 [junit4] 2> 204160 T771 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 204162 T771 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 204172 T771 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 204807 T771 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 204831 T771 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 204835 T771 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 204857 T771 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 204865 T771 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 204873 T771 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 204875 T771 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 204875 T771 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 204875 T771 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 204876 T771 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 204877 T771 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 204877 T771 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 204877 T771 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 204878 T771 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/data/ [junit4] 2> 204878 T771 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d4b307a [junit4] 2> 204880 T771 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/data [junit4] 2> 204880 T771 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/data/index/ [junit4] 2> 204880 T771 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 204881 T771 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-1-001/cores/collection1/data/index [junit4] 2> 204881 T771 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=28, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=46.85546875, floorSegmentMB=2.056640625, forceMergeDeletesPctAllowed=29.795733490044757, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 204882 T771 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@fb46a24 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@da4698a),segFN=segments_1,generation=1} [junit4] 2> 204883 T771 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 204894 T771 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib" [junit4] 2> 204895 T771 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 204895 T771 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 204896 T771 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 204896 T771 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 204896 T771 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 204897 T771 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 204897 T771 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 204898 T771 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 204941 T771 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 204946 T771 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 204950 T771 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 204953 T771 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 204962 T771 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /get,/update/json/docs,/admin/system,/admin/mbeans,/admin/file,/admin/ping,/update,/admin/plugins,/admin/segments,/update/json,/config,/schema,standard,/admin/properties,/admin/threads,/admin/logging,/update/csv,/admin/luke,/replication [junit4] 2> 204965 T771 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 204968 T771 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 204968 T771 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 204970 T771 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 204970 T771 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 204971 T771 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=11, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.796074430601503] [junit4] 2> 204972 T771 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@fb46a24 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@da4698a),segFN=segments_1,generation=1} [junit4] 2> 204973 T771 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 204973 T771 oass.SolrIndexSearcher.<init> Opening Searcher@1a13ae7c[collection1] main [junit4] 2> 204973 T771 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 204974 T771 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 204975 T771 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 204975 T771 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 204975 T771 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 204976 T771 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 204977 T771 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 204977 T771 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 204977 T771 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 204978 T771 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 204980 T772 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a13ae7c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 204980 T771 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 204981 T775 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:28388 collection:collection1 shard:shard3 [junit4] 2> 204982 T717 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0 [junit4] 2> 204982 T717 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 204983 T775 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard3/election [junit4] 2> 204991 T775 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard3 [junit4] 2> 204993 T743 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 204993 T775 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 204994 T775 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C134 name=collection1 org.apache.solr.core.SolrCore@46ee015c url=http://127.0.0.1:28388/collection1 node=127.0.0.1:28388_ C134_STATE=coll:collection1 core:collection1 props:{base_url=http://127.0.0.1:28388, node_name=127.0.0.1:28388_, core=collection1, state=down} [junit4] 2> 204994 T775 C134 P28388 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:28388/collection1/ [junit4] 2> 204994 T744 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard3", [junit4] 2> "collection":"collection1"} current state version: 5 [junit4] 2> 204994 T775 C134 P28388 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 204995 T775 C134 P28388 oasc.SyncStrategy.syncToMe http://127.0.0.1:28388/collection1/ has no replicas [junit4] 2> 204995 T775 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:28388/collection1/ shard3 [junit4] 2> 204995 T775 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard3 [junit4] 2> 204996 T743 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> 204996 T770 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> 204996 T755 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> 205001 T743 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 205002 T744 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard3", [junit4] 2> "collection":"collection1", [junit4] 2> "base_url":"http://127.0.0.1:28388", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 6 [junit4] 2> 205107 T770 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> 205107 T755 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> 205107 T743 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> 205154 T775 oasc.ZkController.register We are http://127.0.0.1:28388/collection1/ and leader is http://127.0.0.1:28388/collection1/ [junit4] 2> 205155 T775 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:28388 [junit4] 2> 205155 T775 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 205155 T775 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1 [junit4] 2> 205155 T775 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 205157 T743 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 205158 T744 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = { [junit4] 2> "shard":"shard3", [junit4] 2> "operation":"state", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"3", [junit4] 2> "base_url":"http://127.0.0.1:28388", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:28388_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 7 [junit4] 2> 205159 T744 oasco.ReplicaMutator.updateState Update state numShards=3 message={ [junit4] 2> "shard":"shard3", [junit4] 2> "operation":"state", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"3", [junit4] 2> "base_url":"http://127.0.0.1:28388", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:28388_", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} [junit4] 2> 205262 T743 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> 205263 T770 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> 205263 T755 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> 207547 T717 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-2-001/cores/collection1 [junit4] 2> 207552 T717 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2 in directory /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-2-001 [junit4] 2> 207554 T717 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 207557 T717 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:28432 [junit4] 2> 207558 T717 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/, coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-2-001/cores, solrconfig=solrconfig.xml, hostPort=28431, solr.data.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/tempDir-001/jetty2} [junit4] 2> 207559 T717 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@17072b90 [junit4] 2> 207559 T717 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-2-001/' [junit4] 2> 207610 T717 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J0/temp/solr.cloud.ReplicationFactorTest FD655FAB80F513F4-001/shard-2-001/solr.xml [junit4] 2> 207665 T717 oasc.CorePropertiesLocator.<init> Config-defined core [...truncated too long message...] 2 C2125 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml&fl=noval_if:if(no__vals____d,42,-99)&fl=noval_def:def(no__vals____d,-99)&fl=noval_not:not(no__vals____d)&fl=noval_exists:exists(no__vals____d)} hits=1 status=0 QTime=0 [junit4] 2> 1878516 T5172 C2125 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml&fl=noval_if:if(no__vals____ti,42,-99)&fl=noval_def:def(no__vals____ti,-99)&fl=noval_not:not(no__vals____ti)&fl=noval_exists:exists(no__vals____ti)} hits=1 status=0 QTime=1 [junit4] 2> 1878521 T5172 C2125 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml&fl=noval_if:if(no__vals____tl,42,-99)&fl=noval_def:def(no__vals____tl,-99)&fl=noval_not:not(no__vals____tl)&fl=noval_exists:exists(no__vals____tl)} hits=1 status=0 QTime=1 [junit4] 2> 1878526 T5172 C2125 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml&fl=noval_if:if(no__vals____tf,42,-99)&fl=noval_def:def(no__vals____tf,-99)&fl=noval_not:not(no__vals____tf)&fl=noval_exists:exists(no__vals____tf)} hits=1 status=0 QTime=1 [junit4] 2> 1878531 T5172 C2125 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml&fl=noval_if:if(no__vals____td,42,-99)&fl=noval_def:def(no__vals____td,-99)&fl=noval_not:not(no__vals____td)&fl=noval_exists:exists(no__vals____td)} hits=1 status=0 QTime=0 [junit4] 2> 1878536 T5172 oas.SolrTestCaseJ4.tearDown ###Ending testMissingFieldFunctionBehavior [junit4] 2> 1878537 T5172 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> 1878537 T5172 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1866993293 [junit4] 2> 1878537 T5172 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@10098141 [junit4] 2> 1878538 T5172 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=52,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=121,cumulative_deletesById=0,cumulative_deletesByQuery=5,cumulative_errors=0} [junit4] 2> 1878538 T5172 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 1878538 T5172 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 1878539 T5172 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 1878539 T5172 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 1878540 T5172 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 1878540 T5172 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.search.function.TestFunctionQuery FD655FAB80F513F4-001/init-core-data-001 [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.search.function.TestFunctionQuery FD655FAB80F513F4-001/init-core-data-001;done=false>>] [junit4] 2> 1878540 T5172 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.search.function.TestFunctionQuery FD655FAB80F513F4-001/init-core-data-001 [junit4] 2> 1878541 T5172 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.search.function.TestFunctionQuery FD655FAB80F513F4-001/init-core-data-001/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.search.function.TestFunctionQuery FD655FAB80F513F4-001/init-core-data-001/index;done=false>>] [junit4] 2> 1878541 T5172 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.search.function.TestFunctionQuery FD655FAB80F513F4-001/init-core-data-001/index [junit4] 2> NOTE: leaving temporary files on disk at: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.search.function.TestFunctionQuery FD655FAB80F513F4-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {1-1_s=PostingsFormat(name=LuceneVarGapFixedInterval), x:x_i=PostingsFormat(name=Memory doPackFST= true), x_s=PostingsFormat(name=Memory doPackFST= true), x_td=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), a_t=PostingsFormat(name=LuceneFixedGap), foo_tl=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), text=PostingsFormat(name=LuceneVarGapFixedInterval), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), 1_s=PostingsFormat(name=LuceneVarGapFixedInterval), yak_i=PostingsFormat(name=LuceneVarGapFixedInterval), CoMpleX " fieldName _f=PostingsFormat(name=Memory doPackFST= true), eff_ti=PostingsFormat(name=LuceneVarGapFixedInterval), foo_s=PostingsFormat(name=LuceneFixedGap), sfile_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), x_i=PostingsFormat(name=LuceneFixedGap), foo_tf=PostingsFormat(name=LuceneVarGapFixedInterval), a_tdt=PostingsFormat(name=LuceneFixedGap), y_td=PostingsFormat(name=LuceneFixedGap), const_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), foo_d=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), foo_ti=PostingsFormat(name=LuceneFixedGap), b_tdt=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), foo_f=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{}, sim=DefaultSimilarity, locale=el_CY, timezone=America/Curacao [junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 (64-bit)/cpus=16,threads=1,free=125223376,total=435159040 [junit4] 2> NOTE: All tests run in this JVM: [SpellCheckComponentTest, TestBlendedInfixSuggestions, TestRebalanceLeaders, SpellPossibilityIteratorTest, TestShardHandlerFactory, XmlUpdateRequestHandlerTest, TestRequestStatusCollectionAPI, DistributedIntervalFacetingTest, TestSearcherReuse, TestPerFieldSimilarity, TestSimpleQParserPlugin, TestCloudSchemaless, TestSolrCoreProperties, PolyFieldTest, CursorMarkTest, TestTrackingShardHandlerFactory, TestLazyCores, CursorPagingTest, FileUtilsTest, DeleteShardTest, JsonLoaderTest, TestBulkSchemaConcurrent, DistributedSuggestComponentTest, TestStressUserVersions, TestConfig, TestGroupingSearch, TestZkChroot, TestDefaultStatsCache, TestComponentsName, PathHierarchyTokenizerFactoryTest, OverseerRolesTest, SuggesterTest, BufferStoreTest, TestFiltering, OutputWriterTest, DOMUtilTest, TestFieldCollectionResource, TestCloudInspectUtil, TestFieldTypeCollectionResource, TestQueryTypes, TestSurroundQueryParser, MoreLikeThisHandlerTest, HdfsBasicDistributedZk2Test, TestReloadAndDeleteDocs, FullSolrCloudDistribCmdsTest, TestTolerantSearch, MBeansHandlerTest, OutOfBoxZkACLAndCredentialsProvidersTest, CopyFieldTest, TestCharFilters, TestJmxMonitoredMap, HighlighterTest, PrimUtilsTest, PluginInfoTest, BinaryUpdateRequestHandlerTest, LeaderFailoverAfterPartitionTest, DistributedFacetPivotSmallAdvancedTest, ChaosMonkeyNothingIsSafeTest, LeaderElectionIntegrationTest, AsyncMigrateRouteKeyTest, DistribJoinFromCollectionTest, TestReplicaProperties, TestManagedSchemaDynamicFieldResource, TestManagedSchemaFieldResource, TriLevelCompositeIdRoutingTest, DistributedFacetPivotLargeTest, TestSimpleTrackingShardHandler, TestReload, SimpleCollectionCreateDeleteTest, AnalyticsMergeStrategyTest, ExitableDirectoryReaderTest, BlockDirectoryTest, TestIndexSearcher, ConnectionManagerTest, OverriddenZkACLAndCredentialsProvidersTest, AnalysisAfterCoreReloadTest, SolrRequestParserTest, SpellCheckCollatorTest, AtomicUpdatesTest, VMParamsZkACLAndCredentialsProvidersTest, TestFunctionQuery] [junit4] Completed on J1 in 2.89s, 15 tests, 1 error <<< FAILURES! [...truncated 453 lines...] BUILD FAILED /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:529: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:477: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:61: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/extra-targets.xml:39: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build.xml:191: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/common-build.xml:509: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:1370: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:976: There were test failures: 475 suites, 1892 tests, 4 errors, 62 ignored (22 assumptions) Total time: 53 minutes 47 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Sending artifact delta relative to Lucene-Solr-Tests-5.x-Java7 #2431 Archived 5 artifacts Archive block size is 32768 Received 0 blocks and 190041879 bytes Compression is 0.0% Took 36 sec Recording test results Email was triggered for: Failure Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org