Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/32/

5 tests failed.
FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test

Error Message:
Timeout occured while waiting response from server at: 
http://127.0.0.1:41346/o_d/nz

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:41346/o_d/nz
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:381)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.deletePartiallyCreatedCollection(CollectionsAPIDistributedZkTest.java:243)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:171)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        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:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:170)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
        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:272)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:495)
        ... 47 more


FAILED:  org.apache.solr.cloud.hdfs.HdfsChaosMonkeyNothingIsSafeTest.test

Error Message:
There were too many update fails (83 > 60) - we expect it can happen, but 
shouldn't easily

Stack Trace:
java.lang.AssertionError: There were too many update fails (83 > 60) - we 
expect it can happen, but shouldn't easily
        at 
__randomizedtesting.SeedInfo.seed([D16D03BF5A4DBE22:59393C65F4B1D3DA]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertFalse(Assert.java:68)
        at 
org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest.test(ChaosMonkeyNothingIsSafeTest.java:218)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        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:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test

Error Message:
Timeout occured while waiting response from server at: 
http://127.0.0.1:39334/_pbi/is

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:39334/_pbi/is
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:381)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:497)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:169)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        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:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:170)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
        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:272)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:495)
        ... 47 more


FAILED:  org.apache.solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest.test

Error Message:
There are still nodes recoverying - waited for 440 seconds

Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 440 
seconds
        at 
__randomizedtesting.SeedInfo.seed([D16D03BF5A4DBE22:59393C65F4B1D3DA]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:173)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:856)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1412)
        at 
org.apache.solr.cloud.TlogReplayBufferedWhileIndexingTest.test(TlogReplayBufferedWhileIndexingTest.java:99)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        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:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
        at 
__randomizedtesting.SeedInfo.seed([D16D03BF5A4DBE22:BA22A3C223426318]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        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:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11833 lines...]
   [junit4] Suite: 
org.apache.solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/init-core-data-001
   [junit4]   2> 1367398 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: 
/y_yh/yq
   [junit4]   1> Formatting using clusterid: testClusterID
   [junit4]   2> 1367517 WARN  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried 
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
   [junit4]   2> 1367529 WARN  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1367536 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log jetty-6.1.26
   [junit4]   2> 1367578 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log Extract 
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/hdfs
 to ./temp/Jetty_localhost_50178_hdfs____w7z669/webapp
   [junit4]   2> 1367676 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1368022 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:50178
   [junit4]   2> 1368238 WARN  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1368239 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log jetty-6.1.26
   [junit4]   2> 1368248 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log Extract 
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
 to ./temp/Jetty_localhost_47245_datanode____h84s6v/webapp
   [junit4]   2> 1368363 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1368783 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:47245
   [junit4]   2> 1368818 WARN  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
   [junit4]   2> 1368819 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log jetty-6.1.26
   [junit4]   2> 1368830 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log Extract 
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
 to ./temp/Jetty_localhost_54900_datanode____d1lfxd/webapp
   [junit4]   2> 1368988 INFO  (IPC Server handler 3 on 42133) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-609b957a-eb87-4b86-a516-64c985034ef8 node DatanodeRegistration(127.0.0.1, 
datanodeUuid=d87b82cb-19a0-4f74-8d31-601b97ff74b9, infoPort=47245, 
ipcPort=55194, storageInfo=lv=-56;cid=testClusterID;nsid=1621610907;c=0), 
blocks: 0, hasStaleStorages: true, processing time: 1 msecs
   [junit4]   2> 1368988 INFO  (IPC Server handler 3 on 42133) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-0ca90e83-b8d5-4e90-ba56-68c7e541c936 node DatanodeRegistration(127.0.0.1, 
datanodeUuid=d87b82cb-19a0-4f74-8d31-601b97ff74b9, infoPort=47245, 
ipcPort=55194, storageInfo=lv=-56;cid=testClusterID;nsid=1621610907;c=0), 
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
   [junit4]   2> 1369077 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log NO JSP Support for /, did not find 
