Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/46/
4 tests failed. FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:34956 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:34956 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:399) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:457) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:179) 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.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([E4A8AA33FD235588:8FE70A4E842C88B2]:0) at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:47) 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) FAILED: org.apache.solr.core.TestDynamicLoading.testDynamicLoading Error Message: Could not get expected value 'X val' for path 'x' full output: { "responseHeader":{ "status":0, "QTime":0}, "params":{"wt":"json"}, "context":{ "webapp":"/izcsw/fi", "path":"/test1", "httpMethod":"GET"}, "class":"org.apache.solr.core.BlobStoreTestRequestHandler", "x":null}, from server: null Stack Trace: java.lang.AssertionError: Could not get expected value 'X val' for path 'x' full output: { "responseHeader":{ "status":0, "QTime":0}, "params":{"wt":"json"}, "context":{ "webapp":"/izcsw/fi", "path":"/test1", "httpMethod":"GET"}, "class":"org.apache.solr.core.BlobStoreTestRequestHandler", "x":null}, from server: null at __randomizedtesting.SeedInfo.seed([E4A8AA33FD235588:3CE587640AFEF028]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:457) at org.apache.solr.core.TestDynamicLoading.testDynamicLoading(TestDynamicLoading.java:233) 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: junit.framework.TestSuite.org.apache.solr.schema.TestManagedSchemaAPI Error Message: ObjectTracker found 2 object(s) that were not released!!! [RawDirectoryWrapper, RawDirectoryWrapper] Stack Trace: java.lang.AssertionError: ObjectTracker found 2 object(s) that were not released!!! [RawDirectoryWrapper, RawDirectoryWrapper] at __randomizedtesting.SeedInfo.seed([E4A8AA33FD235588]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNull(Assert.java:551) at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:256) at sun.reflect.GeneratedMethodAccessor26.invoke(Unknown Source) 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$7.evaluate(RandomizedRunner.java:834) 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 12585 lines...] [junit4] Suite: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/init-core-data-001 [junit4] 2> 4984762 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) [junit4] 2> 4984763 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 1> Formatting using clusterid: testClusterID [junit4] 2> 4984879 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 4984886 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 4984888 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 4984902 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-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_53376_hdfs____.w22kpu/webapp [junit4] 2> 4985313 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 4985752 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:53376 [junit4] 2> 4986124 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 4986124 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 4986139 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-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_34884_datanode____.vwciu/webapp [junit4] 2> 4986220 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 4986716 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:34884 [junit4] 2> 4986786 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 4986787 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 4986801 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-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_52885_datanode____.f4brfl/webapp [junit4] 2> 4986860 INFO (IPC Server handler 3 on 46173) [ ] BlockStateChange BLOCK* processReport: from storage DS-05c397af-2aed-495d-8940-f7529ea12c16 node DatanodeRegistration(127.0.0.1, datanodeUuid=491bf2dc-de19-4a9a-9e08-59b33e2919cb, infoPort=34884, ipcPort=58446, storageInfo=lv=-56;cid=testClusterID;nsid=1601857524;c=0), blocks: 0, hasStaleStorages: true, processing time: 1 msecs [junit4] 2> 4986860 INFO (IPC Server handler 3 on 46173) [ ] BlockStateChange BLOCK* processReport: from storage DS-78c9130c-bc66-4a0b-b96e-b175b3ef262c node DatanodeRegistration(127.0.0.1, datanodeUuid=491bf2dc-de19-4a9a-9e08-59b33e2919cb, infoPort=34884, ipcPort=58446, storageInfo=lv=-56;cid=testClusterID;nsid=1601857524;c=0), blocks: 0, hasStaleStorages: false, processing time: 0 msecs [junit4] 2> 4986904 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 4987407 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[E4A8AA33FD235588]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:52885 [junit4] 2> 4987765 INFO (IPC Server handler 5 on 46173) [ ] BlockStateChange BLOCK* processReport: from storage DS-baddebc8-147d-4674-8f2e-c4c141e5a61c node DatanodeRegistration(127.0.0.1, datanodeUuid=afdea3b6-b01d-437f-9ddf-31f9014a98f0, infoPort=52885, ipcPort=45964, storageInfo=lv=-56;cid=testClusterID;nsid=1601857524;c=0), blocks: 0, hasStaleStorages: true, processing time: 7 msecs [junit4] 2> 4987768 INFO (IPC Server handler 5 on 46173) [ ] BlockStateChange BLOCK* processReport: from storage DS-127a36df-b438-43e6-9824-c6268bcc922b node DatanodeRegistration(127.0.0.1, datanodeUuid=afdea3b6-b01d-437f-9ddf-31f9014a98f0, infoPort=52885, ipcPort=45964, storageInfo=lv=-56;cid=testClusterID;nsid=1601857524;c=0), blocks: 0, hasStaleStorages: false, processing time: 0 msecs [junit4] 2> 4987917 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 4987927 INFO (Thread-14776) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 4987928 INFO (Thread-14776) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 4988034 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.ZkTestServer start zk server on port:40789 [junit4] 2> 4988034 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 4988035 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 4988073 INFO (zkCallback-4297-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@132e80f4 name:ZooKeeperConnection Watcher:127.0.0.1:40789 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 4988073 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 4988074 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 4988074 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 4988078 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 4988078 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 4988079 INFO (zkCallback-4298-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@70c813c name:ZooKeeperConnection Watcher:127.0.0.1:40789/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 4988080 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 4988080 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 4988080 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 4988082 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 4988083 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 4988084 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 4988085 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988085 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 4988087 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 4988087 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 4988089 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988089 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 4988090 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988090 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 4988091 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988091 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 4988092 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988092 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 4988093 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988094 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 4988095 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988095 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 4988096 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988096 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 4988097 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988097 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 4988098 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988098 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 4988100 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 4988100 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 4988101 INFO (zkCallback-4299-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@30fc3413 name:ZooKeeperConnection Watcher:127.0.0.1:40789 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 4988101 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 4988101 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 4988101 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 4988102 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 4988103 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 4988103 INFO (zkCallback-4300-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1963957f name:ZooKeeperConnection Watcher:127.0.0.1:40789/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 4988104 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 4988104 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 4988104 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/solrconfig.xml [junit4] 2> 4988104 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml [junit4] 2> 4988106 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf2/schema.xml [junit4] 2> 4988106 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml [junit4] 2> 4988107 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/enumsConfig.xml [junit4] 2> 4988107 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml [junit4] 2> 4988108 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 4988108 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 4988109 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/stopwords.txt [junit4] 2> 4988109 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt [junit4] 2> 4988110 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/protwords.txt [junit4] 2> 4988110 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt [junit4] 2> 4988111 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/currency.xml [junit4] 2> 4988111 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml [junit4] 2> 4988113 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/open-exchange-rates.json [junit4] 2> 4988113 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json [junit4] 2> 4988114 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 4988114 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 4988115 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/old_synonyms.txt [junit4] 2> 4988115 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt [junit4] 2> 4988116 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/conf2/synonyms.txt [junit4] 2> 4988116 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt [junit4] 2> 4988117 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/elevate.xml to /configs/conf2/elevate.xml [junit4] 2> 4988117 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml [junit4] 2> 4988184 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/cores/collection1 [junit4] 2> 4988185 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 4988240 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@ff1933a{/,null,AVAILABLE} [junit4] 2> 4988240 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.e.j.s.ServerConnector Started ServerConnector@4e200314{HTTP/1.1,[http/1.1]}{127.0.0.1:53428} [junit4] 2> 4988240 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.e.j.s.Server Started @4993601ms [junit4] 2> 4988240 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=hdfs://localhost:46173/hdfs__localhost_46173__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_solr_build_solr-core_test_J0_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001_tempDir-002_control_data, hostContext=/, hostPort=53428, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/cores} [junit4] 2> 4988240 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 4988240 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001' [junit4] 2> 4988241 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 4988241 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 4988241 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 4988248 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 4988267 INFO (zkCallback-4301-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5aeba3aa name:ZooKeeperConnection Watcher:127.0.0.1:40789/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 4988268 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 4988270 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 4988271 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 4988271 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/solr.xml [junit4] 2> 4988274 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/cores [junit4] 2> 4988274 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.CoreContainer New CoreContainer 649673635 [junit4] 2> 4988274 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001] [junit4] 2> 4988275 WARN (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/lib [junit4] 2> 4988275 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] 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> 4988276 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 4988276 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 4988276 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 4988276 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40789/solr [junit4] 2> 4988276 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 4988276 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 4988277 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 4988277 INFO (zkCallback-4304-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6f7696ef name:ZooKeeperConnection Watcher:127.0.0.1:40789 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 4988277 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 4988277 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 4988278 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$27/1254703706@5a9bee97 [junit4] 2> 4988279 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 4988280 INFO (zkCallback-4305-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@649e18a5 name:ZooKeeperConnection Watcher:127.0.0.1:40789/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 4988280 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 4988280 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 4988281 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 4988282 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 4988283 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 4988284 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 4988284 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 4988285 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 4988285 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 4988286 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 4988286 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 4988287 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 4988287 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 4988288 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 4988288 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 4988288 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95777702432014342-127.0.0.1:53428_-n_0000000000 [junit4] 2> 4988289 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:53428_ [junit4] 2> 4988289 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 4988289 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.Overseer Overseer (id=95777702432014342-127.0.0.1:53428_-n_0000000000) starting [junit4] 2> 4988290 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 4988292 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 4988293 INFO (OverseerStateUpdate-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 4988294 INFO (OverseerStateUpdate-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 4988294 INFO (OverseerCollectionConfigSetProcessor-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 4988295 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:53428_ [junit4] 2> 4988295 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:53428_ [junit4] 2> 4988296 INFO (zkCallback-4305-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ ] 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> 4988296 INFO (zkCallback-4305-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 4988309 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 4988309 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 4988310 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/cores [junit4] 2> 4988310 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] 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> 4988310 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/cores/collection1 [junit4] 2> 4988310 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 4988311 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 4988311 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 4988312 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.ZkController Collection control_collection not visible yet, but flagging it so a watch is registered when it becomes visible [junit4] 2> 4988312 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader addZkWatch [control_collection] [junit4] 2> 4988312 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Deleting data for [control_collection] [junit4] 2> 4988312 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 4988313 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0 [junit4] 2> 4988313 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[E4A8AA33FD235588]) [n:127.0.0.1:53428_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 4988313 INFO (OverseerStateUpdate-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] 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:53428";, [junit4] 2> "node_name":"127.0.0.1:53428_", [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> 4988313 INFO (OverseerStateUpdate-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] 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:53428";, [junit4] 2> "node_name":"127.0.0.1:53428_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 4988313 INFO (OverseerStateUpdate-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 4988314 INFO (OverseerStateUpdate-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 4988314 INFO (zkCallback-4305-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ ] 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> 4989313 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 4989313 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 4989313 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 4989313 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 4989313 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 4989313 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/cores/collection1' [junit4] 2> 4989313 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 4989314 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 4989314 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 4989317 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 4989322 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 4989329 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 4989333 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 4989612 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 4989618 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 4989619 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 4989625 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 4989627 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 4989628 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 4989629 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 4989629 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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/J0 [junit4] 2> 4989629 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 4989630 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory [junit4] 2> 4989630 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:46173/solr_hdfs_home [junit4] 2> 4989630 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled [junit4] 2> 4989630 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_E4A8AA33FD235588-001/control-001/cores/collection1], dataDir=[hdfs://localhost:46173/solr_hdfs_home/control_collection/core_node1/data/] [junit4] 2> 4989630 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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@6d35d731 [junit4] 2> 4989630 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:46173/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 4989656 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for hdfs://localhost:46173/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 4989661 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=hdfs://localhost:46173/solr_hdfs_home/control_collection/core_node1/data/index/ [junit4] 2> 4989679 WARN (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'hdfs:/localhost:46173/solr_hdfs_home/control_collection/core_node1/data/index' doesn't exist. Creating new index... [junit4] 2> 4989680 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:46173/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 4989714 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for hdfs://localhost:46173/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 4989714 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=5, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 4989896 INFO (IPC Server handler 1 on 46173) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37164 is added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-baddebc8-147d-4674-8f2e-c4c141e5a61c:NORMAL:127.0.0.1:37164|RBW], ReplicaUnderConstruction[[DISK]DS-78c9130c-bc66-4a0b-b96e-b175b3ef262c:NORMAL:127.0.0.1:43736|RBW]]} size 0 [junit4] 2> 4989899 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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(HdfsDirectory@hdfs://localhost:46173/solr_hdfs_home/control_collection/core_node1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39b6f140; maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1} [junit4] 2> 4989899 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 4989899 INFO (IPC Server handler 3 on 46173) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43736 is added to blk_1073741825_1001 size 71 [junit4] 2> 4989905 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:53428_ 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:46173/solr_hdfs_home/control_collection/core_node1/data/ [junit4] 2> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989907 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989907 WARN (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989909 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 4989909 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 4989910 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 4989910 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 4989912 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989912 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989913 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989913 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989913 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2 [junit4] 2> 4989920 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 4989921 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 4989924 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=45, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 4989928 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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(HdfsDirectory@hdfs://localhost:46173/solr_hdfs_home/control_collection/core_node1/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39b6f140; maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1} [junit4] 2> 4989928 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 4989929 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6633192a[collection1] main] [junit4] 2> 4989929 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989929 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989929 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989929 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 4989929 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 4989929 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989930 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989930 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989930 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 4989930 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 4989931 INFO (searcherExecutor-9862-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6633192a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 4989931 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989931 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989931 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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> 4989931 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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 1532443241008332800 [junit4] 2> 4989933 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ 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 1532443241008332800 [junit4] 2> 4989933 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 4989933 INFO (coreLoadExecutor-9861-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 4989933 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ 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:53428 collection:control_collection shard:shard1 [junit4] 2> 4989934 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ 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> 4989935 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ 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/95777702432014342-core_node1-n_0000000000 [junit4] 2> 4989935 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ 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=180000 [junit4] 2> 4989937 INFO (OverseerStateUpdate-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection"} current state version: 1 [junit4] 2> 4989937 INFO (zkCallback-4305-thread-1-processing-n:127.0.0.1:53428_) [n:127.0.0.1:53428_ ] 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> 4989939 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 4989939 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ 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> 4989939 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:53428/collection1/ [junit4] 2> 4989939 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 4989939 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:53428/collection1/ has no replicas [junit4] 2> 4989941 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 4989942 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/95777702432014342-core_node1-n_0000000000 [junit4] 2> 4989943 INFO (OverseerStateUpdate-95777702432014342-127.0.0.1:53428_-n_0000000000) [n:127.0.0.1:53428_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "base_url":"http://127.0.0.1:53428";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 2 [junit4] 2> 4989944 INFO (coreZkRegister-9855-thread-1-processing-n:127.0.0.1:53428_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53428_ c:control_collection s:shard1 r:core_node1 x:collect [...truncated too long message...] hread.java:745) [junit4] 2> [junit4] 2> 6458322 INFO (Thread-69080) [n:127.0.0.1:47740_solr c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica2] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.schema.TestManagedSchemaAPI_E4A8AA33FD235588-001/tempDir-001/node1/./testschemaapi_shard1_replica2/data/index [junit4] 2> 6458344 INFO (Thread-69080) [n:127.0.0.1:47740_solr c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica2] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.schema.TestManagedSchemaAPI_E4A8AA33FD235588-001/tempDir-001/node1/./testschemaapi_shard1_replica2/data [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.schema.TestManagedSchemaAPI_E4A8AA33FD235588-001/tempDir-001/node1/./testschemaapi_shard1_replica2/data;done=false>>] [junit4] 2> 6458344 INFO (Thread-69080) [n:127.0.0.1:47740_solr c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica2] o.a.s.c.CachingDirectoryFactory Closing directory, CoreContainer#isShutdown=true [junit4] 2> 6458344 INFO (Thread-69080) [n:127.0.0.1:47740_solr c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica2] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.schema.TestManagedSchemaAPI_E4A8AA33FD235588-001/tempDir-001/node1/./testschemaapi_shard1_replica2/data [junit4] 2> 6458344 WARN (Thread-69080) [n:127.0.0.1:47740_solr c:testschemaapi s:shard1 r:core_node2 x:testschemaapi_shard1_replica2] o.a.s.c.ZkController listener throws error [junit4] 2> org.apache.solr.common.SolrException: Unable to reload core [testschemaapi_shard1_replica2] [junit4] 2> at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:921) [junit4] 2> at org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2488) [junit4] 2> at org.apache.solr.cloud.ZkController$4.run(ZkController.java:2425) [junit4] 2> Caused by: org.apache.solr.common.SolrException: Could not find config name for collection:testschemaapi [junit4] 2> at org.apache.solr.core.SolrCore.<init>(SolrCore.java:772) [junit4] 2> at org.apache.solr.core.SolrCore.reload(SolrCore.java:461) [junit4] 2> at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:915) [junit4] 2> ... 2 more [junit4] 2> Caused by: org.apache.solr.common.SolrException: Could not find config name for collection:testschemaapi [junit4] 2> at org.apache.solr.rest.ManagedResourceStorage.newStorageIO(ManagedResourceStorage.java:101) [junit4] 2> at org.apache.solr.core.SolrCore.initRestManager(SolrCore.java:2283) [junit4] 2> at org.apache.solr.core.SolrCore.<init>(SolrCore.java:748) [junit4] 2> ... 4 more [junit4] 2> Apr 23, 2016 11:13:48 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Lucene60, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=ja-JP-u-ca-japanese-x-lvariant-JP, timezone=Asia/Dacca [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=275464768,total=529530880 [junit4] 2> NOTE: All tests run in this JVM: [ChangedSchemaMergeTest, TestSolrQueryParser, TestDistribDocBasedVersion, PrimitiveFieldTypeTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestTolerantSearch, TestCustomDocTransformer, MigrateRouteKeyTest, TestSchemaSimilarityResource, TestCharFilters, EnumFieldTest, TestUtils, TestJmxIntegration, TestSolrConfigHandler, PKIAuthenticationIntegrationTest, RollingRestartTest, HardAutoCommitTest, FullHLLTest, UnloadDistributedZkTest, TestLeaderElectionZkExpiry, CoreAdminHandlerTest, DeleteShardTest, OverseerStatusTest, TestDocBasedVersionConstraints, TlogReplayBufferedWhileIndexingTest, FieldMutatingUpdateProcessorTest, TestCloudPivotFacet, BinaryUpdateRequestHandlerTest, TestStressReorder, SolrCoreCheckLockOnStartupTest, SparseHLLTest, TestSearchPerf, RecoveryZkTest, TestDefaultStatsCache, TestSolrJ, HdfsRecoverLeaseTest, TestPostingsSolrHighlighter, TestElisionMultitermQuery, DeleteInactiveReplicaTest, TestJettySolrRunner, LeaderElectionTest, TestMaxScoreQueryParser, TestReloadDeadlock, DocValuesMultiTest, TestMiniSolrCloudClusterBase, ClusterStateTest, TestClusterStateMutator, InfoHandlerTest, SimpleCollectionCreateDeleteTest, SliceStateTest, TestBulkSchemaAPI, TestRuleBasedAuthorizationPlugin, DistributedFacetPivotLongTailTest, DistribDocExpirationUpdateProcessorTest, RegexBoostProcessorTest, SearchHandlerTest, TestReload, VersionInfoTest, TestFastWriter, TermVectorComponentDistributedTest, TestCoreDiscovery, BaseCdcrDistributedZkTest, TestFileDictionaryLookup, TestShortCircuitedRequests, TestComplexPhraseQParserPlugin, TestStandardQParsers, CollectionsAPISolrJTest, HdfsBasicDistributedZk2Test, TestPerFieldSimilarity, CleanupOldIndexTest, DirectUpdateHandlerOptimizeTest, AssignTest, CoreAdminCreateDiscoverTest, TestExpandComponent, TestManagedStopFilterFactory, SuggestComponentContextFilterQueryTest, TestZkChroot, LukeRequestHandlerTest, TestDistributedMissingSort, TestClassicSimilarityFactory, TestSweetSpotSimilarityFactory, NoCacheHeaderTest, DirectSolrConnectionTest, TestNamedUpdateProcessors, TestWriterPerf, StatelessScriptUpdateProcessorFactoryTest, TestManagedResource, CheckHdfsIndexTest, DistributedVersionInfoTest, TestStressLiveNodes, TestOnReconnectListenerSupport, TestRecovery, OverriddenZkACLAndCredentialsProvidersTest, HdfsChaosMonkeySafeLeaderTest, DistributedDebugComponentTest, TestRandomFaceting, ZkSolrClientTest, ZkCLITest, TestDistributedSearch, CollectionStateFormat2Test, CollectionsAPIAsyncDistributedZkTest, ConfigSetsAPITest, DistributedQueueTest, LeaderFailoverAfterPartitionTest, LeaderInitiatedRecoveryOnShardRestartTest, SSLMigrationTest, SaslZkACLProviderTest, ShardSplitTest, HdfsNNFailoverTest, HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, ZkStateReaderTest, RuleEngineTest, RulesTest, TestReplicationHandlerBackup, TestSQLHandler, SecurityConfHandlerTest, SegmentsInfoRequestHandlerTest, DistributedFacetPivotSmallAdvancedTest, DistributedFacetPivotWhiteBoxTest, DistributedQueryComponentOptimizationTest, DistributedSuggestComponentTest, FacetPivotSmallTest, SpatialHeatmapFacetsTest, TestPivotHelperCode, TestTrackingShardHandlerFactory, JavabinLoaderTest, WrapperMergePolicyFactoryTest, SmileWriterTest, TestIntervalFaceting, TestMacros, TestChildDocTransformer, TestGeoJSONResponseWriter, TestRawResponseWriter, TestRawTransformer, TestCopyFieldCollectionResource, TestDefaultSearchFieldResource, TestDynamicFieldCollectionResource, TestDynamicFieldResource, TestFieldCollectionResource, TestFieldResource, TestFieldTypeCollectionResource, TestFieldTypeResource, TestSchemaVersionResource, TestSerializedLuceneMatchVersion, TestSolrQueryParserDefaultOperatorResource, DocValuesMissingTest, SpatialRPTFieldTypeTest, TestBulkSchemaConcurrent, TestCloudManagedSchema, TestCloudSchemaless, TestCollationFieldDocValues, TestManagedSchemaAPI] [junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestManagedSchemaAPI -Dtests.seed=E4A8AA33FD235588 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt -Dtests.locale=ja-JP-u-ca-japanese-x-lvariant-JP -Dtests.timezone=Asia/Dacca -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J2 | TestManagedSchemaAPI (suite) <<< [junit4] > Throwable #1: java.lang.AssertionError: ObjectTracker found 2 object(s) that were not released!!! [RawDirectoryWrapper, RawDirectoryWrapper] [junit4] > at __randomizedtesting.SeedInfo.seed([E4A8AA33FD235588]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:256) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] Completed [527/591 (4!)] on J2 in 15.74s, 1 test, 1 failure <<< FAILURES! [...truncated 225 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: 591 suites (10 ignored), 2381 tests, 1 suite-level error, 2 errors, 1 failure, 31 ignored (16 assumptions) [seed: E4A8AA33FD235588] Total time: 332 minutes 55 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
