Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/121/
4 tests failed. FAILED: org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test Error Message: Expected 2 of 3 replicas to be active but only found 1; [core_node2:{"core":"c8n_1x3_lf_shard1_replica1","base_url":"http://127.0.0.1:55779","node_name":"127.0.0.1:55779_","state":"active","leader":"true"}]; clusterState: DocCollection(c8n_1x3_lf//collections/c8n_1x3_lf/state.json/20)={ "replicationFactor":"3", "shards":{"shard1":{ "range":"80000000-7fffffff", "state":"active", "replicas":{ "core_node1":{ "state":"down", "base_url":"http://127.0.0.1:54909", "core":"c8n_1x3_lf_shard1_replica3", "node_name":"127.0.0.1:54909_"}, "core_node2":{ "core":"c8n_1x3_lf_shard1_replica1", "base_url":"http://127.0.0.1:55779", "node_name":"127.0.0.1:55779_", "state":"active", "leader":"true"}, "core_node3":{ "core":"c8n_1x3_lf_shard1_replica2", "base_url":"http://127.0.0.1:38009", "node_name":"127.0.0.1:38009_", "state":"down"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"1", "autoAddReplicas":"false"} Stack Trace: java.lang.AssertionError: Expected 2 of 3 replicas to be active but only found 1; [core_node2:{"core":"c8n_1x3_lf_shard1_replica1","base_url":"http://127.0.0.1:55779","node_name":"127.0.0.1:55779_","state":"active","leader":"true"}]; clusterState: DocCollection(c8n_1x3_lf//collections/c8n_1x3_lf/state.json/20)={ "replicationFactor":"3", "shards":{"shard1":{ "range":"80000000-7fffffff", "state":"active", "replicas":{ "core_node1":{ "state":"down", "base_url":"http://127.0.0.1:54909", "core":"c8n_1x3_lf_shard1_replica3", "node_name":"127.0.0.1:54909_"}, "core_node2":{ "core":"c8n_1x3_lf_shard1_replica1", "base_url":"http://127.0.0.1:55779", "node_name":"127.0.0.1:55779_", "state":"active", "leader":"true"}, "core_node3":{ "core":"c8n_1x3_lf_shard1_replica2", "base_url":"http://127.0.0.1:38009", "node_name":"127.0.0.1:38009_", "state":"down"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"1", "autoAddReplicas":"false"} at __randomizedtesting.SeedInfo.seed([53C8CD85C44C8CD3:DB9CF25F6AB0E12B]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.testRf3WithLeaderFailover(LeaderFailoverAfterPartitionTest.java:168) at org.apache.solr.cloud.LeaderFailoverAfterPartitionTest.test(LeaderFailoverAfterPartitionTest.java:55) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.handler.TestReqParamsAPI.test Error Message: Could not get expected value 'CY val' for path 'params/c' full output: { "responseHeader":{ "status":0, "QTime":0}, "params":{ "a":"A val", "b":"B val", "wt":"json", "useParams":""}, "context":{ "webapp":"", "path":"/dump1", "httpMethod":"GET"}}, from server: https://127.0.0.1:42946/collection1 Stack Trace: java.lang.AssertionError: Could not get expected value 'CY val' for path 'params/c' full output: { "responseHeader":{ "status":0, "QTime":0}, "params":{ "a":"A val", "b":"B val", "wt":"json", "useParams":""}, "context":{ "webapp":"", "path":"/dump1", "httpMethod":"GET"}}, from server: https://127.0.0.1:42946/collection1 at __randomizedtesting.SeedInfo.seed([53C8CD85C44C8CD3:DB9CF25F6AB0E12B]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:481) at org.apache.solr.handler.TestReqParamsAPI.testReqParams(TestReqParamsAPI.java:171) at org.apache.solr.handler.TestReqParamsAPI.test(TestReqParamsAPI.java:61) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Timeout occured while waiting response from server at: https://127.0.0.1:44842 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:44842 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:601) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:399) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:515) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:179) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) at java.net.SocketInputStream.read(SocketInputStream.java:170) at java.net.SocketInputStream.read(SocketInputStream.java:141) at sun.security.ssl.InputRecord.readFully(InputRecord.java:465) at sun.security.ssl.InputRecord.read(InputRecord.java:503) at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:973) at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:930) at sun.security.ssl.AppInputStream.read(AppInputStream.java:105) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:495) ... 47 more FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=30486, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=30486, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] at __randomizedtesting.SeedInfo.seed([53C8CD85C44C8CD3:DB9CF25F6AB0E12B]:0) Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:36282: collection already exists: awholynewstresscollection_collection2_1 at __randomizedtesting.SeedInfo.seed([53C8CD85C44C8CD3]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:403) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:356) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1270) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1040) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:976) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1599) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1620) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:987) Build Log: [...truncated 11212 lines...] [junit4] Suite: org.apache.solr.cloud.LeaderFailoverAfterPartitionTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/init-core-data-001 [junit4] 2> 254836 INFO (SUITE-LeaderFailoverAfterPartitionTest-seed#[53C8CD85C44C8CD3]-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> 254836 INFO (SUITE-LeaderFailoverAfterPartitionTest-seed#[53C8CD85C44C8CD3]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 254841 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 254842 INFO (Thread-787) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 254842 INFO (Thread-787) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 254942 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.ZkTestServer start zk server on port:51810 [junit4] 2> 254942 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 254942 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 254947 INFO (zkCallback-168-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@735b24ba name:ZooKeeperConnection Watcher:127.0.0.1:51810 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 254947 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 254947 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 254948 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 254951 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 254951 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 254957 INFO (zkCallback-169-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@35dd0133 name:ZooKeeperConnection Watcher:127.0.0.1:51810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 254957 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 254958 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 254958 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 254959 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 254961 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 254962 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 254963 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 254963 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 254965 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 254965 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 254967 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 254967 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 254968 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 254968 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 254969 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 254970 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 254971 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 254971 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 254972 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 254972 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 254973 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 254973 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 254975 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 254975 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 254976 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 254976 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 254977 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 254977 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 255077 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1 [junit4] 2> 255080 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 255091 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@9ace822{/,null,AVAILABLE} [junit4] 2> 255094 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.e.j.s.ServerConnector Started ServerConnector@18819dfe{HTTP/1.1,[http/1.1]}{127.0.0.1:34115} [junit4] 2> 255094 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.e.j.s.Server Started @259593ms [junit4] 2> 255094 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/tempDir-001/control/data, hostContext=/, hostPort=38009, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores} [junit4] 2> 255094 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 255094 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001' [junit4] 2> 255094 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 255094 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 255095 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 255097 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 255099 INFO (zkCallback-170-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1ed314a6 name:ZooKeeperConnection Watcher:127.0.0.1:51810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 255099 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 255099 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 255102 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 255102 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/solr.xml [junit4] 2> 255107 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores [junit4] 2> 255107 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.CoreContainer New CoreContainer 137092164 [junit4] 2> 255107 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001] [junit4] 2> 255107 WARN (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/lib [junit4] 2> 255108 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000, [junit4] 2> 255113 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 255114 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 255114 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 255114 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51810/solr [junit4] 2> 255114 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 255114 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 255115 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 255119 INFO (zkCallback-173-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@498cb511 name:ZooKeeperConnection Watcher:127.0.0.1:51810 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 255119 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 255119 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 255120 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$18/1651980046@6df0566 [junit4] 2> 255125 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 255127 INFO (zkCallback-174-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@634f652d name:ZooKeeperConnection Watcher:127.0.0.1:51810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 255127 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 255128 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 255129 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 255131 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 255133 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 255134 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 255136 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 255137 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 255138 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 255139 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 255139 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 255140 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 255140 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 255143 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 255143 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 255144 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 255145 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96248157586980868-127.0.0.1:38009_-n_0000000000 [junit4] 2> 255145 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38009_ [junit4] 2> 255145 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 255146 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.Overseer Overseer (id=96248157586980868-127.0.0.1:38009_-n_0000000000) starting [junit4] 2> 255148 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 255152 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 255154 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 255157 INFO (OverseerCollectionConfigSetProcessor-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 255159 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38009_ [junit4] 2> 255159 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:38009_ [junit4] 2> 255159 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 255161 INFO (zkCallback-174-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 255161 INFO (zkCallback-174-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 255174 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 255174 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 255175 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores [junit4] 2> 255176 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=control_collection, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 255176 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1 [junit4] 2> 255176 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 255178 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 255178 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 255179 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2 [junit4] 2> 255179 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [n:127.0.0.1:38009_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 255179 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.ZkController Collection control_collection not visible yet, but flagging it so a watch is registered when it becomes visible [junit4] 2> 255179 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:38009", [junit4] 2> "node_name":"127.0.0.1:38009_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 255180 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:38009", [junit4] 2> "node_name":"127.0.0.1:38009_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 255180 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 255181 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 255187 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Deleting data for [control_collection] [junit4] 2> 255187 INFO (zkCallback-174-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 255189 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 255189 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 255189 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 255189 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 255189 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 255190 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 255190 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1' [junit4] 2> 255190 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 255190 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 255191 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 255200 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 255204 WARN (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 255204 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0 [junit4] 2> 255213 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 255219 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 255304 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 255310 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 255311 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 255327 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 255329 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 255331 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 255331 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 255333 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2 [junit4] 2> 255333 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 255333 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 255333 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1/data/] [junit4] 2> 255333 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@514d7b2d [junit4] 2> 255334 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1/data [junit4] 2> 255334 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1/data/index/ [junit4] 2> 255334 WARN (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 255334 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1/data/index [junit4] 2> 255335 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.8671875, noCFSRatio=0.8698527042071156] [junit4] 2> 255335 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@660b12d1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c3b610d),segFN=segments_1,generation=1} [junit4] 2> 255335 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 255344 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 255344 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 255344 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 255344 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 255345 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 255345 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 255345 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 255345 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 255345 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 255345 WARN (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}} [junit4] 2> 255347 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 255348 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 255349 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 255349 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 255351 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1/data/ [junit4] 2> 255353 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 255354 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/dump,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms [junit4] 2> 255355 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 255357 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 255357 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 255358 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 255358 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 255358 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=28, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=19.552734375, floorSegmentMB=1.501953125, forceMergeDeletesPctAllowed=17.826478631557844, segmentsPerTier=50.0, maxCFSSegmentSizeMB=1.859375, noCFSRatio=0.8859658523399524 [junit4] 2> 255359 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@660b12d1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3c3b610d),segFN=segments_1,generation=1} [junit4] 2> 255359 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 255360 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4c24c776[collection1] main] [junit4] 2> 255360 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 255361 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 255361 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 255362 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 255362 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 255362 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 255362 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 255362 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 255362 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 255362 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 255363 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 255363 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 255363 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 255363 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1539970521933807616 [junit4] 2> 255365 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1539970521933807616 [junit4] 2> 255365 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 255366 INFO (searcherExecutor-466-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4c24c776[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 255369 INFO (coreLoadExecutor-465-thread-1-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 255373 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:http://127.0.0.1:38009 collection:control_collection shard:shard1 [junit4] 2> 255378 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 255438 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership election with path: /collections/control_collection/leader_elect/shard1/election/96248157586980868-core_node1-n_0000000000 [junit4] 2> 255445 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 and weAreReplacement=false and leaderVoteWait=10000 [junit4] 2> 255473 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 255473 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ 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> 255473 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:38009/collection1/ [junit4] 2> 255473 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 255473 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:38009/collection1/ has no replicas [junit4] 2> 255488 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 255488 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection"} current state version: 1 [junit4] 2> 255525 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/96248157586980868-core_node1-n_0000000000 [junit4] 2> 255553 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ 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:38009/collection1/ shard1 [junit4] 2> 255565 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "base_url":"http://127.0.0.1:38009", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 255687 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 255689 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 255701 INFO (zkCallback-174-thread-3-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 255701 INFO (zkCallback-178-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@50669078 name:ZooKeeperConnection Watcher:127.0.0.1:51810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 255701 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 255702 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 255702 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 255717 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 255725 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 255727 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:38009/collection1/ and leader is http://127.0.0.1:38009/collection1/ [junit4] 2> 255727 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:38009 [junit4] 2> 255727 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 255727 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 255727 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 255729 INFO (coreZkRegister-459-thread-1-processing-n:127.0.0.1:38009_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:38009_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Checking legacy cluster state for collection control_collection [junit4] 2> 255729 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 255729 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 255729 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 255737 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 255737 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:38009", [junit4] 2> "node_name":"127.0.0.1:38009_", [junit4] 2> "numShards":"2", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 2 [junit4] 2> 255737 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:38009", [junit4] 2> "node_name":"127.0.0.1:38009_", [junit4] 2> "numShards":"2", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 255754 INFO (zkCallback-179-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5ce0b8c4 name:ZooKeeperConnection Watcher:127.0.0.1:51810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 255754 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 255755 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 255798 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"create", [junit4] 2> "name":"collection1", [junit4] 2> "numShards":"2", [junit4] 2> "stateFormat":"2"} current state version: 2 [junit4] 2> 255798 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 255806 INFO (zkCallback-174-thread-3-processing-n:127.0.0.1:38009_) [n:127.0.0.1:38009_ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 255806 INFO (zkCallback-178-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 255916 INFO (OverseerStateUpdate-96248157586980868-127.0.0.1:38009_-n_0000000000) [n:127.0.0.1:38009_ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/collection1/state.json [junit4] 2> 255951 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/shard-1-001/cores/collection1 [junit4] 2> 255951 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/shard-1-001 [junit4] 2> 255954 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 255965 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@403633da{/,null,AVAILABLE} [junit4] 2> 255966 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.e.j.s.ServerConnector Started ServerConnector@6008de6b{HTTP/1.1,[http/1.1]}{127.0.0.1:33672} [junit4] 2> 255966 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.e.j.s.Server Started @260465ms [junit4] 2> 255966 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/, hostPort=55779, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/shard-1-001/cores} [junit4] 2> 255966 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 255966 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/shard-1-001' [junit4] 2> 255967 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 255967 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 255967 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 255977 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 256005 INFO (zkCallback-180-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@548b167d name:ZooKeeperConnection Watcher:127.0.0.1:51810/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 256008 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 256008 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 256034 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 256034 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/shard-1-001/solr.xml [junit4] 2> 256055 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/shard-1-001/cores [junit4] 2> 256061 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.CoreContainer New CoreContainer 2044392201 [junit4] 2> 256061 INFO (TEST-LeaderFailoverAfterPartitionTest.test-seed#[53C8CD85C44C8CD3]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderFailoverAfterPartitionTest_53C8CD85C44C8CD3-001/shard-1-001] [junit4] 2> 256062 WARN (TEST-LeaderFailoverAfterPa [...truncated too long message...] dapter.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:367) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [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> 8341246 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[53C8CD85C44C8CD3]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_53C8CD85C44C8CD3-001 [junit4] 2> Jul 16, 2016 3:07:00 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 35 leaked thread(s). [junit4] 2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=28307, maxDocsPerChunk=1, blockSize=5), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, chunkSize=28307, blockSize=5)), sim=ClassicSimilarity, locale=ar-TN, timezone=Pacific/Funafuti [junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=2,free=75667024,total=458752000 [junit4] 2> NOTE: All tests run in this JVM: [TlogReplayBufferedWhileIndexingTest, TestHashPartitioner, DistributedMLTComponentTest, CustomCollectionTest, AliasIntegrationTest, CdcrReplicationHandlerTest, ConfigSetsAPITest, TestConfigReload, TestExactSharedStatsCache, EnumFieldTest, TestCollationFieldDocValues, TestSolrCoreProperties, SimplePostToolTest, TestRandomCollapseQParserPlugin, TestSizeLimitedDistributedMap, TestSolrConfigHandlerCloud, SpatialFilterTest, TestDynamicLoading, TestQuerySenderListener, OverseerModifyCollectionTest, SpellPossibilityIteratorTest, TestLFUCache, TestSimpleTrackingShardHandler, NotRequiredUniqueKeyTest, TestTrieFacet, TestConfigSetsAPI, TermsComponentTest, SuggestComponentTest, TestRawResponseWriter, MultiTermTest, TestBlendedInfixSuggestions, DistributedFacetPivotSmallAdvancedTest, TestDocTermOrds, HdfsBasicDistributedZk2Test, SSLMigrationTest, TestConfigSetImmutable, TestLeaderInitiatedRecoveryThread, TestBinaryResponseWriter, TestRequestStatusCollectionAPI, TestPKIAuthenticationPlugin, DeleteReplicaTest, TestSolrQueryParserResource, TestNonDefinedSimilarityFactory, TestInitParams, TestFieldCacheSanityChecker, TestUpdate, DirectSolrSpellCheckerTest, HttpPartitionTest, TestSchemaNameResource, DistribCursorPagingTest, DocValuesTest, TestHdfsUpdateLog, TestShardHandlerFactory, MoreLikeThisHandlerTest, HdfsSyncSliceTest, TestRTimerTree, TestSubQueryTransformerCrossCore, SortByFunctionTest, BasicFunctionalityTest, TestFastLRUCache, CoreAdminRequestStatusTest, TestBM25SimilarityFactory, TestCodecSupport, TestManagedResourceStorage, BasicAuthIntegrationTest, TestQueryUtils, HighlighterMaxOffsetTest, TestSolrXml, ChangedSchemaMergeTest, TestManagedSynonymFilterFactory, OverseerTaskQueueTest, TestSortingResponseWriter, ResponseHeaderTest, TimeZoneUtilsTest, ReplicationFactorTest, SolrIndexSplitterTest, OutOfBoxZkACLAndCredentialsProvidersTest, ChaosMonkeySafeLeaderTest, DistributedExpandComponentTest, SolrPluginUtilsTest, TestDynamicFieldCollectionResource, TestFieldCacheVsDocValues, ClusterStateUpdateTest, SharedFSAutoReplicaFailoverTest, ConvertedLegacyTest, TestCloudManagedSchema, CSVRequestHandlerTest, TestSurroundQueryParser, AddBlockUpdateTest, AtomicUpdatesTest, SolrCmdDistributorTest, TestInitQParser, TestMiniSolrCloudClusterSSL, FacetPivotSmallTest, DocumentBuilderTest, TestCustomDocTransformer, SimpleMLTQParserTest, IndexBasedSpellCheckerTest, QueryResultKeyTest, CollectionsAPIDistributedZkTest, TestRandomFaceting, ZkSolrClientTest, ZkCLITest, ShardRoutingCustomTest, TestDistributedSearch, TestCoreContainer, SimpleFacetsTest, StatsComponentTest, SpellCheckComponentTest, TestGroupingSearch, QueryElevationComponentTest, PeerSyncTest, TestFiltering, TestLazyCores, HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser, SpellCheckCollatorTest, SuggesterFSTTest, CoreAdminHandlerTest, TestFoldingMultitermQuery, SuggesterTSTTest, SuggesterTest, TestStressLucene, TestTrie, SuggesterWFSTTest, WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, SolrCoreCheckLockOnStartupTest, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, TestRemoteStreaming, DistanceFunctionTest, SolrInfoMBeanTest, DisMaxRequestHandlerTest, StandardRequestHandlerTest, TestReversedWildcardFilterFactory, TestQueryTypes, PrimitiveFieldTypeTest, RequestHandlersTest, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, RequiredFieldsTest, FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, RegexBoostProcessorTest, IndexSchemaTest, ReturnFieldsTest, UpdateRequestProcessorFactoryTest, JSONWriterTest, MBeansHandlerTest, QueryParsingTest, UniqFieldsUpdateProcessorFactoryTest, BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication, SearchHandlerTest, HighlighterConfigTest, SOLR749Test, AlternateDirectoryTest, TestQuerySenderNoQuery, ResponseLogComponentTest, SolrIndexConfigTest, BadComponentTest, TestStressRecovery, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestHighlightDedupGrouping, TestTolerantSearch, TestEmbeddedSolrServerConstructors, TestJettySolrRunner, ActionThrottleTest, AsyncMigrateRouteKeyTest, CloudExitableDirectoryReaderTest, CollectionReloadTest, CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest, DistributedQueueTest, ForceLeaderTest, TestCloudDeleteByQuery, TestCloudInspectUtil, TestCloudPivotFacet, TestCryptoKeys, TestDownShardTolerantSearch, TestHdfsCloudBackupRestore, TestLocalFSCloudBackupRestore, TestOnReconnectListenerSupport, TestRandomRequestDistribution, TestReplicaProperties, TestShortCircuitedRequests, TestStressLiveNodes, HdfsCollectionsAPIDistributedZkTest] [junit4] Completed [621/621 (4!)] on J1 in 3876.76s, 1 test, 1 error <<< FAILURES! [...truncated 1 lines...] [junit4] JVM J1: stdout was not empty, see: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J1-20160716_004754_856.sysout [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] java.lang.OutOfMemoryError: Java heap space [junit4] Dumping heap to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/heapdumps/java_pid8943.hprof ... [junit4] Heap dump file created [620495685 bytes in 6.924 secs] [junit4] <<< JVM J1: EOF ---- [...truncated 13 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:770: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:707: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:536: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1443: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:984: There were test failures: 621 suites (10 ignored), 2642 tests, 2 errors, 2 failures, 46 ignored (31 assumptions) [seed: 53C8CD85C44C8CD3] Total time: 346 minutes 49 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org