Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.3/9/
2 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Error from server at https://127.0.0.1:48730: Error CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create core [halfcollection_shard1_replica1] Caused by: Could not get shard id for core: halfcollection_shard1_replica1 Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:48730: Error CREATEing SolrCore 'halfcollection_shard1_replica1': Unable to create core [halfcollection_shard1_replica1] Caused by: Could not get shard id for core: halfcollection_shard1_replica1 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:301) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:418) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:168) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) 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:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) 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:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=95103, name=collection4, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=95103, name=collection4, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:54815/t_ek/oe: Could not find collection : awholynewstresscollection_collection4_0 at __randomizedtesting.SeedInfo.seed([6B115E9977A97773]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1085) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:894) Build Log: [...truncated 11499 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/init-core-data-001 [junit4] 2> 2785491 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[6B115E9977A97773]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) [junit4] 2> 2785491 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[6B115E9977A97773]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 2785496 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2785497 INFO (Thread-45712) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2785497 INFO (Thread-45712) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2785597 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.ZkTestServer start zk server on port:40584 [junit4] 2> 2785597 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2785598 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2785601 INFO (zkCallback-1427-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@359fa838 name:ZooKeeperConnection Watcher:127.0.0.1:40584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2785602 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2785602 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2785602 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 2785607 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2785607 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2785611 INFO (zkCallback-1428-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@c89e409 name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2785611 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2785612 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2785612 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 2785614 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 2785616 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 2785618 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 2785619 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 2785620 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 2785622 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 2785623 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 2785625 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2785625 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2785631 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 2785631 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 2785633 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 2785633 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 2785635 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 2785636 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 2785638 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 2785638 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 2785640 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 2785640 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 2785642 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2785643 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2785645 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 2785645 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 2785651 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 2785652 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 2785655 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2785655 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2785659 INFO (zkCallback-1429-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2921a5c4 name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2785659 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2785659 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2785661 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2785662 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2785663 INFO (zkCallback-1430-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5e7034de name:ZooKeeperConnection Watcher:127.0.0.1:40584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2785664 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2785664 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2785665 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 2785668 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2785674 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2785687 INFO (zkCallback-1431-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@78341c65 name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2785687 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2785688 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2785688 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf2/solrconfig.xml [junit4] 2> 2785689 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml [junit4] 2> 2785691 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf2/schema.xml [junit4] 2> 2785692 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml [junit4] 2> 2785694 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf2/enumsConfig.xml [junit4] 2> 2785695 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml [junit4] 2> 2785697 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2785697 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2785699 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf2/stopwords.txt [junit4] 2> 2785699 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt [junit4] 2> 2785701 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf2/protwords.txt [junit4] 2> 2785701 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt [junit4] 2> 2785703 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf2/currency.xml [junit4] 2> 2785703 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml [junit4] 2> 2785705 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf2/open-exchange-rates.json [junit4] 2> 2785705 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json [junit4] 2> 2785706 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 2785707 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 2785709 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf2/old_synonyms.txt [junit4] 2> 2785709 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt [junit4] 2> 2785711 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf2/synonyms.txt [junit4] 2> 2785712 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt [junit4] 2> 2785714 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/elevate.xml to /configs/conf2/elevate.xml [junit4] 2> 2785714 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml [junit4] 2> 2786030 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1 [junit4] 2> 2786032 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 2786034 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2080209f{/,null,AVAILABLE} [junit4] 2> 2786038 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.e.j.s.ServerConnector Started ServerConnector@6e913270{SSL-http/1.1}{127.0.0.1:40598} [junit4] 2> 2786039 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.e.j.s.Server Started @2793263ms [junit4] 2> 2786039 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores, hostPort=40598, solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/tempDir-001/control/data, hostContext=/} [junit4] 2> 2786040 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1fe91485 [junit4] 2> 2786040 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/' [junit4] 2> 2786079 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2786080 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2786081 INFO (zkCallback-1432-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6a3731a6 name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2786081 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2786082 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2786083 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2786083 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/solr.xml [junit4] 2> 2786099 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores [junit4] 2> 2786100 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.CoreContainer New CoreContainer 1133113664 [junit4] 2> 2786100 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/] [junit4] 2> 2786100 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/lib [junit4] 2> 2786100 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/lib). [junit4] 2> 2786110 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] 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> 2786119 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2786121 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2786121 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2786121 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40584/solr [junit4] 2> 2786121 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 2786121 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2786122 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2786125 INFO (zkCallback-1434-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3230785b name:ZooKeeperConnection Watcher:127.0.0.1:40584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2786126 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2786126 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2786128 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2786131 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@79e04c35 name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2786131 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2786132 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 2786134 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 2786136 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 2786138 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 2786140 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 2786143 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 2786145 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 2786146 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 2786147 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 2786148 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40598_ [junit4] 2> 2786149 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:40598_ [junit4] 2> 2786150 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 2786152 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 2786154 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2786155 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94368158350573575-127.0.0.1:40598_-n_0000000000 [junit4] 2> 2786155 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:40598_ [junit4] 2> 2786156 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 2786157 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.Overseer Overseer (id=94368158350573575-127.0.0.1:40598_-n_0000000000) starting [junit4] 2> 2786159 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 2786165 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 2786165 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 2786165 INFO (OverseerCollectionProcessor-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations [junit4] 2> 2786166 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 2786177 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 2786177 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2786178 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores [junit4] 2> 2786179 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.SolrCore Created CoreDescriptor: {transient=false, loadOnStartup=true, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1, configSetProperties=configsetprops.json, coreNodeName=, config=solrconfig.xml, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/, name=collection1, collection=control_collection, shard=, dataDir=data/, schema=schema.xml} [junit4] 2> 2786180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/ [junit4] 2> 2786180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 2786181 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2 [junit4] 2> 2786181 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:40598_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 2786183 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 2786183 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 2786183 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 2786183 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2786186 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "numShards":"1", [junit4] 2> "base_url":"https://127.0.0.1:40598";, [junit4] 2> "state":"down", [junit4] 2> "core":"collection1", [junit4] 2> "node_name":"127.0.0.1:40598_", [junit4] 2> "operation":"state", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "roles":null} current state version: 0 [junit4] 2> 2786187 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "numShards":"1", [junit4] 2> "base_url":"https://127.0.0.1:40598";, [junit4] 2> "state":"down", [junit4] 2> "core":"collection1", [junit4] 2> "node_name":"127.0.0.1:40598_", [junit4] 2> "operation":"state", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "roles":null} [junit4] 2> 2786187 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 2786187 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 2786189 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] 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> 2786190 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 1 [junit4] 2> 2787184 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 2787184 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 2787185 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 2787185 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 2787185 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2787186 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/' [junit4] 2> 2787203 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 2787209 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2787227 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0 [junit4] 2> 2787258 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 2787259 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 2787265 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2787536 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2787543 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 2787545 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2787555 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2787558 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2787561 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2787562 WARN (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 2787562 WARN (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 2787562 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2787563 WARN (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 2787563 WARN (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 2787564 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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-5.3/solr/build/solr-core/test/J2 [junit4] 2> 2787565 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 2787565 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2787565 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/], dataDir=[null] [junit4] 2> 2787565 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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@71f7162 [junit4] 2> 2787566 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/data [junit4] 2> 2787566 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/data/index/ [junit4] 2> 2787566 WARN (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2787567 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/data/index [junit4] 2> 2787567 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@318689d9 [junit4] 2> 2787568 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@77c41ef5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6ccca440),segFN=segments_1,generation=1} [junit4] 2> 2787568 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2787568 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:40598_ 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-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/data/ [junit4] 2> 2787568 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 2787573 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 2787573 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 2787574 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2787574 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2787574 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2787574 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787574 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787575 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787575 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787578 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2787580 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2787581 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2787582 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2787586 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/ping,/admin/file,/admin/mbeans,standard,/config,/update,/admin/plugins,/schema,/update/json,/admin/segments,/admin/properties,/admin/threads,/update/json/docs,/admin/system,/get,/admin/logging,/replication,/admin/luke,/update/csv [junit4] 2> 2787588 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787588 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787588 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787589 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 2787589 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 2787590 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=41, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 2787590 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@77c41ef5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6ccca440),segFN=segments_1,generation=1} [junit4] 2> 2787591 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2787591 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@7de61768[collection1] main [junit4] 2> 2787591 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787592 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787592 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787593 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 2787593 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 2787593 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787593 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787594 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787594 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 2787594 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2787595 INFO (searcherExecutor-4469-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7de61768[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2787596 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787596 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787596 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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> 2787596 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ 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 1509890535809089536 [junit4] 2> 2787599 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 3 ms to seed version buckets with highest version 1509890535809089536 [junit4] 2> 2787599 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 2787600 INFO (coreLoadExecutor-4468-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 2787600 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:https://127.0.0.1:40598 collection:control_collection shard:shard1 [junit4] 2> 2787602 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ 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> 2787605 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ 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/94368158350573575-core_node1-n_0000000000 [junit4] 2> 2787606 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 [junit4] 2> 2787608 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2787608 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 2787608 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ 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> 2787608 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] 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> 2787608 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:40598/collection1/ [junit4] 2> 2787609 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 2787609 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy https://127.0.0.1:40598/collection1/ has no replicas [junit4] 2> 2787609 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:40598/collection1/ shard1 [junit4] 2> 2787609 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 2787614 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2787615 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] 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":"https://127.0.0.1:40598";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 2787686 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2787686 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2787689 INFO (zkCallback-1437-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3b4a6507 name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2787689 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2787690 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2787690 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 2787692 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 2787693 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 2787693 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2787693 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2787695 INFO (zkCallback-1438-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@48598593 name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2787695 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2787695 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2787697 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2787698 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"create", [junit4] 2> "name":"collection1", [junit4] 2> "numShards":"2", [junit4] 2> "stateFormat":"2"} current state version: 1 [junit4] 2> 2787698 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 2787702 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] 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> 2787703 INFO (zkCallback-1437-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 2787705 INFO (zkCallback-1437-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 2 [junit4] 2> 2787705 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 2 [junit4] 2> 2787716 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are https://127.0.0.1:40598/collection1/ and leader is https://127.0.0.1:40598/collection1/ [junit4] 2> 2787716 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:40598 [junit4] 2> 2787716 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 2787716 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 2787716 INFO (coreZkRegister-4462-thread-1-processing-r:core_node1 x:collection1 n:127.0.0.1:40598_ s:shard1 c:control_collection) [n:127.0.0.1:40598_ 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> 2787718 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2787718 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "numShards":"2", [junit4] 2> "base_url":"https://127.0.0.1:40598";, [junit4] 2> "state":"active", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "core":"collection1", [junit4] 2> "node_name":"127.0.0.1:40598_", [junit4] 2> "operation":"state", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "roles":null} current state version: 2 [junit4] 2> 2787720 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "numShards":"2", [junit4] 2> "base_url":"https://127.0.0.1:40598";, [junit4] 2> "state":"active", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "core":"collection1", [junit4] 2> "node_name":"127.0.0.1:40598_", [junit4] 2> "operation":"state", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "roles":null} [junit4] 2> 2787720 INFO (OverseerStateUpdate-94368158350573575-127.0.0.1:40598_-n_0000000000) [n:127.0.0.1:40598_ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/collection1/state.json [junit4] 2> 2787721 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] 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> 2787721 INFO (zkCallback-1437-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 2787723 INFO (zkCallback-1437-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 3 [junit4] 2> 2787723 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 3 [junit4] 2> 2787826 INFO (zkCallback-1437-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 2787826 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] 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> 2787828 INFO (zkCallback-1437-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 4 [junit4] 2> 2787829 INFO (zkCallback-1435-thread-1-processing-n:127.0.0.1:40598_) [n:127.0.0.1:40598_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 4 [junit4] 2> 2788074 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/cores/collection1 [junit4] 2> 2788075 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001 [junit4] 2> 2788076 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 2788083 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1c713cbb{/,null,AVAILABLE} [junit4] 2> 2788086 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.e.j.s.ServerConnector Started ServerConnector@666c4c0c{SSL-http/1.1}{127.0.0.1:48730} [junit4] 2> 2788086 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.e.j.s.Server Started @2795310ms [junit4] 2> 2788086 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/tempDir-001/jetty1, hostPort=48730, hostContext=/, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/cores, solrconfig=solrconfig.xml} [junit4] 2> 2788086 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1fe91485 [junit4] 2> 2788087 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/' [junit4] 2> 2788126 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2788130 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2788130 INFO (zkCallback-1439-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@d5b41de name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2788131 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2788131 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2788132 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2788133 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/solr.xml [junit4] 2> 2788161 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/cores [junit4] 2> 2788161 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.CoreContainer New CoreContainer 2100620127 [junit4] 2> 2788162 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/] [junit4] 2> 2788162 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/lib [junit4] 2> 2788162 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/lib). [junit4] 2> 2788176 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] 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> 2788180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2788182 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2788183 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2788183 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40584/solr [junit4] 2> 2788183 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 2788183 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2788184 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2788186 INFO (zkCallback-1441-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@78e3d78b name:ZooKeeperConnection Watcher:127.0.0.1:40584 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2788188 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2788188 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2788191 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2788195 INFO (zkCallback-1442-thread-1-processing-n:127.0.0.1:48730_) [n:127.0.0.1:48730_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@40257e2 name:ZooKeeperConnection Watcher:127.0.0.1:40584/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2788196 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2788202 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 2789207 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:48730_ [junit4] 2> 2789208 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:48730_ [junit4] 2> 2789211 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2789211 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94368158350573580-127.0.0.1:48730_-n_0000000001 [junit4] 2> 2789212 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/94368158350573575-127.0.0.1:40598_-n_0000000000 to know if I could be the leader [junit4] 2> 2789221 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 2789221 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2789222 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/cores [junit4] 2> 2789223 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[6B115E9977A97773]) [n:127.0.0.1:48730_ ] o.a.s.c.SolrCore Created CoreDescriptor: {collection=collection1, coreNodeName=, dataDir=data/, configSetProperties=configsetprops.json, name=collection1, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/cores/collection1/, shard=, config=solrconfig.xml, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_6B115E9977A97773-001/shard-1-001/cores/collection1, schema=schema.xml, loadOnStartup=true, t [...truncated too long message...] nServerInterceptor.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:197) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.teardownClass(HdfsCollectionsAPIDistributedZkTest.java:50) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:606) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799) [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:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [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:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [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> ... 53 more [junit4] 2> 5159347 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[6B115E9977A97773]-worker) [n:127.0.0.1:51499_t_ek%2Foe c:addReplicaColl s:shard2 r:core_node6 x:addReplicaColl_shard2_replica3] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> Aug 18, 2015 9:03:20 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), a_i1=FST50, timestamp=FST50, text=PostingsFormat(name=Direct), range_facet_l_dv=PostingsFormat(name=Memory doPackFST= true), range_facet_i_dv=FST50, a_t=FST50, _version_=FST50, other_tl1=FST50, id=PostingsFormat(name=Memory doPackFST= true), range_facet_l=FST50, intDefault=FST50}, docValues:{timestamp=DocValuesFormat(name=Asserting), range_facet_l_dv=DocValuesFormat(name=Lucene50), range_facet_i_dv=DocValuesFormat(name=Asserting)}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=el_GR, timezone=Australia/West [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.7.0_72 (64-bit)/cpus=4,threads=2,free=299213632,total=534249472 [junit4] 2> NOTE: All tests run in this JVM: [TestWordDelimiterFilterFactory, TestStressUserVersions, TestNamedUpdateProcessors, SolrIndexConfigTest, TestConfig, JavabinLoaderTest, MBeansHandlerTest, TestReversedWildcardFilterFactory, TestExactStatsCache, UUIDUpdateProcessorFallbackTest, TestCryptoKeys, TestDocBasedVersionConstraints, AnalysisErrorHandlingTest, TestConfigOverlay, TestObjectReleaseTracker, TestCollectionAPI, SuggesterFSTTest, TestCustomSort, ParsingFieldUpdateProcessorsTest, TestManagedSchemaFieldResource, TestRemoteStreaming, TestCloudManagedSchemaConcurrent, TestBinaryField, TestCloudInspectUtil, CleanupOldIndexTest, ExternalFileFieldSortTest, TestStressLucene, TestCodecSupport, PeerSyncTest, ConnectionManagerTest, UUIDFieldTest, DistributedFacetPivotSmallAdvancedTest, TestFieldResource, TestSolrConfigHandler, StressHdfsTest, TestSweetSpotSimilarityFactory, DefaultValueUpdateProcessorTest, RequestHandlersTest, TestReplicationHandler, TestRealTimeGet, TestRandomFaceting, ZkNodePropsTest, DebugComponentTest, BasicDistributedZkTest, TermVectorComponentTest, TestMiniSolrCloudClusterSSL, IndexBasedSpellCheckerTest, TestChildDocTransformer, TestJmxMonitoredMap, StandardRequestHandlerTest, TestBadConfig, TestCursorMarkWithoutUniqueKey, TestFieldSortValues, HdfsDirectoryTest, MultiTermTest, TestQuerySenderListener, HdfsRecoverLeaseTest, ExitableDirectoryReaderTest, IndexSchemaTest, HighlighterTest, HLLUtilTest, TestSolrConfigHandlerCloud, HdfsSyncSliceTest, CoreAdminRequestStatusTest, TestUniqueKeyFieldResource, TestMergePolicyConfig, UpdateRequestProcessorFactoryTest, TestTolerantSearch, MultiThreadedOCPTest, SolrCloudExampleTest, TestLazyCores, AddBlockUpdateTest, SchemaVersionSpecificBehaviorTest, UniqFieldsUpdateProcessorFactoryTest, SaslZkACLProviderTest, SimplePostToolTest, LeaderInitiatedRecoveryOnCommitTest, CoreMergeIndexesAdminHandlerTest, BitVectorTest, MigrateRouteKeyTest, DateFieldTest, TestArbitraryIndexDir, TestSolrIndexConfig, TestFaceting, DeleteLastCustomShardedReplicaTest, SyncSliceTest, OpenCloseCoreStressTest, ClusterStateUpdateTest, LeaderElectionTest, ZkSolrClientTest, TestDistributedSearch, PreAnalyzedFieldTest, TestSystemIdResolver, RAMDirectoryFactoryTest, ClusterStateTest, TestSolrJ, TestUtils, TestDocumentBuilder, FileUtilsTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, DistributedIntervalFacetingTest, TestJettySolrRunner, AssignTest, CloudExitableDirectoryReaderTest, CollectionsAPIAsyncDistributedZkTest, DeleteInactiveReplicaTest, DistribJoinFromCollectionTest, OverseerStatusTest, RecoveryAfterSoftCommitTest, TestDownShardTolerantSearch, TestRebalanceLeaders, HdfsCollectionsAPIDistributedZkTest] [junit4] Completed [464/531] on J0 in 516.66s, 1 test, 1 error <<< FAILURES! [...truncated 223 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:733: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:670: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build.xml:230: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/common-build.xml:524: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/lucene/common-build.xml:1449: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/lucene/common-build.xml:1003: There were test failures: 531 suites, 2104 tests, 2 errors, 26 ignored (14 assumptions) Total time: 262 minutes 41 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 Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
