Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/807/
2 tests failed. FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=12379, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12379, name=collection0, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:43418/_j: Could not find collection : awholynewstresscollection_collection0_0 at __randomizedtesting.SeedInfo.seed([28E9BB72335AD47A]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895) FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=6508, name=collection2, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=6508, name=collection2, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:43430: Could not find collection : awholynewstresscollection_collection2_0 at __randomizedtesting.SeedInfo.seed([28E9BB72335AD47A]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895) Build Log: [...truncated 10194 lines...] [junit4] Suite: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/init-core-data-001 [junit4] 2> 439776 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 439776 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 1> Formatting using clusterid: testClusterID [junit4] 2> 439848 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 439855 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 439858 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 439871 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-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_42784_hdfs____.knc3s1/webapp [junit4] 2> 439985 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 440352 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:42784 [junit4] 2> 440454 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 440456 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 440469 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-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_39518_datanode____.7r0jdv/webapp [junit4] 2> 440574 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 440824 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:39518 [junit4] 2> 440874 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 440876 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 440890 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-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_53140_datanode____1og31y/webapp [junit4] 2> 440948 INFO (IPC Server handler 4 on 41031) [ ] BlockStateChange BLOCK* processReport: from storage DS-a4d90881-c9aa-4446-9149-8a8c391914a7 node DatanodeRegistration(127.0.0.1, datanodeUuid=8c1aa9d2-5cb1-432c-ae12-fba4f04e38bf, infoPort=39518, ipcPort=56498, storageInfo=lv=-56;cid=testClusterID;nsid=40386014;c=0), blocks: 0, hasStaleStorages: true, processing time: 1 msecs [junit4] 2> 440948 INFO (IPC Server handler 4 on 41031) [ ] BlockStateChange BLOCK* processReport: from storage DS-0f352c48-df75-421f-89a2-adbd0f40497d node DatanodeRegistration(127.0.0.1, datanodeUuid=8c1aa9d2-5cb1-432c-ae12-fba4f04e38bf, infoPort=39518, ipcPort=56498, storageInfo=lv=-56;cid=testClusterID;nsid=40386014;c=0), blocks: 0, hasStaleStorages: false, processing time: 0 msecs [junit4] 2> 441017 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 441327 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:53140 [junit4] 2> 441420 INFO (IPC Server handler 6 on 41031) [ ] BlockStateChange BLOCK* processReport: from storage DS-6b67412d-1e13-4829-9b61-04d02f5e8c4c node DatanodeRegistration(127.0.0.1, datanodeUuid=8d4fa09f-8264-4d87-b9f5-83d91c6b4b2f, infoPort=53140, ipcPort=37168, storageInfo=lv=-56;cid=testClusterID;nsid=40386014;c=0), blocks: 0, hasStaleStorages: true, processing time: 0 msecs [junit4] 2> 441421 INFO (IPC Server handler 6 on 41031) [ ] BlockStateChange BLOCK* processReport: from storage DS-78971cdf-8f06-4a07-aaa1-27fb66489579 node DatanodeRegistration(127.0.0.1, datanodeUuid=8d4fa09f-8264-4d87-b9f5-83d91c6b4b2f, infoPort=53140, ipcPort=37168, storageInfo=lv=-56;cid=testClusterID;nsid=40386014;c=0), blocks: 0, hasStaleStorages: false, processing time: 0 msecs [junit4] 2> 441516 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 441516 INFO (Thread-2005) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 441516 INFO (Thread-2005) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 441616 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.ZkTestServer start zk server on port:33781 [junit4] 2> 441617 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 441617 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 441621 INFO (zkCallback-489-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@13e5579f name:ZooKeeperConnection Watcher:127.0.0.1:33781 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 441621 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 441621 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 441621 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 441624 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 441624 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 441626 INFO (zkCallback-490-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2702d9ef name:ZooKeeperConnection Watcher:127.0.0.1:33781/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 441626 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 441626 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 441626 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 441628 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 441629 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 441631 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 441632 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 441632 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 441634 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 441635 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 441636 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 441636 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 441638 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 441638 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 441639 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 441639 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 441641 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 441641 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 441643 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 441643 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 441644 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 441644 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 441646 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 441646 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 441647 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 441647 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 441649 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 441649 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 441651 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 441651 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 441653 INFO (zkCallback-491-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@23c83269 name:ZooKeeperConnection Watcher:127.0.0.1:33781 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 441653 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 441654 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 441654 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 441655 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 441660 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 441660 INFO (zkCallback-492-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@50baf82c name:ZooKeeperConnection Watcher:127.0.0.1:33781/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 441660 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 441660 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 441660 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf2/solrconfig.xml [junit4] 2> 441661 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml [junit4] 2> 441663 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf2/schema.xml [junit4] 2> 441663 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml [junit4] 2> 441664 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf2/enumsConfig.xml [junit4] 2> 441665 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml [junit4] 2> 441666 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 441666 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 441667 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf2/stopwords.txt [junit4] 2> 441667 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt [junit4] 2> 441669 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf2/protwords.txt [junit4] 2> 441669 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt [junit4] 2> 441670 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf2/currency.xml [junit4] 2> 441670 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml [junit4] 2> 441672 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf2/open-exchange-rates.json [junit4] 2> 441672 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json [junit4] 2> 441673 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 441673 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 441675 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf2/old_synonyms.txt [junit4] 2> 441675 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt [junit4] 2> 441676 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf2/synonyms.txt [junit4] 2> 441676 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt [junit4] 2> 441678 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/elevate.xml to /configs/conf2/elevate.xml [junit4] 2> 441678 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml [junit4] 2> 441963 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores/collection1 [junit4] 2> 441965 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 441967 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6fb9743f{/,null,AVAILABLE} [junit4] 2> 441967 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.e.j.s.ServerConnector Started ServerConnector@bb6f560{HTTP/1.1}{127.0.0.1:43430} [junit4] 2> 441967 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.e.j.s.Server Started @445272ms [junit4] 2> 441967 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=hdfs://localhost:41031/hdfs__localhost_41031__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-trunk_solr_build_solr-core_test_J2_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001_tempDir-002_control_data, hostContext=/, hostPort=43430, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores} [junit4] 2> 441968 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 441968 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/' [junit4] 2> 441982 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 441982 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 441984 INFO (zkCallback-493-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1b9e9c66 name:ZooKeeperConnection Watcher:127.0.0.1:33781/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 441984 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 441984 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 441985 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 441985 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/solr.xml [junit4] 2> 441990 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores [junit4] 2> 441990 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.CoreContainer New CoreContainer 411041001 [junit4] 2> 441990 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/] [junit4] 2> 441990 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/lib [junit4] 2> 441990 WARN (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] 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-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/lib). [junit4] 2> 442009 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] 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> 442012 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 442013 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 442013 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 442013 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33781/solr [junit4] 2> 442013 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 442013 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 442013 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 442015 INFO (zkCallback-495-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2b575664 name:ZooKeeperConnection Watcher:127.0.0.1:33781 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 442015 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 442015 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 442017 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 442018 INFO (zkCallback-496-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2f0e850d name:ZooKeeperConnection Watcher:127.0.0.1:33781/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 442018 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 442019 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 442020 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 442023 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 442024 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 442026 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 442027 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 442029 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 442030 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 442031 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 442031 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43430_ [junit4] 2> 442032 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:43430_ [junit4] 2> 442033 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 442034 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 442035 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 442036 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94597101388169222-127.0.0.1:43430_-n_0000000000 [junit4] 2> 442036 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43430_ [junit4] 2> 442036 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 442037 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.Overseer Overseer (id=94597101388169222-127.0.0.1:43430_-n_0000000000) starting [junit4] 2> 442038 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 442043 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 442044 INFO (OverseerCollectionConfigSetProcessor-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 442044 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 442044 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 442056 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 442056 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 442057 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores [junit4] 2> 442058 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores/collection1, collection=control_collection, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 442058 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores/collection1/ [junit4] 2> 442058 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 442059 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2 [junit4] 2> 442059 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:43430_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 442059 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 442059 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 442060 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:43430";, [junit4] 2> "node_name":"127.0.0.1:43430_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 442061 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 442061 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:43430";, [junit4] 2> "node_name":"127.0.0.1:43430_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 442061 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 442062 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 442063 INFO (zkCallback-496-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ ] 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> 443061 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 443061 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 443062 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 443062 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 443062 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 443062 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores/collection1/' [junit4] 2> 443076 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 443084 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 443088 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 443096 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 443097 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 443101 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 444006 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 444019 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 444020 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 444037 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 444040 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 444042 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 444043 WARN (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 444043 WARN (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 444043 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 444043 WARN (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 444043 WARN (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 444045 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2 [junit4] 2> 444045 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 444045 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory [junit4] 2> 444045 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:41031/solr_hdfs_home [junit4] 2> 444045 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled [junit4] 2> 444045 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/control-001/cores/collection1/], dataDir=[null] [junit4] 2> 444045 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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@9d4fe9c [junit4] 2> 444046 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:41031/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 444076 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry hdfs://localhost:41031/solr_hdfs_home/control_collection/core_node1/data for locality metrics. [junit4] 2> 444076 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for hdfs://localhost:41031/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 444077 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=hdfs://localhost:41031/solr_hdfs_home/control_collection/core_node1/data/index/ [junit4] 2> 444086 WARN (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'hdfs:/localhost:41031/solr_hdfs_home/control_collection/core_node1/data/index' doesn't exist. Creating new index... [junit4] 2> 444086 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:41031/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 444098 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry hdfs://localhost:41031/solr_hdfs_home/control_collection/core_node1/data/index for locality metrics. [junit4] 2> 444098 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for hdfs://localhost:41031/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 444098 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=21, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=75.2939453125, floorSegmentMB=0.548828125, forceMergeDeletesPctAllowed=9.82898895092754, segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 444140 INFO (IPC Server handler 0 on 41031) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:39146 is added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-a4d90881-c9aa-4446-9149-8a8c391914a7:NORMAL:127.0.0.1:47924|RBW], ReplicaUnderConstruction[[DISK]DS-6b67412d-1e13-4829-9b61-04d02f5e8c4c:NORMAL:127.0.0.1:39146|FINALIZED]]} size 0 [junit4] 2> 444142 INFO (IPC Server handler 5 on 41031) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:47924 is added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-a4d90881-c9aa-4446-9149-8a8c391914a7:NORMAL:127.0.0.1:47924|RBW], ReplicaUnderConstruction[[DISK]DS-6b67412d-1e13-4829-9b61-04d02f5e8c4c:NORMAL:127.0.0.1:39146|FINALIZED]]} size 0 [junit4] 2> 444147 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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@b6ed8d01 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@301c6f6e; maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1} [junit4] 2> 444147 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 444152 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:43430_ 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:41031/solr_hdfs_home/control_collection/core_node1/data/ [junit4] 2> 444155 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 444155 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 444155 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 444155 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 444156 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 444156 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444156 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444156 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444156 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444158 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 444159 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 444159 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 444160 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 444167 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file [junit4] 2> 444168 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444172 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444172 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444192 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 444192 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 444194 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@2939c7a1 [junit4] 2> 444200 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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@b6ed8d01 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@301c6f6e; maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1} [junit4] 2> 444200 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 444200 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@7c72aec7[collection1] main [junit4] 2> 444201 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444201 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444201 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444201 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 444202 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 444202 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444202 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444202 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444202 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 444202 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 444206 INFO (searcherExecutor-802-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7c72aec7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 444208 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444208 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444208 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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> 444208 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ 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 1513553625031376896 [junit4] 2> 444208 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 0.0ms to seed version buckets with highest version 1513553625031376896 [junit4] 2> 444208 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 444208 INFO (coreLoadExecutor-801-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 444216 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ 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:43430 collection:control_collection shard:shard1 [junit4] 2> 444221 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ 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> 444229 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ 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/94597101388169222-core_node1-n_0000000000 [junit4] 2> 444229 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 [junit4] 2> 444231 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 444231 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ 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> 444231 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:43430/collection1/ [junit4] 2> 444231 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] 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> 444231 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 444231 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:43430/collection1/ has no replicas [junit4] 2> 444231 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ 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:43430/collection1/ shard1 [junit4] 2> 444232 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 444232 INFO (zkCallback-496-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ ] 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> 444234 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node [junit4] 2> 444235 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] 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:43430";, [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 2 [junit4] 2> 444337 INFO (zkCallback-496-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ ] 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> 444386 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:43430/collection1/ and leader is http://127.0.0.1:43430/collection1/ [junit4] 2> 444386 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ 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:43430 [junit4] 2> 444386 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 444386 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 444386 INFO (coreZkRegister-795-thread-1-processing-n:127.0.0.1:43430_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:43430_ 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> 444388 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:43430";, [junit4] 2> "node_name":"127.0.0.1:43430_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 3 [junit4] 2> 444388 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:43430";, [junit4] 2> "node_name":"127.0.0.1:43430_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 444482 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 444483 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 444484 INFO (zkCallback-498-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@48fd0771 name:ZooKeeperConnection Watcher:127.0.0.1:33781/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 444484 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 444485 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 444485 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 444487 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 444487 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 444488 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 444490 INFO (zkCallback-496-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ ] 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> 444496 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 444496 INFO (zkCallback-498-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> 444497 INFO (zkCallback-499-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@598f6d86 name:ZooKeeperConnection Watcher:127.0.0.1:33781/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 444497 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 444497 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 444500 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] 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> 444500 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 444602 INFO (OverseerStateUpdate-94597101388169222-127.0.0.1:43430_-n_0000000000) [n:127.0.0.1:43430_ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/collection1/state.json [junit4] 2> 444814 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001/cores/collection1 [junit4] 2> 444814 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001 [junit4] 2> 444815 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 444817 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@13a565ed{/,null,AVAILABLE} [junit4] 2> 444817 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.e.j.s.ServerConnector Started ServerConnector@289ee3f6{HTTP/1.1}{127.0.0.1:59600} [junit4] 2> 444818 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.e.j.s.Server Started @448122ms [junit4] 2> 444818 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=hdfs://localhost:41031/hdfs__localhost_41031__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-trunk_solr_build_solr-core_test_J2_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001_tempDir-002_jetty1, solrconfig=solrconfig.xml, hostContext=/, hostPort=59600, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001/cores} [junit4] 2> 444818 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 444818 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001/' [junit4] 2> 444833 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 444833 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 444835 INFO (zkCallback-500-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6cc5d6d7 name:ZooKeeperConnection Watcher:127.0.0.1:33781/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 444835 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 444835 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 444836 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 444836 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001/solr.xml [junit4] 2> 444841 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001/cores [junit4] 2> 444841 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.CoreContainer New CoreContainer 568154132 [junit4] 2> 444841 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001/] [junit4] 2> 444841 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001/lib [junit4] 2> 444841 WARN (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] 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-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_28E9BB72335AD47A-001/shard-1-001/lib). [junit4] 2> 444849 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] 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> 444850 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 444851 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 444851 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 444851 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33781/solr [junit4] 2> 444851 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 444851 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 444851 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 444853 INFO (zkCallback-502-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6963346b name:ZooKeeperConnection Watcher:127.0.0.1:33781 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 444853 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 444854 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 444855 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 444856 INFO (zkCallback-503-thread-1-processing-n:127.0.0.1:59600_) [n:127.0.0.1:59600_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@283f0e60 name:ZooKeeperConnection Watcher:127.0.0.1:33781/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 444856 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 444861 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 445866 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59600_ [junit4] 2> 445867 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:59600_ [junit4] 2> 445868 INFO (zkCallback-496-thread-1-processing-n:127.0.0.1:43430_) [n:127.0.0.1:43430_ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 445868 INFO (zkCallback-498-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 445868 INFO (zkCallback-503-thread-1-processing-n:127.0.0.1:59600_) [n:127.0.0.1:59600_ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 445869 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 445870 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94597101388169227-127.0.0.1:59600_-n_0000000001 [junit4] 2> 445870 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/94597101388169222-127.0.0.1:43430_-n_0000000000 to know if I could be the leader [junit4] 2> 445883 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 445883 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[28E9BB72335AD47A]) [n:127.0.0.1:59600_ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 445884 INFO (TEST-HdfsCollectionsAPIDistrib [...truncated too long message...] (HttpSolrClient.java:575) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) [junit4] > at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895)Throwable #4: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12382, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:50840/_j: Could not find collection : awholynewstresscollection_collection3_0 [junit4] > at __randomizedtesting.SeedInfo.seed([28E9BB72335AD47A]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) [junit4] > at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895)Throwable #5: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12384, name=collection5, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:50840/_j: Could not find collection : awholynewstresscollection_collection5_0 [junit4] > at __randomizedtesting.SeedInfo.seed([28E9BB72335AD47A]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) [junit4] > at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895)Throwable #6: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=12383, name=collection4, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] [junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:50840/_j: Could not find collection : awholynewstresscollection_collection4_0 [junit4] > at __randomizedtesting.SeedInfo.seed([28E9BB72335AD47A]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) [junit4] > at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895) [junit4] 2> 1636496 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[28E9BB72335AD47A]-worker) [n:127.0.0.1:52279__j c:addReplicaColl s:shard2 r:core_node6 x:addReplicaColl_shard2_replica3] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: test params are: codec=Lucene53, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ga_IE, timezone=GB [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=4,threads=1,free=187891576,total=521142272 [junit4] 2> NOTE: All tests run in this JVM: [CdcrRequestHandlerTest, TestJsonFacets, ExplicitHLLTest, MBeansHandlerTest, ZkStateReaderTest, DocumentBuilderTest, JavabinLoaderTest, SoftAutoCommitTest, TestHashPartitioner, PreAnalyzedFieldTest, TestStressVersions, RuleEngineTest, CustomCollectionTest, ChangedSchemaMergeTest, TestCopyFieldCollectionResource, TestSchemaVersionResource, PreAnalyzedUpdateProcessorTest, SpatialHeatmapFacetsTest, DistributedFacetPivotWhiteBoxTest, ShardRoutingTest, DateRangeFieldTest, TestCodecSupport, DistributedFacetPivotLongTailTest, UpdateRequestProcessorFactoryTest, SimplePostToolTest, TestShortCircuitedRequests, TestSuggestSpellingConverter, TestReqParamsAPI, HdfsLockFactoryTest, TestRequestStatusCollectionAPI, SolrIndexSplitterTest, TestCryptoKeys, TestBlendedInfixSuggestions, WordBreakSolrSpellCheckerTest, StressHdfsTest, TestMaxScoreQueryParser, TestCustomDocTransformer, TestConfigSetsAPI, ConvertedLegacyTest, TestQuerySenderNoQuery, BlockCacheTest, DOMUtilTest, TestNRTOpen, CSVRequestHandlerTest, TestManagedSchema, HLLSerializationTest, SpellPossibilityIteratorTest, TestUtils, SolrPluginUtilsTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestSolrCoreProperties, TestReplicationHandlerBackup, TestManagedSchemaFieldTypeResource, DistanceFunctionTest, NotRequiredUniqueKeyTest, BJQParserTest, HdfsNNFailoverTest, AnalysisErrorHandlingTest, TestSolrDeletionPolicy2, TestObjectReleaseTracker, SolrCmdDistributorTest, VMParamsZkACLAndCredentialsProvidersTest, ZkSolrClientTest, TestFiltering, TestPartialUpdateDeduplication, HdfsRecoveryZkTest, DistributedTermsComponentTest, TestSchemaManager, PKIAuthenticationIntegrationTest, MinimalSchemaTest, HdfsRecoverLeaseTest, SSLMigrationTest, SliceStateTest, TestConfigSetsAPIExclusivity, TestOverriddenPrefixQueryForCustomFieldType, TestWordDelimiterFilterFactory, TestUpdate, BadCopyFieldTest, SchemaVersionSpecificBehaviorTest, SortByFunctionTest, TermsComponentTest, SuggestComponentTest, DistributedQueueTest, DocValuesMissingTest, TestTrie, SimpleMLTQParserTest, CoreAdminRequestStatusTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, CollectionsAPIDistributedZkTest] [junit4] Completed [185/546] on J1 in 559.72s, 1 test, 1 error <<< FAILURES! [...truncated 1155 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:782: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:719: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:514: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1432: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:987: There were test failures: 546 suites (8 ignored), 2145 tests, 2 errors, 29 ignored (17 assumptions) [seed: 28E9BB72335AD47A] Total time: 195 minutes 12 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]
