Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1328/
2 tests failed. FAILED: org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.test Error Message: Error from server at http://127.0.0.1:49604: Error CREATEing SolrCore 'test_unload_shard_and_collection_1': Unable to create core [test_unload_shard_and_collection_1] Caused by: Direct buffer memory Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:49604: Error CREATEing SolrCore 'test_unload_shard_and_collection_1': Unable to create core [test_unload_shard_and_collection_1] Caused by: Direct buffer memory at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:595) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:231) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:220) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.UnloadDistributedZkTest.testUnloadShardAndCollection(UnloadDistributedZkTest.java:125) at org.apache.solr.cloud.UnloadDistributedZkTest.test(UnloadDistributedZkTest.java:70) 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:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) 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:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.hdfs.StressHdfsTest.test Error Message: Could not find collection:delete_data_dir Stack Trace: java.lang.AssertionError: Could not find collection:delete_data_dir at __randomizedtesting.SeedInfo.seed([E75F835B2AFC2393:6F0BBC8184004E6B]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertNotNull(Assert.java:526) at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:159) at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:144) at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:139) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:910) at org.apache.solr.cloud.hdfs.StressHdfsTest.createAndDeleteCollection(StressHdfsTest.java:159) at org.apache.solr.cloud.hdfs.StressHdfsTest.test(StressHdfsTest.java:103) 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:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) 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:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 13180 lines...] [junit4] Suite: org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/init-core-data-001 [junit4] 2> 3620377 WARN (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=42 numCloses=42 [junit4] 2> 3620378 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields [junit4] 2> 3620379 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776) [junit4] 2> 3620379 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 1> Formatting using clusterid: testClusterID [junit4] 2> 3620423 WARN (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 3620436 WARN (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 3620440 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 3620460 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs to ./temp/Jetty_localhost_39676_hdfs____.ro1srr/webapp [junit4] 2> 3620800 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:39676 [junit4] 2> 3620904 WARN (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 3620905 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 3620920 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_45932_datanode____ignxr2/webapp [junit4] 2> 3621305 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:45932 [junit4] 2> 3621347 WARN (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 3621348 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 3621369 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_54866_datanode____.k4xoyo/webapp [junit4] 2> 3621421 INFO (IPC Server handler 1 on 56960) [ ] BlockStateChange BLOCK* processReport: from storage DS-b95996b5-b25c-472f-8331-ffe6147174ee node DatanodeRegistration(127.0.0.1:49160, datanodeUuid=75151cb6-3eff-4412-a185-fa1b853f3460, infoPort=39648, infoSecurePort=0, ipcPort=56233, storageInfo=lv=-56;cid=testClusterID;nsid=1245311648;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs [junit4] 2> 3621421 INFO (IPC Server handler 1 on 56960) [ ] BlockStateChange BLOCK* processReport: from storage DS-f30c5c35-4636-47d7-9d6a-fc82c2a3980e node DatanodeRegistration(127.0.0.1:49160, datanodeUuid=75151cb6-3eff-4412-a185-fa1b853f3460, infoPort=39648, infoSecurePort=0, ipcPort=56233, storageInfo=lv=-56;cid=testClusterID;nsid=1245311648;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs [junit4] 2> 3621742 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[E75F835B2AFC2393]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:54866 [junit4] 2> 3621872 INFO (IPC Server handler 8 on 56960) [ ] BlockStateChange BLOCK* processReport: from storage DS-4ecda774-79ba-4731-825c-5acd346e1778 node DatanodeRegistration(127.0.0.1:58715, datanodeUuid=e255d4a3-e537-47be-a1b7-a98a5855cf67, infoPort=59408, infoSecurePort=0, ipcPort=38246, storageInfo=lv=-56;cid=testClusterID;nsid=1245311648;c=0), blocks: 0, hasStaleStorage: true, processing time: 0 msecs [junit4] 2> 3621873 INFO (IPC Server handler 8 on 56960) [ ] BlockStateChange BLOCK* processReport: from storage DS-0ed83831-0f56-4215-8eff-d0603087e373 node DatanodeRegistration(127.0.0.1:58715, datanodeUuid=e255d4a3-e537-47be-a1b7-a98a5855cf67, infoPort=59408, infoSecurePort=0, ipcPort=38246, storageInfo=lv=-56;cid=testClusterID;nsid=1245311648;c=0), blocks: 0, hasStaleStorage: false, processing time: 0 msecs [junit4] 2> 3621974 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 3621974 INFO (Thread-23800) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 3621974 INFO (Thread-23800) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 3621983 ERROR (Thread-23800) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 3622074 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.ZkTestServer start zk server on port:37555 [junit4] 2> 3622090 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 3622093 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 3622094 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 3622096 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 3622098 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 3622100 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 3622103 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 3622107 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 3622109 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 3622111 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 3622112 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 3622115 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise [junit4] 2> 3622232 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/control-001/cores/collection1 [junit4] 2> 3622233 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 3622235 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d10c564{/,null,AVAILABLE} [junit4] 2> 3622235 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@589e8e8d{HTTP/1.1,[http/1.1]}{127.0.0.1:52560} [junit4] 2> 3622237 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.Server Started @3625213ms [junit4] 2> 3622237 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=hdfs://localhost:56960/hdfs__localhost_56960__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-master_checkout_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001_tempDir-002_control_data, hostContext=/, hostPort=52560, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/control-001/cores} [junit4] 2> 3622237 ERROR (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 3622237 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 3622238 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 3622238 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 3622238 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-17T07:27:13.643Z [junit4] 2> 3622240 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 3622241 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/control-001/solr.xml [junit4] 2> 3622246 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 3622249 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37555/solr [junit4] 2> 3622273 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 3622274 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:52560_ [junit4] 2> 3622275 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.c.Overseer Overseer (id=98152247025991684-127.0.0.1:52560_-n_0000000000) starting [junit4] 2> 3622283 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52560_ [junit4] 2> 3622286 INFO (OverseerStateUpdate-98152247025991684-127.0.0.1:52560_-n_0000000000) [n:127.0.0.1:52560_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3622472 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3622478 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3622478 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3622480 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/control-001/cores [junit4] 2> 3622480 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:52560_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 3622481 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 3622483 INFO (OverseerStateUpdate-98152247025991684-127.0.0.1:52560_-n_0000000000) [n:127.0.0.1:52560_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 3623499 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 3623516 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 3623652 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 3623679 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection, trusted=true [junit4] 2> 3623679 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.control_collection.shard1.core_node1' (registry 'solr.core.control_collection.shard1.core_node1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3623680 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:56960/solr_hdfs_home [junit4] 2> 3623680 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled [junit4] 2> 3623680 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 3623680 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/control-001/cores/collection1], dataDir=[hdfs://localhost:56960/solr_hdfs_home/control_collection/core_node1/data/] [junit4] 2> 3623681 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/control_collection/core_node1/data/snapshot_metadata [junit4] 2> 3623690 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true] [junit4] 2> 3623690 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [8388608] will allocate [1] slabs and use ~[8388608] bytes [junit4] 2> 3623690 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache [junit4] 2> 3623698 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.s.b.BlockDirectory Block cache on write is disabled [junit4] 2> 3623699 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 3623716 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 3623722 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true] [junit4] 2> 3623723 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [8388608] will allocate [1] slabs and use ~[8388608] bytes [junit4] 2> 3623723 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache [junit4] 2> 3623729 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.s.b.BlockDirectory Block cache on write is disabled [junit4] 2> 3623730 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 3623749 INFO (IPC Server handler 1 on 56960) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:49160 is added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-4ecda774-79ba-4731-825c-5acd346e1778:NORMAL:127.0.0.1:58715|RBW], ReplicaUC[[DISK]DS-f30c5c35-4636-47d7-9d6a-fc82c2a3980e:NORMAL:127.0.0.1:49160|RBW]]} size 0 [junit4] 2> 3623750 INFO (IPC Server handler 5 on 56960) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58715 is added to blk_1073741825_1001 size 72 [junit4] 2> 3623755 WARN (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 3623803 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog [junit4] 2> 3623803 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 3623803 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2 [junit4] 2> 3623813 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 3623813 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 3623815 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 3623820 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@499b6edc[collection1] main] [junit4] 2> 3623822 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 3623822 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3623823 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 3623824 INFO (searcherExecutor-10879-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@499b6edc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3623825 WARN (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.s.h.HdfsLocalityReporter Could not retrieve locality information for hdfs://localhost:41202/solr3 due to exception: java.net.ConnectException: Call From lucene1-us-west/10.41.0.5 to localhost:41202 failed on connection exception: java.net.ConnectException: Connection refused; For more details see: http://wiki.apache.org/hadoop/ConnectionRefused [junit4] 2> 3623825 INFO (coreLoadExecutor-10878-thread-1-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ c:control_collection x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1570435954355732480 [junit4] 2> 3623832 INFO (coreZkRegister-10871-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 3623832 INFO (coreZkRegister-10871-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ 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> 3623833 INFO (coreZkRegister-10871-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:52560/collection1/ [junit4] 2> 3623833 INFO (coreZkRegister-10871-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 3623833 INFO (coreZkRegister-10871-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:52560/collection1/ has no replicas [junit4] 2> 3623833 INFO (coreZkRegister-10871-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 3623837 INFO (coreZkRegister-10871-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:52560/collection1/ shard1 [junit4] 2> 3623988 INFO (coreZkRegister-10871-thread-1-processing-n:127.0.0.1:52560_ x:collection1 c:control_collection) [n:127.0.0.1:52560_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 3624006 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3624008 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37555/solr ready [junit4] 2> 3624008 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 3624008 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 3624131 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-1-001/cores/collection1 [junit4] 2> 3624132 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-1-001 of type NRT [junit4] 2> 3624134 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 3624136 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@63a193db{/,null,AVAILABLE} [junit4] 2> 3624136 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7bcb591c{HTTP/1.1,[http/1.1]}{127.0.0.1:49604} [junit4] 2> 3624136 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.Server Started @3627112ms [junit4] 2> 3624137 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=hdfs://localhost:56960/hdfs__localhost_56960__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-master_checkout_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001_tempDir-002_jetty1, replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/, hostPort=49604, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-1-001/cores} [junit4] 2> 3624137 ERROR (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 3624137 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 3624137 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 3624137 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 3624137 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-17T07:27:15.542Z [junit4] 2> 3624148 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 3624148 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-1-001/solr.xml [junit4] 2> 3624154 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 3624157 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37555/solr [junit4] 2> 3624172 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3624176 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:49604_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 3624179 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:49604_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49604_ [junit4] 2> 3624182 INFO (zkCallback-3911-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3624182 INFO (zkCallback-3907-thread-2-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3624187 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3624331 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:49604_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3624344 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:49604_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3624344 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:49604_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3624347 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:49604_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-1-001/cores [junit4] 2> 3624347 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:49604_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 3624350 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 3624351 INFO (OverseerStateUpdate-98152247025991684-127.0.0.1:52560_-n_0000000000) [n:127.0.0.1:52560_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2 [junit4] 2> 3624454 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3625368 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 3625385 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 3625527 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 3625543 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection collection1, trusted=true [junit4] 2> 3625543 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard2.core_node1' (registry 'solr.core.collection1.shard2.core_node1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3625543 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:56960/solr_hdfs_home [junit4] 2> 3625543 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled [junit4] 2> 3625543 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 3625544 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-1-001/cores/collection1], dataDir=[hdfs://localhost:56960/solr_hdfs_home/collection1/core_node1/data/] [junit4] 2> 3625545 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/collection1/core_node1/data/snapshot_metadata [junit4] 2> 3625554 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true] [junit4] 2> 3625554 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [8388608] will allocate [1] slabs and use ~[8388608] bytes [junit4] 2> 3625554 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache [junit4] 2> 3625559 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.s.b.BlockDirectory Block cache on write is disabled [junit4] 2> 3625559 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/collection1/core_node1/data [junit4] 2> 3625579 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/collection1/core_node1/data/index [junit4] 2> 3625586 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true] [junit4] 2> 3625586 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [8388608] will allocate [1] slabs and use ~[8388608] bytes [junit4] 2> 3625586 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache [junit4] 2> 3625591 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.s.b.BlockDirectory Block cache on write is disabled [junit4] 2> 3625591 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 3625614 INFO (IPC Server handler 6 on 56960) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:49160 is added to blk_1073741826_1002{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-f30c5c35-4636-47d7-9d6a-fc82c2a3980e:NORMAL:127.0.0.1:49160|RBW], ReplicaUC[[DISK]DS-4ecda774-79ba-4731-825c-5acd346e1778:NORMAL:127.0.0.1:58715|RBW]]} size 72 [junit4] 2> 3625614 INFO (IPC Server handler 7 on 56960) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58715 is added to blk_1073741826_1002 size 72 [junit4] 2> 3626023 WARN (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 3626078 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog [junit4] 2> 3626095 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 3626095 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2 [junit4] 2> 3626109 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 3626109 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 3626111 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 3626116 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@637e9d10[collection1] main] [junit4] 2> 3626117 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 3626118 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3626118 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 3626120 INFO (searcherExecutor-10890-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@637e9d10[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3626121 WARN (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Could not retrieve locality information for hdfs://localhost:41202/solr3 due to exception: java.net.ConnectException: Call >From lucene1-us-west/10.41.0.5 to localhost:41202 failed on connection exception: java.net.ConnectException: Connection refused; For more details see: http://wiki.apache.org/hadoop/ConnectionRefused [junit4] 2> 3626121 INFO (coreLoadExecutor-10889-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ c:collection1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1570435956763262976 [junit4] 2> 3626129 INFO (coreZkRegister-10884-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 3626129 INFO (coreZkRegister-10884-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 3626129 INFO (coreZkRegister-10884-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:49604/collection1/ [junit4] 2> 3626129 INFO (coreZkRegister-10884-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 3626129 INFO (coreZkRegister-10884-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:49604/collection1/ has no replicas [junit4] 2> 3626129 INFO (coreZkRegister-10884-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 3626135 INFO (coreZkRegister-10884-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:49604/collection1/ shard2 [junit4] 2> 3626237 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3626286 INFO (coreZkRegister-10884-thread-1-processing-n:127.0.0.1:49604_ x:collection1 c:collection1) [n:127.0.0.1:49604_ c:collection1 s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 3626390 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2]) [junit4] 2> 3626550 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-2-001/cores/collection1 [junit4] 2> 3626551 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-2-001 of type NRT [junit4] 2> 3626551 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 3626553 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5c413beb{/,null,AVAILABLE} [junit4] 2> 3626553 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6f76804e{HTTP/1.1,[http/1.1]}{127.0.0.1:59306} [junit4] 2> 3626553 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.Server Started @3629529ms [junit4] 2> 3626553 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=hdfs://localhost:56960/hdfs__localhost_56960__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-master_checkout_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001_tempDir-002_jetty2, replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/, hostPort=59306, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-2-001/cores} [junit4] 2> 3626554 ERROR (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 3626554 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 3626554 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 3626554 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 3626554 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-17T07:27:17.959Z [junit4] 2> 3626568 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 3626568 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-2-001/solr.xml [junit4] 2> 3626573 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 3626580 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37555/solr [junit4] 2> 3626600 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:59306_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 3626603 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:59306_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 3626606 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:59306_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59306_ [junit4] 2> 3626607 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3626608 INFO (zkCallback-3911-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3626609 INFO (zkCallback-3923-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3626611 INFO (zkCallback-3907-thread-2-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3626727 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:59306_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3626741 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:59306_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3626741 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:59306_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3626743 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:59306_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-2-001/cores [junit4] 2> 3626744 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:59306_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 3626746 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 3626748 INFO (OverseerStateUpdate-98152247025991684-127.0.0.1:52560_-n_0000000000) [n:127.0.0.1:52560_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 3626850 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3626850 INFO (zkCallback-3923-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3627765 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 3627781 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 3627911 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 3627923 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection collection1, trusted=true [junit4] 2> 3627923 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard1.core_node2' (registry 'solr.core.collection1.shard1.core_node2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3627923 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:56960/solr_hdfs_home [junit4] 2> 3627924 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled [junit4] 2> 3627924 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 3627924 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-2-001/cores/collection1], dataDir=[hdfs://localhost:56960/solr_hdfs_home/collection1/core_node2/data/] [junit4] 2> 3627925 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/collection1/core_node2/data/snapshot_metadata [junit4] 2> 3627933 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true] [junit4] 2> 3627933 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [8388608] will allocate [1] slabs and use ~[8388608] bytes [junit4] 2> 3627933 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache [junit4] 2> 3627937 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.s.b.BlockDirectory Block cache on write is disabled [junit4] 2> 3627938 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/collection1/core_node2/data [junit4] 2> 3627954 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:56960/solr_hdfs_home/collection1/core_node2/data/index [junit4] 2> 3627960 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct memory allocation set to [true] [junit4] 2> 3627960 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of [8388608] will allocate [1] slabs and use ~[8388608] bytes [junit4] 2> 3627961 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache [junit4] 2> 3627965 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.s.b.BlockDirectory Block cache on write is disabled [junit4] 2> 3627965 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 3627973 INFO (IPC Server handler 8 on 56960) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:58715 is added to blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-f30c5c35-4636-47d7-9d6a-fc82c2a3980e:NORMAL:127.0.0.1:49160|RBW], ReplicaUC[[DISK]DS-0ed83831-0f56-4215-8eff-d0603087e373:NORMAL:127.0.0.1:58715|RBW]]} size 0 [junit4] 2> 3627974 INFO (IPC Server handler 2 on 56960) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:49160 is added to blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null, primaryNodeIndex=-1, replicas=[ReplicaUC[[DISK]DS-f30c5c35-4636-47d7-9d6a-fc82c2a3980e:NORMAL:127.0.0.1:49160|RBW], ReplicaUC[[DISK]DS-0ed83831-0f56-4215-8eff-d0603087e373:NORMAL:127.0.0.1:58715|RBW]]} size 0 [junit4] 2> 3627979 WARN (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}} [junit4] 2> 3628030 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog [junit4] 2> 3628030 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 3628030 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2 [junit4] 2> 3628040 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 3628040 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 3628042 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 3628046 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@274c2798[collection1] main] [junit4] 2> 3628047 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 3628048 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 3628049 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 3628050 WARN (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Could not retrieve locality information for hdfs://localhost:41202/solr3 due to exception: java.net.ConnectException: Call >From lucene1-us-west/10.41.0.5 to localhost:41202 failed on connection exception: java.net.ConnectException: Connection refused; For more details see: http://wiki.apache.org/hadoop/ConnectionRefused [junit4] 2> 3628051 INFO (searcherExecutor-10901-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@274c2798[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 3628051 INFO (coreLoadExecutor-10900-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ c:collection1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1570435958787014656 [junit4] 2> 3628058 INFO (coreZkRegister-10895-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 3628058 INFO (coreZkRegister-10895-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 3628058 INFO (coreZkRegister-10895-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:59306/collection1/ [junit4] 2> 3628058 INFO (coreZkRegister-10895-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 3628058 INFO (coreZkRegister-10895-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:59306/collection1/ has no replicas [junit4] 2> 3628058 INFO (coreZkRegister-10895-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 3628063 INFO (coreZkRegister-10895-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:59306/collection1/ shard1 [junit4] 2> 3628166 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3628166 INFO (zkCallback-3923-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3628214 INFO (coreZkRegister-10895-thread-1-processing-n:127.0.0.1:59306_ x:collection1 c:collection1) [n:127.0.0.1:59306_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 3628318 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3628318 INFO (zkCallback-3923-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 3628422 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-3-001/cores/collection1 [junit4] 2> 3628423 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-3-001 of type NRT [junit4] 2> 3628423 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 3628426 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c660e9b{/,null,AVAILABLE} [junit4] 2> 3628427 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1dc2e368{HTTP/1.1,[http/1.1]}{127.0.0.1:44773} [junit4] 2> 3628428 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.e.j.s.Server Started @3631404ms [junit4] 2> 3628429 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=hdfs://localhost:56960/hdfs__localhost_56960__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-master_checkout_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001_tempDir-002_jetty3, replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/, hostPort=44773, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-3-001/cores} [junit4] 2> 3628429 ERROR (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 3628429 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 3628429 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 3628429 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 3628429 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-17T07:27:19.834Z [junit4] 2> 3628432 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 3628432 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-3-001/solr.xml [junit4] 2> 3628438 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 3628441 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37555/solr [junit4] 2> 3628453 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:44773_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 3628456 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:44773_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 3628458 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:44773_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44773_ [junit4] 2> 3628460 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 3628461 INFO (zkCallback-3911-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 3628462 INFO (zkCallback-3929-thread-1-processing-n:127.0.0.1:44773_) [n:127.0.0.1:44773_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 3628462 INFO (zkCallback-3907-thread-2-processing-n:127.0.0.1:52560_) [n:127.0.0.1:52560_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 3628462 INFO (zkCallback-3923-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 3628593 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:44773_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3628603 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:44773_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3628603 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:44773_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e765abc [junit4] 2> 3628606 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:44773_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsUnloadDistributedZkTest_E75F835B2AFC2393-001/shard-3-001/cores [junit4] 2> 3628606 INFO (TEST-HdfsUnloadDistributedZkTest.test-seed#[E75F835B2AFC2393]) [n:127.0.0.1:44773_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 3628608 INFO (coreLoadExecutor-10911-thread-1-processing-n:127.0.0.1:44773_) [n:127.0.0.1:44773_ c:collection1 x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 3628609 INFO (OverseerStateUpdate-98152247025991684-127.0.0.1:52560_-n_0000000000) [n:127.0.0.1:52560_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2 [junit4] 2> 3628712 INFO (zkCallback-3917-thread-1-processing-n:127.0.0.1:49604_) [n:127.0.0.1:49604_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 3628712 INFO (zkCallback-3923-thread-1-processing-n:127.0.0.1:59306_) [n:127.0.0.1:59306_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [4]) [junit4] 2> 3628712 INFO (zkCallback-3929-thread-1-processing-n:127.0.0.1:447 [...truncated too long message...] tressHdfsTest.java:77) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> Caused by: java.lang.NullPointerException [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:203) [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3370) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:5729) [junit4] 2> ... 54 more [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_E75F835B2AFC2393-001 [junit4] 2> Jun 17, 2017 7:30:07 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 34 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=992, maxMBSortInHeap=7.434938637439267, sim=RandomSimilarity(queryNorm=true): {}, locale=es-PY, timezone=America/St_Barthelemy [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_131 (64-bit)/cpus=4,threads=2,free=283402472,total=524812288 [junit4] 2> NOTE: All tests run in this JVM: [HdfsDirectoryTest, TestCloudRecovery, DOMUtilTest, DistributedIntervalFacetingTest, TestMacroExpander, DistribJoinFromCollectionTest, InfixSuggestersTest, DirectSolrConnectionTest, TestTrie, TestDelegationWithHadoopAuth, TestCollectionAPIs, SoftAutoCommitTest, TestPartialUpdateDeduplication, DirectSolrSpellCheckerTest, TestPivotHelperCode, TestFuzzyAnalyzedSuggestions, TestConfigSets, SmileWriterTest, DistributedTermsComponentTest, DistributedFacetPivotLargeTest, TestLocalFSCloudBackupRestore, TestQueryWrapperFilter, RecoveryAfterSoftCommitTest, TestDownShardTolerantSearch, DeleteStatusTest, SegmentsInfoRequestHandlerTest, TestSortByMinMaxFunction, ChaosMonkeySafeLeaderTest, SolrMetricManagerTest, ManagedSchemaRoundRobinCloudTest, CollectionReloadTest, TestRestoreCore, UpdateLogTest, TestManagedStopFilterFactory, AutoScalingHandlerTest, JsonLoaderTest, PreAnalyzedUpdateProcessorTest, WordBreakSolrSpellCheckerTest, DistributedDebugComponentTest, TestStandardQParsers, TestUseDocValuesAsStored, CustomCollectionTest, TestSurroundQueryParser, TestOverriddenPrefixQueryForCustomFieldType, SolrIndexSplitterTest, ZkCLITest, CSVRequestHandlerTest, TestManagedSchema, DistanceUnitsTest, TestSolrJ, MetricsHandlerTest, SOLR749Test, FullHLLTest, TestMissingGroups, TestLRUCache, BlockJoinFacetRandomTest, HdfsCollectionsAPIDistributedZkTest, ConfigSetsAPITest, TestUpdate, ShardRoutingTest, TestCloudSchemaless, SolrInfoBeanTest, TestElisionMultitermQuery, TestShardHandlerFactory, TestSolr4Spatial2, ZkControllerTest, CdcrUpdateLogTest, MissingSegmentRecoveryTest, SSLMigrationTest, HdfsDirectoryFactoryTest, TestBulkSchemaAPI, BadComponentTest, HttpSolrCallGetCoreTest, TestSimpleTrackingShardHandler, TestInitParams, TestFileDictionaryLookup, TestSearcherReuse, SpellCheckCollatorTest, TestSystemIdResolver, TestFieldCacheSortRandom, SpellCheckCollatorWithCollapseTest, TestDynamicLoading, RuleEngineTest, DocValuesNotIndexedTest, DeleteNodeTest, HighlighterTest, TestRawTransformer, OverseerStatusTest, TestStressCloudBlindAtomicUpdates, TestAddFieldRealTimeGet, ReplicationFactorTest, TestWordDelimiterFilterFactory, BasicAuthStandaloneTest, SortByFunctionTest, CdcrReplicationDistributedZkTest, CdcrVersionReplicationTest, TestSearchPerf, TestCloudNestedDocsSort, LeaderElectionContextKeyTest, TestNonDefinedSimilarityFactory, FileUtilsTest, TestPointFields, CoreAdminRequestStatusTest, AsyncCallRequestStatusResponseTest, QueryParsingTest, TestAuthenticationFramework, TestCharFilters, TestDistributedGrouping, TestLegacyField, TestCursorMarkWithoutUniqueKey, TestXmlQParser, BigEndianAscendingWordSerializerTest, TestFiltering, SpatialFilterTest, BlockCacheTest, SolrCmdDistributorTest, JvmMetricsTest, TestReRankQParserPlugin, TestBulkSchemaConcurrent, BasicDistributedZkTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest, ClusterStateUpdateTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, ShardRoutingCustomTest, AutoCommitTest, TestHashPartitioner, TestStressReorder, TestReload, TestCoreContainer, SpellCheckComponentTest, TestGroupingSearch, ConvertedLegacyTest, BasicFunctionalityTest, TestLazyCores, DistributedQueryElevationComponentTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser, SuggesterFSTTest, CoreAdminHandlerTest, TestFoldingMultitermQuery, DocValuesTest, TestStressLucene, SuggesterWFSTTest, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, TestAtomicUpdateErrorCases, QueryEqualityTest, DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, TestRemoteStreaming, DocValuesMultiTest, DistanceFunctionTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, TestQueryUtils, TestReversedWildcardFilterFactory, TestQueryTypes, FileBasedSpellCheckerTest, TermsComponentTest, XmlUpdateRequestHandlerTest, DocumentBuilderTest, TermVectorComponentTest, MoreLikeThisHandlerTest, FieldAnalysisRequestHandlerTest, FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, RegexBoostProcessorTest, SolrPluginUtilsTest, IndexSchemaTest, TestJmxIntegration, TestCollationField, ReturnFieldsTest, UpdateRequestProcessorFactoryTest, TestCSVResponseWriter, TestAnalyzedSuggestions, UniqFieldsUpdateProcessorFactoryTest, TestPHPSerializedResponseWriter, TestComponentsName, TestQuerySenderListener, UpdateParamsTest, AlternateDirectoryTest, TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, TestStressRecovery, SampleTest, TestBinaryField, MinimalSchemaTest, OutputWriterTest, TestSolrCoreProperties, TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestCodecSupport, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, TestSweetSpotSimilarityFactory, TestDFRSimilarityFactory, TestPerFieldSimilarity, TestLMDirichletSimilarityFactory, TestBM25SimilarityFactory, TestFastWriter, ResourceLoaderTest, ScriptEngineTest, URLClassifyProcessorTest, TestFastLRUCache, PreAnalyzedFieldTest, PrimUtilsTest, DateFieldTest, ClusterStateTest, TestUtils, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, CursorPagingTest, TestCrossCoreJoin, TestDistributedMissingSort, TestHighlightDedupGrouping, TestEmbeddedSolrServerSchemaAPI, TestJettySolrRunner, ActionThrottleTest, AssignTest, BaseCdcrDistributedZkTest, CdcrBootstrapTest, ChaosMonkeySafeLeaderWithPullReplicasTest, CollectionsAPISolrJTest, LeaderFailoverAfterPartitionTest, MultiThreadedOCPTest, TestClusterProperties, TestCollectionAPI, TestConfigSetsAPI, TestMiniSolrCloudCluster, TestOnReconnectListenerSupport, TestRebalanceLeaders, TestSSLRandomization, TestSegmentSorting, TestTlogReplica, HdfsBasicDistributedZk2Test, HdfsChaosMonkeyNothingIsSafeTest, HdfsNNFailoverTest, HdfsRecoverLeaseTest, HdfsRecoveryZkTest, HdfsSyncSliceTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest] [junit4] Completed [556/725 (2!)] on J1 in 74.54s, 1 test, 1 failure <<< FAILURES! [...truncated 43929 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
