Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/936/
3 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=7209, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=7209, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:49048: collection already exists: awholynewstresscollection_collection0_0 at __randomizedtesting.SeedInfo.seed([1A489CD376F2486A]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:966) FAILED: org.apache.solr.cloud.hdfs.HdfsChaosMonkeyNothingIsSafeTest.test Error Message: There were too many update fails (98 > 60) - we expect it can happen, but shouldn't easily Stack Trace: java.lang.AssertionError: There were too many update fails (98 > 60) - we expect it can happen, but shouldn't easily at __randomizedtesting.SeedInfo.seed([1A489CD376F2486A:921CA309D80E2592]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertFalse(Assert.java:68) at org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest.test(ChaosMonkeyNothingIsSafeTest.java:216) 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:497) 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:964) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:939) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.core.TestDynamicLoading.testDynamicLoading Error Message: Could not get expected value 'X val changed' for path 'x' full output: { "responseHeader":{ "status":0, "QTime":0}, "params":{"wt":"json"}, "context":{ "webapp":"", "path":"/test1", "httpMethod":"GET"}, "class":"org.apache.solr.core.BlobStoreTestRequestHandler", "x":"X val"} Stack Trace: java.lang.AssertionError: Could not get expected value 'X val changed' for path 'x' full output: { "responseHeader":{ "status":0, "QTime":0}, "params":{"wt":"json"}, "context":{ "webapp":"", "path":"/test1", "httpMethod":"GET"}, "class":"org.apache.solr.core.BlobStoreTestRequestHandler", "x":"X val"} at __randomizedtesting.SeedInfo.seed([1A489CD376F2486A:C205B184812FEDCA]: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:456) at org.apache.solr.core.TestDynamicLoading.testDynamicLoading(TestDynamicLoading.java:255) 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:497) 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:964) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:939) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 11027 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/init-core-data-001 [junit4] 2> 295276 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[1A489CD376F2486A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 295276 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[1A489CD376F2486A]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 295281 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 295281 INFO (Thread-4227) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 295281 INFO (Thread-4227) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 295381 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.ZkTestServer start zk server on port:50226 [junit4] 2> 295382 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 295382 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 295390 INFO (zkCallback-899-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@645117a2 name:ZooKeeperConnection Watcher:127.0.0.1:50226 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 295390 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 295390 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 295390 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 295396 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 295396 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 295397 INFO (zkCallback-900-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7deec9c9 name:ZooKeeperConnection Watcher:127.0.0.1:50226/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 295397 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 295397 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 295398 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 295399 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 295401 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 295402 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 295404 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 295404 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 295407 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 295407 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 295409 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 295409 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 295413 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 295413 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 295417 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 295417 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 295419 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 295419 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 295421 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 295421 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 295426 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 295426 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 295430 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 295430 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 295432 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 295432 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 295434 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 295434 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 295444 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 295445 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 295449 INFO (zkCallback-901-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16865410 name:ZooKeeperConnection Watcher:127.0.0.1:50226 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 295449 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 295449 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 295449 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 295451 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 295452 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 295453 INFO (zkCallback-902-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6986b361 name:ZooKeeperConnection Watcher:127.0.0.1:50226/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 295453 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 295453 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 295454 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf2/solrconfig.xml [junit4] 2> 295454 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml [junit4] 2> 295457 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf2/schema.xml [junit4] 2> 295457 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml [junit4] 2> 295459 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf2/enumsConfig.xml [junit4] 2> 295459 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml [junit4] 2> 295470 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 295471 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 295472 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf2/stopwords.txt [junit4] 2> 295472 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt [junit4] 2> 295473 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf2/protwords.txt [junit4] 2> 295473 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt [junit4] 2> 295475 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf2/currency.xml [junit4] 2> 295475 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml [junit4] 2> 295476 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf2/open-exchange-rates.json [junit4] 2> 295476 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json [junit4] 2> 295479 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 295479 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 295483 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf2/old_synonyms.txt [junit4] 2> 295483 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt [junit4] 2> 295486 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf2/synonyms.txt [junit4] 2> 295486 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt [junit4] 2> 295488 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/elevate.xml to /configs/conf2/elevate.xml [junit4] 2> 295488 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml [junit4] 2> 295603 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1 [junit4] 2> 295605 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 295607 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1fe866cd{/,null,AVAILABLE} [junit4] 2> 295616 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.e.j.s.ServerConnector Started ServerConnector@277d8c99{HTTP/1.1}{127.0.0.1:52323} [junit4] 2> 295616 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.e.j.s.Server Started @298758ms [junit4] 2> 295616 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/tempDir-001/control/data, hostContext=/, hostPort=52323, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores} [junit4] 2> 295617 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 295617 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001' [junit4] 2> 295617 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 295617 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 295617 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 295622 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 295623 INFO (zkCallback-903-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5a32ee4 name:ZooKeeperConnection Watcher:127.0.0.1:50226/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 295623 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 295623 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 295624 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 295624 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/solr.xml [junit4] 2> 295629 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores [junit4] 2> 295630 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.CoreContainer New CoreContainer 1863071554 [junit4] 2> 295630 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001] [junit4] 2> 295630 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/lib [junit4] 2> 295630 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 295631 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 295632 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 295632 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 295632 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50226/solr [junit4] 2> 295632 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 295632 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 295633 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 295639 INFO (zkCallback-906-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7f055a01 name:ZooKeeperConnection Watcher:127.0.0.1:50226 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 295639 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 295639 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 295641 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 295651 INFO (zkCallback-907-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7b1aab39 name:ZooKeeperConnection Watcher:127.0.0.1:50226/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 295651 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 295659 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 295660 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 295663 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 295664 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 295666 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 295668 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 295669 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 295669 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 295670 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 295671 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52323_ [junit4] 2> 295672 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:52323_ [junit4] 2> 295673 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 295674 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 295675 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 295675 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95398194716540934-127.0.0.1:52323_-n_0000000000 [junit4] 2> 295676 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:52323_ [junit4] 2> 295676 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 295677 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.Overseer Overseer (id=95398194716540934-127.0.0.1:52323_-n_0000000000) starting [junit4] 2> 295678 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 295683 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 295684 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 295684 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 295688 INFO (OverseerCollectionConfigSetProcessor-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 295695 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 295710 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 295710 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 295711 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores [junit4] 2> 295712 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] 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> 295712 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1 [junit4] 2> 295712 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 295714 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 295714 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 295716 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 295722 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1 [junit4] 2> 295722 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:52323_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 295722 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] 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:52323";, [junit4] 2> "node_name":"127.0.0.1:52323_", [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> 295723 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] 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:52323";, [junit4] 2> "node_name":"127.0.0.1:52323_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 295723 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 295724 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 295726 INFO (zkCallback-907-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ ] 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> 295726 INFO (zkCallback-907-thread-2-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ ] 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> 296716 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 296716 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 296717 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 296717 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 296718 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 296718 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1' [junit4] 2> 296718 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 296718 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 296720 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 296726 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 296731 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 296740 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 296746 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 296849 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 296855 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 296856 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 296870 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 296872 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 296874 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 296875 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 296876 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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-trunk/solr/build/solr-core/test/J1 [junit4] 2> 296876 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 296877 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 296877 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1/data/] [junit4] 2> 296877 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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@24b453c3 [junit4] 2> 296878 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1/data [junit4] 2> 296878 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1/data/index/ [junit4] 2> 296878 WARN (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 296878 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1/data/index [junit4] 2> 296879 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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=39, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=25.0439453125, floorSegmentMB=0.943359375, forceMergeDeletesPctAllowed=14.725817520948132, segmentsPerTier=19.0, maxCFSSegmentSizeMB=0.2001953125, noCFSRatio=1.0 [junit4] 2> 296886 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/index-SimpleFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@f0e9c2c),segFN=segments_1,generation=1} [junit4] 2> 296886 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 296890 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 296890 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 296890 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 296890 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 296890 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 296890 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296890 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296891 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296891 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:52323_ 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-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1/data/ [junit4] 2> 296891 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296891 WARN (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296891 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 296893 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 296896 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 296899 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 296901 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 296904 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file [junit4] 2> 296905 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296905 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296905 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296906 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 296906 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 296906 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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=21, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=71.796875, floorSegmentMB=1.7939453125, forceMergeDeletesPctAllowed=1.6685891877534087, segmentsPerTier=42.0, maxCFSSegmentSizeMB=1.8310546875, noCFSRatio=1.0 [junit4] 2> 296911 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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(SimpleFSDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/index-SimpleFSDirectory-001 lockFactory=org.apache.lucene.store.NativeFSLockFactory@f0e9c2c),segFN=segments_1,generation=1} [junit4] 2> 296911 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 296911 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6c11e46c[collection1] main] [junit4] 2> 296912 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296915 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296915 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296915 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 296915 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 296915 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296916 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296916 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296916 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 296916 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 296918 INFO (searcherExecutor-1844-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6c11e46c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 296918 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296918 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296918 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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> 296918 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ 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 1526371117172785152 [junit4] 2> 296920 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 1526371117172785152 [junit4] 2> 296920 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 296920 INFO (coreLoadExecutor-1843-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 296921 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ 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:52323 collection:control_collection shard:shard1 [junit4] 2> 296922 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ 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> 296926 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ 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/95398194716540934-core_node1-n_0000000000 [junit4] 2> 296927 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 and weAreReplacement=false and leaderVoteWait=180000 [junit4] 2> 296928 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 296928 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ 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> 296928 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:52323/collection1/ [junit4] 2> 296929 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 296929 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:52323/collection1/ has no replicas [junit4] 2> 296929 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] 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> 296929 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 296932 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node [junit4] 2> 296934 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ 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:52323/collection1/ shard1 [junit4] 2> 296934 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] 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:52323";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 297036 INFO (zkCallback-907-thread-2-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ ] 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> 297036 INFO (zkCallback-907-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ ] 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> 297087 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:52323/collection1/ and leader is http://127.0.0.1:52323/collection1/ [junit4] 2> 297087 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ 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:52323 [junit4] 2> 297087 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 297087 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 297087 INFO (coreZkRegister-1837-thread-1-processing-n:127.0.0.1:52323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:52323_ 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> 297094 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] 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:52323";, [junit4] 2> "node_name":"127.0.0.1:52323_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 2 [junit4] 2> 297095 INFO (OverseerStateUpdate-95398194716540934-127.0.0.1:52323_-n_0000000000) [n:127.0.0.1:52323_ ] o.a.s.c.o.ReplicaMutator Update state numShards=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:52323";, [junit4] 2> "node_name":"127.0.0.1:52323_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 297198 INFO (zkCallback-907-thread-2-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ ] 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> 297198 INFO (zkCallback-907-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ ] 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> 297224 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 297225 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 297225 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@74b24ec1 name:ZooKeeperConnection Watcher:127.0.0.1:50226/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 297225 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 297226 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 297226 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 297228 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 297323 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001/cores/collection1 [junit4] 2> 297324 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001 [junit4] 2> 297324 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 297332 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@23ae156f{/,null,AVAILABLE} [junit4] 2> 297335 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.e.j.s.ServerConnector Started ServerConnector@26e2a270{HTTP/1.1}{127.0.0.1:33842} [junit4] 2> 297335 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.e.j.s.Server Started @300476ms [junit4] 2> 297335 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/, hostPort=33842, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001/cores} [junit4] 2> 297335 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 297335 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001' [junit4] 2> 297335 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 297335 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 297336 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 297338 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 297339 INFO (zkCallback-910-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@45db7298 name:ZooKeeperConnection Watcher:127.0.0.1:50226/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 297339 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 297340 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 297341 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 297341 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001/solr.xml [junit4] 2> 297346 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001/cores [junit4] 2> 297346 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.CoreContainer New CoreContainer 1330663732 [junit4] 2> 297346 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001] [junit4] 2> 297346 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_1A489CD376F2486A-001/shard-1-001/lib [junit4] 2> 297347 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 297348 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 297348 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 297349 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 297349 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:50226/solr [junit4] 2> 297349 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 297349 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 297350 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 297350 INFO (zkCallback-913-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@195a5306 name:ZooKeeperConnection Watcher:127.0.0.1:50226 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 297351 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 297351 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 297355 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:33842_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 297359 INFO (zkCallback-914-thread-1-processing-n:127.0.0.1:33842_) [n:127.0.0.1:33842_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2d621e09 name:ZooKeeperConnection Watcher:127.0.0.1:50226/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 297359 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:33842_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 297363 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:33842_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 298368 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:33842_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33842_ [junit4] 2> 298369 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[1A489CD376F2486A]) [n:127.0.0.1:33842_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:33842_ [junit4] 2> 298370 INFO (zkCallback-909-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 298370 INFO (zkCallback-907-thread-1-processing-n:127.0.0.1:52323_) [n:127.0.0.1:52323_ ] o.a.s.c.c.ZkStateReader [...truncated too long message...] 86A]-worker) [ ] o.a.h.m.l.MethodMetric Error invoking method getBlocksTotal [junit4] 2> java.lang.reflect.InvocationTargetException [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497) [junit4] 2> at org.apache.hadoop.metrics2.lib.MethodMetric$2.snapshot(MethodMetric.java:111) [junit4] 2> at org.apache.hadoop.metrics2.lib.MethodMetric.snapshot(MethodMetric.java:144) [junit4] 2> at org.apache.hadoop.metrics2.lib.MetricsRegistry.snapshot(MetricsRegistry.java:387) [junit4] 2> at org.apache.hadoop.metrics2.lib.MetricsSourceBuilder$1.getMetrics(MetricsSourceBuilder.java:79) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMetrics(MetricsSourceAdapter.java:195) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.updateJmxCache(MetricsSourceAdapter.java:172) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMBeanInfo(MetricsSourceAdapter.java:151) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:430) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415) [junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546) [junit4] 2> at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:81) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stopMBeans(MetricsSourceAdapter.java:227) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stop(MetricsSourceAdapter.java:212) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:461) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:212) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:592) [junit4] 2> at org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72) [junit4] 2> at org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:198) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsChaosMonkeyNothingIsSafeTest.teardownClass(HdfsChaosMonkeyNothingIsSafeTest.java:47) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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:198) [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223) [junit4] 2> ... 54 more [junit4] 2> 1563925 INFO (SUITE-HdfsChaosMonkeyNothingIsSafeTest-seed#[1A489CD376F2486A]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsChaosMonkeyNothingIsSafeTest_1A489CD376F2486A-001 [junit4] 2> Feb 16, 2016 10:36:39 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Lucene60, sim=ClassicSimilarity, locale=es-AR, timezone=Asia/Qatar [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=4,threads=3,free=209194592,total=523763712 [junit4] 2> NOTE: All tests run in this JVM: [TestSortByMinMaxFunction, TestFastWriter, TestManagedSchemaFieldTypeResource, CoreMergeIndexesAdminHandlerTest, RestartWhileUpdatingTest, FieldAnalysisRequestHandlerTest, TestJmxIntegration, TestFieldCollectionResource, RegexBoostProcessorTest, BigEndianAscendingWordSerializerTest, TestSolrDeletionPolicy1, TestRandomRequestDistribution, WrapperMergePolicyFactoryTest, TestCloudSchemaless, FullSolrCloudDistribCmdsTest, FullHLLTest, TestReloadDeadlock, TestZkChroot, LeaderElectionTest, SparseHLLTest, TestDynamicLoading, LukeRequestHandlerTest, SharedFSAutoReplicaFailoverUtilsTest, HdfsLockFactoryTest, PreAnalyzedUpdateProcessorTest, SolrXmlInZkTest, TestFreeTextSuggestions, SimpleFacetsTest, DistributedQueryComponentOptimizationTest, SliceStateTest, DistribCursorPagingTest, TestReversedWildcardFilterFactory, TestXIncludeConfig, OverseerRolesTest, SolrTestCaseJ4Test, TestDFISimilarityFactory, TestLRUStatsCache, ShowFileRequestHandlerTest, TestComplexPhraseQParserPlugin, ClusterStateTest, AutoCommitTest, TestCoreDiscovery, TestFilteredDocIdSet, HdfsChaosMonkeyNothingIsSafeTest] [junit4] Completed [137/579 (3!)] on J2 in 111.43s, 1 test, 1 failure <<< FAILURES! [...truncated 1426 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:524: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1014: There were test failures: 579 suites (8 ignored), 2331 tests, 1 error, 2 failures, 34 ignored (18 assumptions) [seed: 1A489CD376F2486A] Total time: 227 minutes 58 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: [email protected] For additional commands, e-mail: [email protected]