org.apache.jasper.servlet.JspServlet
   [junit4]   2> 1369502 INFO  
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[D16D03BF5A4DBE22]-worker) 
[    ] o.m.log Started 
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:54900
   [junit4]   2> 1369780 INFO  (IPC Server handler 7 on 42133) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-0bc88fb3-df07-4c93-8a78-f4f729b6c52c node DatanodeRegistration(127.0.0.1, 
datanodeUuid=b219c554-45c5-440e-9567-24b80284e021, infoPort=54900, 
ipcPort=47114, storageInfo=lv=-56;cid=testClusterID;nsid=1621610907;c=0), 
blocks: 0, hasStaleStorages: true, processing time: 2 msecs
   [junit4]   2> 1369786 INFO  (IPC Server handler 7 on 42133) [    ] 
BlockStateChange BLOCK* processReport: from storage 
DS-753c5a94-f012-4d77-b2fe-45a31dff256a node DatanodeRegistration(127.0.0.1, 
datanodeUuid=b219c554-45c5-440e-9567-24b80284e021, infoPort=54900, 
ipcPort=47114, storageInfo=lv=-56;cid=testClusterID;nsid=1621610907;c=0), 
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
   [junit4]   2> 1369988 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1369988 INFO  (Thread-7826) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1369988 INFO  (Thread-7826) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1370090 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.ZkTestServer start zk server on port:48772
   [junit4]   2> 1370090 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1370102 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1370124 INFO  (zkCallback-599-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@fd9a771 name:ZooKeeperConnection 
Watcher:127.0.0.1:48772 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1370133 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1370133 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1370133 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 1370172 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1370172 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1370180 INFO  (zkCallback-600-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@68f02696 
name:ZooKeeperConnection Watcher:127.0.0.1:48772/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1370180 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1370180 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1370180 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 1370181 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 1370181 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 1370182 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 1370183 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 1370183 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1370184 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 1370184 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 1370185 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1370185 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1370186 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 1370186 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 1370187 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 1370187 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 1370188 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 1370188 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 1370189 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1370189 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 1370190 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1370190 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1370191 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1370191 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1370191 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1370192 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 1370192 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 1370192 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 1370250 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/cores/collection1
   [junit4]   2> 1370251 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1370335 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@9fa3506{/y_yh/yq,null,AVAILABLE}
   [junit4]   2> 1370335 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.e.j.s.ServerConnector Started 
ServerConnector@282ca27b{HTTP/1.1,[http/1.1]}{127.0.0.1:50424}
   [junit4]   2> 1370335 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.e.j.s.Server Started @1377419ms
   [junit4]   2> 1370335 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=hdfs://localhost:42133/hdfs__localhost_42133__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001_tempDir-002_control_data,
 hostContext=/y_yh/yq, hostPort=50424, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/cores}
   [junit4]   2> 1370335 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 1370335 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001'
   [junit4]   2> 1370335 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1370335 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1370336 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1370346 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1370358 INFO  (zkCallback-601-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@19688f22 
name:ZooKeeperConnection Watcher:127.0.0.1:48772/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1370362 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1370362 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1370371 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1370372 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/solr.xml
   [junit4]   2> 1370383 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/cores
   [junit4]   2> 1370383 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.CoreContainer New CoreContainer 929334778
   [junit4]   2> 1370383 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001]
   [junit4]   2> 1370384 WARN  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/lib
   [junit4]   2> 1370384 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 
90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : 
false,useRetries : false,
   [junit4]   2> 1370385 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1370385 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1370385 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1370385 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48772/solr
   [junit4]   2> 1370385 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1370385 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1370394 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1370414 INFO  (zkCallback-604-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@317e9f04 
name:ZooKeeperConnection Watcher:127.0.0.1:48772 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1370421 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1370421 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) [   
 ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1370447 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ConnectionManager Waiting for 
client to connect to ZooKeeper
   [junit4]   2> 1370461 INFO  
(zkCallback-605-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7dd991c3 
name:ZooKeeperConnection Watcher:127.0.0.1:48772/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1370461 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ConnectionManager Client is 
connected to ZooKeeper
   [junit4]   2> 1370472 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/queue
   [junit4]   2> 1370578 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 1370614 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 1370621 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 1370623 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 1370624 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1370625 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1370626 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/clusterstate.json
   [junit4]   2> 1370626 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/security.json
   [junit4]   2> 1370627 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ZkStateReader Updating cluster 
state from ZooKeeper... 
   [junit4]   2> 1370627 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (0)
   [junit4]   2> 1370628 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect
   [junit4]   2> 1370628 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 1370629 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1370629 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.LeaderElector Joined leadership 
election with path: 
/overseer_elect/election/95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000
   [junit4]   2> 1370629 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.OverseerElectionContext I am going to 
be the leader 127.0.0.1:50424_y_yh%2Fyq
   [junit4]   2> 1370629 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/leader
   [junit4]   2> 1370630 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.Overseer Overseer 
(id=95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000) starting
   [junit4]   2> 1370631 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/queue-work
   [junit4]   2> 1370633 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.OverseerAutoReplicaFailoverThread 
Starting OverseerAutoReplicaFailoverThread 
autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1370634 INFO  
(OverseerStateUpdate-95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.Overseer Starting to work on the main 
queue
   [junit4]   2> 1370634 INFO  
(OverseerCollectionConfigSetProcessor-95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000)
 [n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.OverseerTaskProcessor Process 
current queue of overseer operations
   [junit4]   2> 1370642 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50424_y_yh%2Fyq
   [junit4]   2> 1370643 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:50424_y_yh%2Fyq
   [junit4]   2> 1370643 INFO  
(OverseerStateUpdate-95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (0)
   [junit4]   2> 1370645 INFO  
(zkCallback-605-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ZkStateReader A live node change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], 
has occurred - updating... (live nodes size: [0])
   [junit4]   2> 1370648 INFO  
(zkCallback-605-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (1)
   [junit4]   2> 1370651 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.CoreContainer Security conf doesn't 
exist. Skipping setup for authorization module.
   [junit4]   2> 1370651 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.CoreContainer No authentication 
plugin used.
   [junit4]   2> 1370652 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.CorePropertiesLocator Looking for 
core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/cores
   [junit4]   2> 1370652 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.CoreDescriptor Created 
CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, 
schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, 
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 1370653 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.CorePropertiesLocator Found core 
collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/cores/collection1
   [junit4]   2> 1370653 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions
   [junit4]   2> 1370654 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1
   [junit4]   2> 1370654 INFO  
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[D16D03BF5A4DBE22]) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.s.SolrDispatchFilter 
SolrDispatchFilter.init() done
   [junit4]   2> 1370655 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1370655 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.ZkController numShards not found on descriptor - reading it from system 
property
   [junit4]   2> 1370655 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.ZkController look for our core node name
   [junit4]   2> 1370671 INFO  
(OverseerStateUpdate-95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.Overseer processMessage: queueSize: 
1, message = {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:50424/y_yh/yq";,
   [junit4]   2>   "node_name":"127.0.0.1:50424_y_yh%2Fyq",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1370678 INFO  
(OverseerStateUpdate-95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.o.ReplicaMutator Update state 
numShards=1 message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:50424/y_yh/yq";,
   [junit4]   2>   "node_name":"127.0.0.1:50424_y_yh%2Fyq",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1370686 INFO  
(OverseerStateUpdate-95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: control_collection
   [junit4]   2> 1370694 INFO  
(OverseerStateUpdate-95693743516286980-127.0.0.1:50424_y_yh%2Fyq-n_0000000000) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.o.ReplicaMutator Assigning new node 
to shard shard=shard1
   [junit4]   2> 1370714 INFO  
(zkCallback-605-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq    ] o.a.s.c.c.ZkStateReader A cluster state 
change: [WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1371656 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1371656 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.ZkController Check for collection zkNode:control_collection
   [junit4]   2> 1371656 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 1371656 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 1371656 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 1371657 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/cores/collection1'
   [junit4]   2> 1371657 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1371657 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1371658 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.Config loaded config solrconfig.xml with version 0 
   [junit4]   2> 1371661 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1371664 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0
   [junit4]   2> 1371671 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1371675 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1371725 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1371725 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1371726 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1371728 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1371777 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/configs/conf1', 
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1
   [junit4]   2> 1371777 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection control_collection
   [junit4]   2> 1371777 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory
   [junit4]   2> 1371778 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory 
solr.hdfs.home=hdfs://localhost:42133/solr_hdfs_home
   [junit4]   2> 1371778 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication 
disabled
   [junit4]   2> 1371778 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_D16D03BF5A4DBE22-001/control-001/cores/collection1],
 
dataDir=[hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data/]
   [junit4]   2> 1371778 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@188ae9e
   [junit4]   2> 1371786 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path 
hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data
   [junit4]   2> 1371827 WARN  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will 
wait 5 seconds and try again.
   [junit4]   2> 1376840 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data
   [junit4]   2> 1376841 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data/index/
   [junit4]   2> 1376862 WARN  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'hdfs:/localhost:42133/solr_hdfs_home/control_collection/core_node1/data/index' 
doesn't exist. Creating new index...
   [junit4]   2> 1376862 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path 
hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data/index
   [junit4]   2> 1376878 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] 
with direct memory allocation set to [true]
   [junit4]   2> 1376879 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, 
slab size of [16777216] will allocate [1] slabs and use ~[16777216] bytes
   [junit4]   2> 1376902 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.b.BlockDirectory Block cache on write is disabled
   [junit4]   2> 1376902 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data/index
   [junit4]   2> 1376903 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=47, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=19.99609375, 
floorSegmentMB=1.220703125, forceMergeDeletesPctAllowed=14.933082781567812, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.41621666154360504
   [junit4]   2> 1377104 INFO  (IPC Server handler 5 on 42133) [    ] 
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:36236 is 
added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, 
primaryNodeIndex=-1, 
replicas=[ReplicaUnderConstruction[[DISK]DS-609b957a-eb87-4b86-a516-64c985034ef8:NORMAL:127.0.0.1:56411|RBW],
 
ReplicaUnderConstruction[[DISK]DS-753c5a94-f012-4d77-b2fe-45a31dff256a:NORMAL:127.0.0.1:36236|RBW]]}
 size 0
   [junit4]   2> 1377111 INFO  (IPC Server handler 4 on 42133) [    ] 
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56411 is 
added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, 
primaryNodeIndex=-1, 
replicas=[ReplicaUnderConstruction[[DISK]DS-753c5a94-f012-4d77-b2fe-45a31dff256a:NORMAL:127.0.0.1:36236|RBW],
 
ReplicaUnderConstruction[[DISK]DS-0ca90e83-b8d5-4e90-ba56-68c7e541c936:NORMAL:127.0.0.1:56411|FINALIZED]]}
 size 0
   [junit4]   2> 1377114 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(BlockDirectory(HdfsDirectory@hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5ea33787); 
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
   [junit4]   2> 1377114 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 1377119 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 1377120 WARN  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 1377121 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1377121 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1377122 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1377122 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1377275 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup 
for core collection1 in 
hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data/
   [junit4]   2> 1377278 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
   [junit4]   2> 1377278 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1377282 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.HdfsUpdateLog
   [junit4]   2> 1377282 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1377282 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: 
tlogDfsReplication=2
   [junit4]   2> 1377296 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
10000ms; 
   [junit4]   2> 1377296 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 3000ms; 
   [junit4]   2> 1377297 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@2dc175a3
   [junit4]   2> 1377305 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(BlockDirectory(HdfsDirectory@hdfs://localhost:42133/solr_hdfs_home/control_collection/core_node1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5ea33787); 
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
   [junit4]   2> 1377305 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1377305 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@dd949a3[collection1] 
main]
   [junit4]   2> 1377305 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 1377305 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 1377305 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based 
storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 1377305 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO 
with znodeBase: /configs/conf1
   [junit4]   2> 1377306 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 1377306 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1377306 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode 
/configs/conf1/_rest_managed.json
   [junit4]   2> 1377306 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1377306 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1377306 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1377310 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed 
version buckets
   [junit4]   2> 1377311 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 
65536 version buckets from index
   [junit4]   2> 1377311 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed 
version bucket highest value from index
   [junit4]   2> 1377311 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1531099903938265088
   [junit4]   2> 1377312 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with 
highest version 1531099903938265088
   [junit4]   2> 1377312 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 1377313 INFO  
(searcherExecutor-1725-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@dd949a3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1377313 INFO  
(coreLoadExecutor-1724-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1377319 INFO  
(coreZkRegister-1718-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController Register replica - core:collection1 
address:http://127.0.0.1:50424/y_yh/yq collection:control_collection 
shard:shard1
   [junit4]   2> 1377320 INFO  
(coreZkRegister-1718-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.c.SolrZkClient makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 1377322 INFO  
(coreZkRegister-1718-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.LeaderElector Joined leadership election with path: 
/collections/control_collection/leader_elect/shard1/election/95693743516286980-core_node1-n_0000000000
   [junit4]   2> 1377322 INFO  
(coreZkRegister-1718-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process 
for shard=shard1 and weAreReplacement=false and leaderVoteWait=300000
   [junit4]   2> 1377323 INFO  
(coreZkRegister-1718-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to 
continue.
   [junit4]   2> 1377323 INFO  
(coreZkRegister-1718-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try 
and sync
   [junit4]   2> 1377323 INFO  
(coreZkRegister-1718-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) 
[n:127.0.0.1:50424_y_yh%2Fyq c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:50424/y_yh/yq/collection1/
   [junit4]   2> 1377323 INFO  
(coreZkRegister-1718-thread-1-processing-n:127.0.0.1:50424_y_yh%2Fyq 
x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:5

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

c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 5569418 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 5569419 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 5569419 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 5569420 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 5569421 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 5569421 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 5569422 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 5569422 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 5569422 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 5569423 INFO  (zkCallback-3795-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 5569424 INFO  (zkCallback-3795-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 5569478 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 5569526 INFO  (zkCallback-3795-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 5569529 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:51486 51486
   [junit4]   2> 5569830 INFO  (Thread-83283) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:51486 51486
   [junit4]   2> 5569836 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[D16D03BF5A4DBE22])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 5569837 INFO  
(SUITE-ZkStateReaderTest-seed#[D16D03BF5A4DBE22]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_D16D03BF5A4DBE22-001
   [junit4]   2> Apr 09, 2016 4:07:26 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {}, 
docValues:{}, maxPointsInLeafNode=1357, maxMBSortInHeap=5.15693007768448, 
sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=ar-TN, 
timezone=America/Inuvik
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=304639336,total=493879296
   [junit4]   2> NOTE: All tests run in this JVM: [RollingRestartTest, 
DocValuesTest, TestLFUCache, SortByFunctionTest, SecurityConfHandlerTest, 
TestSolrFieldCacheMBean, TestMacros, 
OverriddenZkACLAndCredentialsProvidersTest, AliasIntegrationTest, 
TestBlobHandler, TestRequestForwarding, TestRecoveryHdfs, SpatialFilterTest, 
MinimalSchemaTest, OpenExchangeRatesOrgProviderTest, 
ChaosMonkeyNothingIsSafeTest, LeaderFailoverAfterPartitionTest, 
TestExactSharedStatsCache, TestGeoJSONResponseWriter, 
IndexBasedSpellCheckerTest, AddBlockUpdateTest, TestPKIAuthenticationPlugin, 
DistributedIntervalFacetingTest, TestHdfsUpdateLog, TestSchemaNameResource, 
ZkStateWriterTest, PreAnalyzedUpdateProcessorTest, 
SpellPossibilityIteratorTest, AtomicUpdatesTest, WordBreakSolrSpellCheckerTest, 
BigEndianAscendingWordDeserializerTest, TestUpdate, 
TestRandomRequestDistribution, TermVectorComponentTest, HighlighterTest, 
DirectSolrSpellCheckerTest, DistributedMLTComponentTest, 
HdfsTlogReplayBufferedWhileIndexingTest, MoreLikeThisHandlerTest, 
ZkSolrClientTest, SoftAutoCommitTest, SpellCheckComponentTest, 
ConfigSetsAPITest, TestHashPartitioner, HdfsChaosMonkeyNothingIsSafeTest, 
ShardSplitTest, TestSolrQueryParserResource, HdfsRestartWhileUpdatingTest, 
TestQueryTypes, TestBinaryResponseWriter, DocumentBuilderTest, 
FastVectorHighlighterTest, TestConfigSetsAPIExclusivity, TestTrie, 
CSVRequestHandlerTest, DOMUtilTest, CoreAdminRequestStatusTest, TestFiltering, 
SolrPluginUtilsTest, TestManagedResourceStorage, TestSurroundQueryParser, 
TestCursorMarkWithoutUniqueKey, TestReloadAndDeleteDocs, 
DistributedTermsComponentTest, TestSizeLimitedDistributedMap, 
TestSolrDeletionPolicy2, SolrInfoMBeanTest, NotRequiredUniqueKeyTest, 
TestBlendedInfixSuggestions, UpdateRequestProcessorFactoryTest, 
DateRangeFieldTest, BJQParserTest, TestScoreJoinQPScore, 
HighlighterMaxOffsetTest, TestBM25SimilarityFactory, 
SimpleCollectionCreateDeleteTest, DistribDocExpirationUpdateProcessorTest, 
TestInfoStreamLogging, StressHdfsTest, UUIDUpdateProcessorFallbackTest, 
CursorMarkTest, SpellingQueryConverterTest, BlockJoinFacetSimpleTest, 
TestCollapseQParserPlugin, DistributedFacetPivotSmallAdvancedTest, 
TestWordDelimiterFilterFactory, TestSimpleQParserPlugin, 
ChaosMonkeySafeLeaderTest, TestNonDefinedSimilarityFactory, 
TestFieldSortValues, RulesTest, TestPivotHelperCode, TestDistributedGrouping, 
TestFaceting, TestRecovery, TermVectorComponentDistributedTest, 
ZkControllerTest, TestStressReorder, TestJoin, TestStressVersions, 
SolrCoreTest, PeerSyncTest, TestFunctionQuery, BasicFunctionalityTest, 
TestLazyCores, ShowFileRequestHandlerTest, 
DistributedQueryElevationComponentTest, AnalysisAfterCoreReloadTest, 
SpellCheckCollatorTest, SolrRequestParserTest, TestStressLucene, 
SchemaVersionSpecificBehaviorTest, TestSolrDeletionPolicy1, TestQueryUtils, 
StandardRequestHandlerTest, TermsComponentTest, RequiredFieldsTest, 
IndexSchemaRuntimeFieldTest, IndexSchemaTest, TestCSVResponseWriter, 
MBeansHandlerTest, TestAnalyzedSuggestions, TestPartialUpdateDeduplication, 
TestQuerySenderListener, SolrIndexConfigTest, MultiTermTest, SampleTest, 
TestBinaryField, NumericFieldsTest, TestElisionMultitermQuery, TestConfig, 
TestFuzzyAnalyzedSuggestions, TestSolrCoreProperties, TestLuceneMatchVersion, 
TestPhraseSuggestions, TestCodecSupport, TestXIncludeConfig, 
TestDFRSimilarityFactory, TestPerFieldSimilarity, 
TestLMJelinekMercerSimilarityFactory, TestFastWriter, TestJmxMonitoredMap, 
TimeZoneUtilsTest, ResourceLoaderTest, TestFastOutputStream, ScriptEngineTest, 
TestFastLRUCache, DateMathParserTest, PreAnalyzedFieldTest, 
TestSystemIdResolver, PrimUtilsTest, TestSolrJ, TestUtils, TestDocumentBuilder, 
ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, FileUtilsTest, 
CircularListTest, TestRTGBase, CursorPagingTest, TestJettySolrRunner, 
AssignTest, AsyncCallRequestStatusResponseTest, CdcrReplicationHandlerTest, 
CollectionsAPIAsyncDistributedZkTest, CollectionsAPISolrJTest, 
DeleteInactiveReplicaTest, DeleteShardTest, DistribJoinFromCollectionTest, 
DistributedVersionInfoTest, HttpPartitionTest, MultiThreadedOCPTest, 
OverseerStatusTest, RecoveryAfterSoftCommitTest, ReplicationFactorTest, 
SaslZkACLProviderTest, TestCloudDeleteByQuery, TestCloudInspectUtil, 
TestCloudPivotFacet, TestCollectionAPI, TestConfigSetsAPI, 
TestDistribDocBasedVersion, TestLeaderInitiatedRecoveryThread, 
TestTolerantUpdateProcessorRandomCloud, HdfsCollectionsAPIDistributedZkTest, 
HdfsNNFailoverTest, HdfsRecoverLeaseTest, HdfsSyncSliceTest, 
TestClusterStateMutator, ZkStateReaderTest]
   [junit4] Completed [479/585 (5!)] on J1 in 3.20s, 5 tests, 1 error <<< 
FAILURES!

[...truncated 365 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:529:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014:
 There were test failures: 585 suites (10 ignored), 2363 tests, 3 errors, 2 
failures, 31 ignored (16 assumptions) [seed: D16D03BF5A4DBE22]

Total time: 296 minutes 45 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



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

Reply via email to