Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.3/5/
3 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=13575, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=13575, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:53122: collection already exists: awholynewstresscollection_collection2_0 at __randomizedtesting.SeedInfo.seed([8DF3D58615A632E6]: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.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1572) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:887) REGRESSION: org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test Error Message: Timeout waiting for all live and active Stack Trace: java.lang.AssertionError: Timeout waiting for all live and active at __randomizedtesting.SeedInfo.seed([8DF3D58615A632E6:5A7EA5CBB5A5F1E]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.testBasics(SharedFSAutoReplicaFailoverTest.java:194) at org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test(SharedFSAutoReplicaFailoverTest.java:108) 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=1914, name=collection3, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=1914, name=collection3, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:51064: Could not find collection : awholynewstresscollection_collection3_0 at __randomizedtesting.SeedInfo.seed([8DF3D58615A632E6]: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 10852 lines...] [junit4] Suite: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/init-core-data-001 [junit4] 2> 172334 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) [junit4] 2> 172334 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 172959 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your platform... using builtin-java classes where applicable [junit4] 1> Formatting using clusterid: testClusterID [junit4] 2> 173881 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 174102 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via org.mortbay.log.Slf4jLog [junit4] 2> 174122 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 174289 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 174347 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/hdfs to ./temp/Jetty_localhost_51908_hdfs____wgak5r/webapp [junit4] 2> 174640 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 175543 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:51908 [junit4] 2> 176422 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 176430 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 176442 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_41403_datanode____iu4ps1/webapp [junit4] 2> 176576 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 177074 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:41403 [junit4] 2> 177176 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 177179 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 177204 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log Extract jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode to ./temp/Jetty_localhost_47761_datanode____2ifu46/webapp [junit4] 2> 177328 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 178317 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8DF3D58615A632E6]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:47761 [junit4] 2> 178515 INFO (IPC Server handler 1 on 60696) [ ] BlockStateChange BLOCK* processReport: from storage DS-ee81f8d3-9cee-4239-b950-721c76703c0d node DatanodeRegistration(127.0.0.1, datanodeUuid=44d41111-9f6b-4f88-8ac3-f5421c32b49c, infoPort=41403, ipcPort=50652, storageInfo=lv=-56;cid=testClusterID;nsid=601038640;c=0), blocks: 0, hasStaleStorages: true, processing time: 2 msecs [junit4] 2> 178515 INFO (IPC Server handler 2 on 60696) [ ] BlockStateChange BLOCK* processReport: from storage DS-3942e026-75ec-4e93-b265-c5c9332495e0 node DatanodeRegistration(127.0.0.1, datanodeUuid=e80bf4b6-4411-4be9-b15e-3dcf66e47a06, infoPort=47761, ipcPort=37696, storageInfo=lv=-56;cid=testClusterID;nsid=601038640;c=0), blocks: 0, hasStaleStorages: true, processing time: 0 msecs [junit4] 2> 178517 INFO (IPC Server handler 1 on 60696) [ ] BlockStateChange BLOCK* processReport: from storage DS-8a81fbb6-62aa-4d41-b34a-c78f26139a37 node DatanodeRegistration(127.0.0.1, datanodeUuid=44d41111-9f6b-4f88-8ac3-f5421c32b49c, infoPort=41403, ipcPort=50652, storageInfo=lv=-56;cid=testClusterID;nsid=601038640;c=0), blocks: 0, hasStaleStorages: false, processing time: 0 msecs [junit4] 2> 178519 INFO (IPC Server handler 2 on 60696) [ ] BlockStateChange BLOCK* processReport: from storage DS-8f78d040-17b7-4a9d-b36d-237827aac451 node DatanodeRegistration(127.0.0.1, datanodeUuid=e80bf4b6-4411-4be9-b15e-3dcf66e47a06, infoPort=47761, ipcPort=37696, storageInfo=lv=-56;cid=testClusterID;nsid=601038640;c=0), blocks: 0, hasStaleStorages: false, processing time: 0 msecs [junit4] 2> 179059 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 179059 INFO (Thread-453) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 179059 INFO (Thread-453) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 179162 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.ZkTestServer start zk server on port:45451 [junit4] 2> 179162 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 179163 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 179166 INFO (zkCallback-120-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@50563da2 name:ZooKeeperConnection Watcher:127.0.0.1:45451 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 179166 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 179167 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 179167 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 179174 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 179175 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 179176 INFO (zkCallback-121-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3a70d701 name:ZooKeeperConnection Watcher:127.0.0.1:45451/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 179176 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 179176 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 179176 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 179179 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 179181 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 179183 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 179185 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179185 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 179188 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179188 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 179190 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179191 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 179193 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179193 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 179195 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179195 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 179197 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179198 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 179213 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179213 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 179215 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179215 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 179217 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179217 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 179219 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179219 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 179221 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179221 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 179516 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores/collection1 [junit4] 2> 179519 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 179521 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@8e97b58{/,null,AVAILABLE} [junit4] 2> 179522 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.e.j.s.ServerConnector Started ServerConnector@667b27b7{HTTP/1.1}{127.0.0.1:35515} [junit4] 2> 179522 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.e.j.s.Server Started @182569ms [junit4] 2> 179522 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores, solr.data.dir=hdfs://localhost:60696/hdfs__localhost_60696__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-5.3_solr_build_solr-core_test_J0_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001_tempDir-002_control_data, hostPort=35515} [junit4] 2> 179523 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1fe91485 [junit4] 2> 179523 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/' [junit4] 2> 179538 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 179539 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 179541 INFO (zkCallback-122-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3faca6 name:ZooKeeperConnection Watcher:127.0.0.1:45451/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 179541 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 179541 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 179547 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 179548 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/solr.xml [junit4] 2> 179562 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores [junit4] 2> 179562 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.CoreContainer New CoreContainer 293142542 [junit4] 2> 179563 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/] [junit4] 2> 179563 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/lib [junit4] 2> 179563 WARN (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/lib). [junit4] 2> 179571 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 179572 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 179573 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 179573 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 179573 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45451/solr [junit4] 2> 179573 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 179573 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 179574 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 179576 INFO (zkCallback-124-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@24888521 name:ZooKeeperConnection Watcher:127.0.0.1:45451 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 179576 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 179576 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 179578 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 179579 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@305f6a55 name:ZooKeeperConnection Watcher:127.0.0.1:45451/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 179580 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 179581 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 179583 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 179586 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 179588 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 179591 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 179593 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 179595 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 179597 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 179598 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 179599 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35515_ [junit4] 2> 179600 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:35515_ [junit4] 2> 179602 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 179603 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 179605 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 179606 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94341427392610308-127.0.0.1:35515_-n_0000000000 [junit4] 2> 179607 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35515_ [junit4] 2> 179607 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 179608 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.Overseer Overseer (id=94341427392610308-127.0.0.1:35515_-n_0000000000) starting [junit4] 2> 179610 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 179617 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 179618 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 179618 INFO (OverseerCollectionProcessor-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations [junit4] 2> 179618 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 179635 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 179635 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 179636 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores [junit4] 2> 179637 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.SolrCore Created CoreDescriptor: {coreNodeName=, shard=, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores/collection1, collection=control_collection, dataDir=data/, config=solrconfig.xml, configSetProperties=configsetprops.json, loadOnStartup=true, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores/collection1/, schema=schema.xml, name=collection1, transient=false} [junit4] 2> 179637 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores/collection1/ [junit4] 2> 179637 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 179638 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 179638 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 179639 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0 [junit4] 2> 179639 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:35515_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 179639 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 179639 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 179640 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state", [junit4] 2> "base_url":"http://127.0.0.1:35515";, [junit4] 2> "core":"collection1", [junit4] 2> "shard":null, [junit4] 2> "node_name":"127.0.0.1:35515_", [junit4] 2> "state":"down", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null} current state version: 0 [junit4] 2> 179641 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state", [junit4] 2> "base_url":"http://127.0.0.1:35515";, [junit4] 2> "core":"collection1", [junit4] 2> "shard":null, [junit4] 2> "node_name":"127.0.0.1:35515_", [junit4] 2> "state":"down", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null} [junit4] 2> 179641 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 179641 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 179643 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] 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> 179644 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 1 [junit4] 2> 180639 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 180640 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 180640 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 180640 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 180641 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 180641 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores/collection1/' [junit4] 2> 180656 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 180664 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 180678 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0 [junit4] 2> 180725 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 180727 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 180746 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 181012 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 181022 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 181024 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 181038 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 181042 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 181045 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 181046 WARN (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 181046 WARN (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 181046 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 181047 WARN (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 181047 WARN (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 181049 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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/J0 [junit4] 2> 181049 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 181049 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory [junit4] 2> 181058 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:60696/solr_hdfs_home [junit4] 2> 181059 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled [junit4] 2> 181059 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/control-001/cores/collection1/], dataDir=[null] [junit4] 2> 181059 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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@5a56156e [junit4] 2> 181059 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:60696/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 181149 WARN (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will wait 5 seconds and try again. [junit4] 2> 186154 WARN (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsDirectory The NameNode is in SafeMode - Solr will wait 5 seconds and try again. [junit4] 2> 191202 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry hdfs://localhost:60696/solr_hdfs_home/control_collection/core_node1/data for locality metrics. [junit4] 2> 191202 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for hdfs://localhost:60696/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 191208 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=hdfs://localhost:60696/solr_hdfs_home/control_collection/core_node1/data/index/ [junit4] 2> 191245 WARN (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'hdfs:/localhost:60696/solr_hdfs_home/control_collection/core_node1/data/index' doesn't exist. Creating new index... [junit4] 2> 191245 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:60696/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 191268 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry hdfs://localhost:60696/solr_hdfs_home/control_collection/core_node1/data/index for locality metrics. [junit4] 2> 191268 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for hdfs://localhost:60696/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 191269 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=88.89453125, floorSegmentMB=1.7890625, forceMergeDeletesPctAllowed=22.92723653414726, segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 191620 INFO (IPC Server handler 5 on 60696) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:33308 is added to blk_1073741825_1001{blockUCState=COMMITTED, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-3942e026-75ec-4e93-b265-c5c9332495e0:NORMAL:127.0.0.1:48793|RBW], ReplicaUnderConstruction[[DISK]DS-8a81fbb6-62aa-4d41-b34a-c78f26139a37:NORMAL:127.0.0.1:33308|RBW]]} size 71 [junit4] 2> 191622 INFO (IPC Server handler 7 on 60696) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:48793 is added to blk_1073741825_1001 size 71 [junit4] 2> 192030 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(HdfsDirectory@b936602e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@595b246c; maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1} [junit4] 2> 192030 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 192033 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in hdfs://localhost:60696/solr_hdfs_home/control_collection/core_node1/data/ [junit4] 2> 192039 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 192039 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 192039 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 192040 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 192040 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 192040 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192040 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192041 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192041 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192044 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 192046 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 192047 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 192049 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 192054 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/properties,/replication,/admin/threads,/config,/admin/ping,/admin/mbeans,/admin/plugins,/update/json,standard,/schema,/update/csv,/admin/system,/update/json/docs,/update,/admin/segments,/get,/admin/luke,/admin/logging,/admin/file [junit4] 2> 192057 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192060 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog [junit4] 2> 192061 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing HdfsUpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 tlogDfsReplication=2 [junit4] 2> 192080 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 192080 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 192083 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 192156 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(HdfsDirectory@b936602e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@595b246c; maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1} [junit4] 2> 192157 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 192157 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3e001746[collection1] main [junit4] 2> 192157 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192159 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192159 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192159 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 192160 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 192160 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192161 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192161 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192161 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 192161 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 192164 INFO (searcherExecutor-452-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3e001746[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 192172 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192172 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 256 version buckets from index [junit4] 2> 192172 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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> 192172 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ 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 1509462852029644800 [junit4] 2> 192172 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 0 ms to seed version buckets with highest version 1509462852029644800 [junit4] 2> 192173 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 192173 INFO (coreLoadExecutor-451-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 192174 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:http://127.0.0.1:35515 collection:control_collection shard:shard1 [junit4] 2> 192175 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ 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> 192182 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ 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/94341427392610308-core_node1-n_0000000000 [junit4] 2> 192183 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 [junit4] 2> 192185 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 192185 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 192186 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ 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> 192186 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:35515/collection1/ [junit4] 2> 192186 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 192186 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:35515/collection1/ has no replicas [junit4] 2> 192186 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:35515/collection1/ shard1 [junit4] 2> 192186 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 192194 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] 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> 192196 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] 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> 192199 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 2 [junit4] 2> 192201 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "base_url":"http://127.0.0.1:35515";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 2 [junit4] 2> 192203 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 192305 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] 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> 192308 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 3 [junit4] 2> 192357 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:35515/collection1/ and leader is http://127.0.0.1:35515/collection1/ [junit4] 2> 192357 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:35515 [junit4] 2> 192357 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 192357 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 192357 INFO (coreZkRegister-445-thread-1-processing-c:control_collection x:collection1 s:shard1 n:127.0.0.1:35515_ r:core_node1) [n:127.0.0.1:35515_ 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> 192359 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 192360 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "base_url":"http://127.0.0.1:35515";, [junit4] 2> "core":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "node_name":"127.0.0.1:35515_", [junit4] 2> "state":"active", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null} current state version: 3 [junit4] 2> 192361 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "base_url":"http://127.0.0.1:35515";, [junit4] 2> "core":"collection1", [junit4] 2> "shard":"shard1", [junit4] 2> "node_name":"127.0.0.1:35515_", [junit4] 2> "state":"active", [junit4] 2> "numShards":"1", [junit4] 2> "roles":null} [junit4] 2> 192465 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] 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> 192467 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 4 [junit4] 2> 192644 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 192645 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 192646 INFO (zkCallback-127-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@22942b71 name:ZooKeeperConnection Watcher:127.0.0.1:45451/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 192647 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 192647 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 192647 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 192651 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 192651 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 192651 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 192651 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 192653 INFO (zkCallback-128-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5b3b5250 name:ZooKeeperConnection Watcher:127.0.0.1:45451/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 192653 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 192653 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 192655 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 192656 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x14f2b0743570006, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 192659 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] 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: 4 [junit4] 2> 192659 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 192764 INFO (OverseerStateUpdate-94341427392610308-127.0.0.1:35515_-n_0000000000) [n:127.0.0.1:35515_ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/collection1/state.json [junit4] 2> 192765 INFO (zkCallback-127-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> 192766 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] 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> 192768 INFO (zkCallback-127-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 5 [junit4] 2> 192768 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:35515_) [n:127.0.0.1:35515_ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 5 [junit4] 2> 192951 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001/cores/collection1 [junit4] 2> 192952 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001 [junit4] 2> 192955 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 192957 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@183c0ca5{/,null,AVAILABLE} [junit4] 2> 192957 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.e.j.s.ServerConnector Started ServerConnector@50835a77{HTTP/1.1}{127.0.0.1:34757} [junit4] 2> 192958 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.e.j.s.Server Started @196005ms [junit4] 2> 192958 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=34757, hostContext=/, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001/cores, solr.data.dir=hdfs://localhost:60696/hdfs__localhost_60696__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-5.3_solr_build_solr-core_test_J0_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001_tempDir-002_jetty1, solrconfig=solrconfig.xml} [junit4] 2> 192958 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@1fe91485 [junit4] 2> 192958 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001/' [junit4] 2> 192974 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 192975 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 192976 INFO (zkCallback-129-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3204f448 name:ZooKeeperConnection Watcher:127.0.0.1:45451/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 192976 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 192977 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 192978 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 192978 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001/solr.xml [junit4] 2> 193007 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001/cores [junit4] 2> 193008 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.CoreContainer New CoreContainer 359919949 [junit4] 2> 193008 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001/] [junit4] 2> 193008 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001/lib [junit4] 2> 193008 WARN (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_8DF3D58615A632E6-001/shard-1-001/lib). [junit4] 2> 193017 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] 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> 193019 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 193019 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 193020 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 193020 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45451/solr [junit4] 2> 193020 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 193020 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 193021 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 193023 INFO (zkCallback-131-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3c34b0d name:ZooKeeperConnection Watcher:127.0.0.1:45451 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 193024 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 193024 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 193027 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:34757_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 193028 INFO (zkCallback-132-thread-1-processing-n:127.0.0.1:34757_) [n:127.0.0.1:34757_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e87ce30 name:ZooKeeperConnection Watcher:127.0.0.1:45451/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 193028 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:34757_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 193034 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:34757_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 194047 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:34757_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34757_ [junit4] 2> 194048 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:34757_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:34757_ [junit4] 2> 194051 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:34757_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 194052 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:34757_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94341427392610313-127.0.0.1:34757_-n_0000000001 [junit4] 2> 194053 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127.0.0.1:34757_ ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/94341427392610308-127.0.0.1:35515_-n_0000000000 to know if I could be the leader [junit4] 2> 194065 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[8DF3D58615A632E6]) [n:127. [...truncated too long message...] g.apache.hadoop.metrics2.impl.MetricsSourceAdapter.updateJmxCache(MetricsSourceAdapter.java:172) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMBeanInfo(MetricsSourceAdapter.java:151) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:430) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415) [junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546) [junit4] 2> at org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:81) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stopMBeans(MetricsSourceAdapter.java:227) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stop(MetricsSourceAdapter.java:212) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:461) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:212) [junit4] 2> at org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:592) [junit4] 2> at org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72) [junit4] 2> at org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:197) [junit4] 2> at org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.hdfsFailoverAfterClass(SharedFSAutoReplicaFailoverTest.java:83) [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> 3321853 INFO (SUITE-SharedFSAutoReplicaFailoverTest-seed#[8DF3D58615A632E6]-worker) [n:127.0.0.1:54318_mv_ox c:solrj_collection2 s:shard2 r:core_node2 x:solrj_collection2_shard2_replica1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J0/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_8DF3D58615A632E6-001 [junit4] 2> Aug 14, 2015 3:58:03 AM 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): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=sr_ME, timezone=America/Vancouver [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.7.0_72 (64-bit)/cpus=4,threads=1,free=358735656,total=476577792 [junit4] 2> NOTE: All tests run in this JVM: [DeleteReplicaTest, TestSolrDeletionPolicy1, TestManagedSynonymFilterFactory, TestCSVLoader, HighlighterConfigTest, TestRealTimeGet, TestStressUserVersions, TestReqParamsAPI, CloudMLTQParserTest, AnalysisErrorHandlingTest, TestRangeQuery, ExternalFileFieldSortTest, SolrCoreTest, SuggesterWFSTTest, CleanupOldIndexTest, CoreMergeIndexesAdminHandlerTest, TestArbitraryIndexDir, HdfsCollectionsAPIDistributedZkTest, ExitableDirectoryReaderTest, TestJmxMonitoredMap, DistributedSpellCheckComponentTest, SolrIndexConfigTest, TestJmxIntegration, TimeZoneUtilsTest, TestPKIAuthenticationPlugin, HdfsDirectoryFactoryTest, StandardRequestHandlerTest, TestMiniSolrCloudClusterSSL, TestBlendedInfixSuggestions, EnumFieldTest, TestRemoteStreaming, DistanceUnitsTest, TestUpdate, TestDFRSimilarityFactory, TestSolr4Spatial, TestBadConfig, TestFieldSortValues, UniqFieldsUpdateProcessorFactoryTest, ConcurrentDeleteAndCreateCollectionTest, StressHdfsTest, DeleteLastCustomShardedReplicaTest, MBeansHandlerTest, UUIDUpdateProcessorFallbackTest, TestConfigOverlay, TestSolrConfigHandlerCloud, TestHdfsUpdateLog, TestRandomFaceting, TermVectorComponentTest, TestFaceting, TestChildDocTransformer, UUIDFieldTest, HighlighterTest, TestJoin, HdfsRecoveryZkTest, CSVRequestHandlerTest, DebugComponentTest, TestFieldCollectionResource, ChaosMonkeyNothingIsSafeTest, DefaultValueUpdateProcessorTest, SegmentsInfoRequestHandlerTest, TestRawResponseWriter, TestTolerantSearch, AddBlockUpdateTest, CurrencyFieldXmlFileTest, BasicDistributedZkTest, QueryElevationComponentTest, TestCursorMarkWithoutUniqueKey, LeaderElectionIntegrationTest, TestLazyCores, ClusterStateTest, TestCodecSupport, TestFieldResource, AddSchemaFieldsUpdateProcessorFactoryTest, DeleteShardTest, TestQuerySenderListener, IndexBasedSpellCheckerTest, HdfsDirectoryTest, TestReplicationHandler, TestRebalanceLeaders, TestSchemaSimilarityResource, TestMergePolicyConfig, TestBinaryField, TestRecoveryHdfs, ZkNodePropsTest, TestStressLucene, TestDocBasedVersionConstraints, SharedFSAutoReplicaFailoverTest] [junit4] Completed [424/531] on J0 in 225.69s, 1 test, 1 failure <<< FAILURES! [...truncated 359 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, 1 failure, 25 ignored (14 assumptions) Total time: 183 minutes 37 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]
