Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.3/7/
2 tests failed. FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=32903, name=collection1, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=32903, name=collection1, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:37802/_djf: Could not find collection : awholynewstresscollection_collection1_0 at __randomizedtesting.SeedInfo.seed([98D860F4D879C087]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1098) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:869) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:805) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:894) FAILED: org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=126178, name=testExecutor-7212-thread-6, state=RUNNABLE, group=TGRP-HdfsUnloadDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=126178, name=testExecutor-7212-thread-6, state=RUNNABLE, group=TGRP-HdfsUnloadDistributedZkTest] at __randomizedtesting.SeedInfo.seed([98D860F4D879C087:108C5F2E7685AD7F]:0) Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:47647/uu: Error CREATEing SolrCore 'multiunload5': Unable to create core [multiunload5] Caused by: Direct buffer memory at __randomizedtesting.SeedInfo.seed([98D860F4D879C087]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.BasicDistributedZkTest$1.run(BasicDistributedZkTest.java:549) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 11548 lines...] [junit4] Suite: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/init-core-data-001 [junit4] 2> 2847087 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 2847087 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_djf/ [junit4] 1> Formatting using clusterid: testClusterID [junit4] 2> 2847160 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 2847167 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 2847170 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 2847186 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-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_49335_hdfs____shu3mi/webapp [junit4] 2> 2847301 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 2847539 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:49335 [junit4] 2> 2847644 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 2847646 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 2847661 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-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_35231_datanode____.vj1wh7/webapp [junit4] 2> 2847774 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 2848006 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:35231 [junit4] 2> 2848045 WARN (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 2848047 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log jetty-6.1.26 [junit4] 2> 2848061 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-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_41678_datanode____.e35i5b/webapp [junit4] 2> 2848113 INFO (IPC Server handler 2 on 52566) [ ] BlockStateChange BLOCK* processReport: from storage DS-788fd314-85a3-4e1c-bcb5-d8f6d28eb1a3 node DatanodeRegistration(127.0.0.1, datanodeUuid=ce7961ba-8ca4-45cb-94cf-fc75cb74220e, infoPort=35231, ipcPort=43715, storageInfo=lv=-56;cid=testClusterID;nsid=2056078331;c=0), blocks: 0, hasStaleStorages: true, processing time: 1 msecs [junit4] 2> 2848114 INFO (IPC Server handler 2 on 52566) [ ] BlockStateChange BLOCK* processReport: from storage DS-07cb3528-151d-46a9-81a7-61170c89d895 node DatanodeRegistration(127.0.0.1, datanodeUuid=ce7961ba-8ca4-45cb-94cf-fc75cb74220e, infoPort=35231, ipcPort=43715, storageInfo=lv=-56;cid=testClusterID;nsid=2056078331;c=0), blocks: 0, hasStaleStorages: false, processing time: 0 msecs [junit4] 2> 2848214 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet [junit4] 2> 2848511 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[98D860F4D879C087]-worker) [ ] o.m.log Started HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:41678 [junit4] 2> 2848652 INFO (IPC Server handler 3 on 52566) [ ] BlockStateChange BLOCK* processReport: from storage DS-3598ec00-1cc4-4ce7-b223-9fdbd2339e96 node DatanodeRegistration(127.0.0.1, datanodeUuid=12fba098-2e4c-4be2-b3be-41306ef64f50, infoPort=41678, ipcPort=52206, storageInfo=lv=-56;cid=testClusterID;nsid=2056078331;c=0), blocks: 0, hasStaleStorages: true, processing time: 1 msecs [junit4] 2> 2848653 INFO (IPC Server handler 3 on 52566) [ ] BlockStateChange BLOCK* processReport: from storage DS-3b677023-e25d-4c49-988c-13f7074b1d1a node DatanodeRegistration(127.0.0.1, datanodeUuid=12fba098-2e4c-4be2-b3be-41306ef64f50, infoPort=41678, ipcPort=52206, storageInfo=lv=-56;cid=testClusterID;nsid=2056078331;c=0), blocks: 0, hasStaleStorages: false, processing time: 0 msecs [junit4] 2> 2848736 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 2848736 INFO (Thread-19825) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 2848736 INFO (Thread-19825) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 2848836 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.ZkTestServer start zk server on port:46693 [junit4] 2> 2848836 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2848837 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2848840 INFO (zkCallback-2889-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3d779766 name:ZooKeeperConnection Watcher:127.0.0.1:46693 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2848841 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2848841 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2848841 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 2848843 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2848843 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1521e3bbf760000, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 2848844 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2848846 INFO (zkCallback-2890-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@62253ee0 name:ZooKeeperConnection Watcher:127.0.0.1:46693/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2848847 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2848847 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2848847 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 2848849 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 2848851 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 2848852 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 2848853 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 2848854 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 2848856 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 2848856 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 2848858 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2848858 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2848860 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 2848860 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 2848862 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 2848862 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 2848864 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 2848864 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 2848865 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 2848865 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 2848867 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 2848867 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 2848882 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2848882 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 2848884 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 2848884 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 2848885 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 2848886 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 2848888 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2848888 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2848889 INFO (zkCallback-2891-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b7bb339 name:ZooKeeperConnection Watcher:127.0.0.1:46693 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2848889 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2848890 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2848890 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 2848891 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2848892 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2848893 INFO (zkCallback-2892-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@397fcf21 name:ZooKeeperConnection Watcher:127.0.0.1:46693/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2848893 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2848893 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2848894 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf2/solrconfig.xml [junit4] 2> 2848894 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml [junit4] 2> 2848897 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf2/schema.xml [junit4] 2> 2848897 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml [junit4] 2> 2848899 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf2/enumsConfig.xml [junit4] 2> 2848899 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml [junit4] 2> 2848900 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2848901 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 2848902 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf2/stopwords.txt [junit4] 2> 2848902 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt [junit4] 2> 2848904 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf2/protwords.txt [junit4] 2> 2848904 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt [junit4] 2> 2848905 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf2/currency.xml [junit4] 2> 2848906 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml [junit4] 2> 2848907 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf2/open-exchange-rates.json [junit4] 2> 2848908 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json [junit4] 2> 2848909 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 2848909 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 2848911 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf2/old_synonyms.txt [junit4] 2> 2848911 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt [junit4] 2> 2848913 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf2/synonyms.txt [junit4] 2> 2848913 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt [junit4] 2> 2848914 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/core/src/test-files/solr/collection1/conf/elevate.xml to /configs/conf2/elevate.xml [junit4] 2> 2848915 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml [junit4] 2> 2849004 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores/collection1 [junit4] 2> 2849005 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 2849007 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@71d6ab14{/_djf,null,AVAILABLE} [junit4] 2> 2849008 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1f8af288{HTTP/1.1}{127.0.0.1:59004} [junit4] 2> 2849008 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.e.j.s.Server Started @2851900ms [junit4] 2> 2849008 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores, solr.data.dir=hdfs://localhost:52566/hdfs__localhost_52566__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-5.3_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001_tempDir-002_control_data, hostPort=59004, hostContext=/_djf} [junit4] 2> 2849008 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@3827de24 [junit4] 2> 2849008 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/' [junit4] 2> 2849023 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2849024 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2849026 INFO (zkCallback-2893-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@79bfa659 name:ZooKeeperConnection Watcher:127.0.0.1:46693/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2849026 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2849026 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2849027 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2849027 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/solr.xml [junit4] 2> 2849040 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores [junit4] 2> 2849040 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.CoreContainer New CoreContainer 469242975 [junit4] 2> 2849040 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/] [junit4] 2> 2849040 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/lib [junit4] 2> 2849041 WARN (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/lib). [junit4] 2> 2849048 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] 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> 2849049 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2849050 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2849050 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2849050 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46693/solr [junit4] 2> 2849050 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 2849050 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2849050 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2849052 INFO (zkCallback-2895-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@59fb7013 name:ZooKeeperConnection Watcher:127.0.0.1:46693 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2849052 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2849052 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2849054 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2849055 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@430f46ed name:ZooKeeperConnection Watcher:127.0.0.1:46693/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2849055 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2849056 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 2849058 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 2849060 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 2849061 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 2849063 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 2849065 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 2849067 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 2849068 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 2849069 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 2849070 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59004__djf [junit4] 2> 2849071 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:59004__djf [junit4] 2> 2849073 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 2849074 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 2849075 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 2849076 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95171784092286982-127.0.0.1:59004__djf-n_0000000000 [junit4] 2> 2849076 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59004__djf [junit4] 2> 2849077 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 2849078 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.Overseer Overseer (id=95171784092286982-127.0.0.1:59004__djf-n_0000000000) starting [junit4] 2> 2849080 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 2849085 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 2849086 INFO (OverseerCollectionProcessor-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations [junit4] 2> 2849086 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 2849086 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 2849100 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 2849100 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 2849101 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores [junit4] 2> 2849101 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.SolrCore Created CoreDescriptor: {shard=, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores/collection1, config=solrconfig.xml, collection=control_collection, coreNodeName=, transient=false, name=collection1, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores/collection1/, schema=schema.xml, dataDir=data/} [junit4] 2> 2849102 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores/collection1/ [junit4] 2> 2849102 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 2849103 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 2849103 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 2849103 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1 [junit4] 2> 2849103 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [n:127.0.0.1:59004__djf ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 2849103 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2849103 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 2849104 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "roles":null, [junit4] 2> "numShards":"1", [junit4] 2> "collection":"control_collection", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:59004/_djf", [junit4] 2> "operation":"state", [junit4] 2> "shard":null, [junit4] 2> "node_name":"127.0.0.1:59004__djf"} current state version: 0 [junit4] 2> 2849105 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "roles":null, [junit4] 2> "numShards":"1", [junit4] 2> "collection":"control_collection", [junit4] 2> "core":"collection1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:59004/_djf", [junit4] 2> "operation":"state", [junit4] 2> "shard":null, [junit4] 2> "node_name":"127.0.0.1:59004__djf"} [junit4] 2> 2849105 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 2849105 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 2849106 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] 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> 2849107 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.c.ZkStateReader Updated cluster state version to 1 [junit4] 2> 2850104 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 2850104 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 2850105 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 2850105 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 2850106 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 2850106 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores/collection1/' [junit4] 2> 2850122 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 2850129 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 2850141 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.2 [junit4] 2> 2850167 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 2850168 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 2850174 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2850398 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2850405 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 2850406 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 2850415 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2850418 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 2850420 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2850421 WARN (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 2850421 WARN (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 2850421 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2850422 WARN (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 2850422 WARN (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 2850423 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1 [junit4] 2> 2850423 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 2850423 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory [junit4] 2> 2850424 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:52566/solr_hdfs_home [junit4] 2> 2850424 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled [junit4] 2> 2850424 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/control-001/cores/collection1/], dataDir=[null] [junit4] 2> 2850424 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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@31e5ccbf [junit4] 2> 2850424 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:52566/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 2850439 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry hdfs://localhost:52566/solr_hdfs_home/control_collection/core_node1/data for locality metrics. [junit4] 2> 2850439 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for hdfs://localhost:52566/solr_hdfs_home/control_collection/core_node1/data [junit4] 2> 2850440 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=hdfs://localhost:52566/solr_hdfs_home/control_collection/core_node1/data/index/ [junit4] 2> 2850449 WARN (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 'hdfs:/localhost:52566/solr_hdfs_home/control_collection/core_node1/data/index' doesn't exist. Creating new index... [junit4] 2> 2850449 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path hdfs://localhost:52566/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 2850461 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry hdfs://localhost:52566/solr_hdfs_home/control_collection/core_node1/data/index for locality metrics. [junit4] 2> 2850461 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for hdfs://localhost:52566/solr_hdfs_home/control_collection/core_node1/data/index [junit4] 2> 2850461 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=79.3251953125, floorSegmentMB=1.27734375, forceMergeDeletesPctAllowed=7.658539158883208, segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.28293825008275186 [junit4] 2> 2850476 INFO (IPC Server handler 9 on 52566) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37731 is added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-3b677023-e25d-4c49-988c-13f7074b1d1a:NORMAL:127.0.0.1:38025|RBW], ReplicaUnderConstruction[[DISK]DS-788fd314-85a3-4e1c-bcb5-d8f6d28eb1a3:NORMAL:127.0.0.1:37731|FINALIZED]]} size 0 [junit4] 2> 2850477 INFO (IPC Server handler 0 on 52566) [ ] BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:38025 is added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION, primaryNodeIndex=-1, replicas=[ReplicaUnderConstruction[[DISK]DS-788fd314-85a3-4e1c-bcb5-d8f6d28eb1a3:NORMAL:127.0.0.1:37731|FINALIZED], ReplicaUnderConstruction[[DISK]DS-3598ec00-1cc4-4ce7-b223-9fdbd2339e96:NORMAL:127.0.0.1:38025|FINALIZED]]} size 0 [junit4] 2> 2850481 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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@b8449834 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@65534096; maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1} [junit4] 2> 2850481 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2850482 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:59004__djf 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:52566/solr_hdfs_home/control_collection/core_node1/data/ [junit4] 2> 2850486 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 2850486 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 2850486 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2850486 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2850487 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2850487 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850487 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850487 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850487 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850490 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2850491 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2850493 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2850494 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 2850497 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,/replication,/update/json/docs,/admin/segments,/admin/file,/admin/plugins,/admin/logging,/admin/system,/admin/properties,/schema,/admin/ping,/admin/luke,/update/csv,/admin/threads,standard,/get,/update/json,/config,/update [junit4] 2> 2850499 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850499 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850499 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850510 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 2850510 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 2850511 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=4, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.31840037770471474] [junit4] 2> 2850520 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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@b8449834 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@65534096; maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1} [junit4] 2> 2850520 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 2850520 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@1d7ae7a[collection1] main [junit4] 2> 2850521 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850522 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850522 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850523 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 2850523 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 2850523 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850524 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850525 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850525 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 2850525 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2850526 INFO (searcherExecutor-8080-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1d7ae7a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2850527 WARN (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.h.HdfsLocalityReporter Could not retrieve locality information for hdfs://localhost:36227/solr3 due to exception: java.net.ConnectException: Call From lucene1-us-west/10.41.0.5 to localhost:36227 failed on connection exception: java.net.ConnectException: Connection refused; For more details see: http://wiki.apache.org/hadoop/ConnectionRefused [junit4] 2> 2850529 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850529 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850529 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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> 2850529 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf 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 1522748547354591232 [junit4] 2> 2850529 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 0 ms to seed version buckets with highest version 1522748547354591232 [junit4] 2> 2850530 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 2850530 INFO (coreLoadExecutor-8079-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 2850531 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf 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:59004/_djf collection:control_collection shard:shard1 [junit4] 2> 2850532 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf 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> 2850537 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf 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/95171784092286982-core_node1-n_0000000000 [junit4] 2> 2850538 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 [junit4] 2> 2850539 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2850540 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] 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> 2850542 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 2850542 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf 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> 2850542 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:59004/_djf/collection1/ [junit4] 2> 2850542 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 2850542 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:59004/_djf/collection1/ has no replicas [junit4] 2> 2850542 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf 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:59004/_djf/collection1/ shard1 [junit4] 2> 2850542 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 2850547 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2850548 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] 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:59004/_djf", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 2850605 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2850606 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2850607 INFO (zkCallback-2898-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@38198508 name:ZooKeeperConnection Watcher:127.0.0.1:46693/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2850608 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2850608 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2850608 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 2850611 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 2850611 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2 [junit4] 2> 2850611 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2850612 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2850613 INFO (zkCallback-2899-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@47c7e9f3 name:ZooKeeperConnection Watcher:127.0.0.1:46693/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2850614 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2850614 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2850615 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2850616 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"create", [junit4] 2> "name":"collection1", [junit4] 2> "numShards":"2", [junit4] 2> "stateFormat":"2"} current state version: 1 [junit4] 2> 2850616 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.o.ClusterStateMutator building a new cName: collection1 [junit4] 2> 2850617 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] 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> 2850617 INFO (zkCallback-2898-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> 2850625 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.c.ZkStateReader Updated cluster state version to 2 [junit4] 2> 2850625 INFO (zkCallback-2898-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 2 [junit4] 2> 2850650 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:59004/_djf/collection1/ and leader is http://127.0.0.1:59004/_djf/collection1/ [junit4] 2> 2850650 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf 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:59004/_djf [junit4] 2> 2850651 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 2850651 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 2850651 INFO (coreZkRegister-8073-thread-1-processing-c:control_collection r:core_node1 x:collection1 n:127.0.0.1:59004__djf s:shard1) [n:127.0.0.1:59004__djf 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> 2850653 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 2850654 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "roles":null, [junit4] 2> "numShards":"2", [junit4] 2> "collection":"control_collection", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active", [junit4] 2> "base_url":"http://127.0.0.1:59004/_djf", [junit4] 2> "operation":"state", [junit4] 2> "shard":"shard1", [junit4] 2> "node_name":"127.0.0.1:59004__djf"} current state version: 2 [junit4] 2> 2850654 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "roles":null, [junit4] 2> "numShards":"2", [junit4] 2> "collection":"control_collection", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active", [junit4] 2> "base_url":"http://127.0.0.1:59004/_djf", [junit4] 2> "operation":"state", [junit4] 2> "shard":"shard1", [junit4] 2> "node_name":"127.0.0.1:59004__djf"} [junit4] 2> 2850655 INFO (OverseerStateUpdate-95171784092286982-127.0.0.1:59004__djf-n_0000000000) [n:127.0.0.1:59004__djf ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/collection1/state.json [junit4] 2> 2850656 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] 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> 2850656 INFO (zkCallback-2898-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> 2850658 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] o.a.s.c.c.ZkStateReader Updated cluster state version to 3 [junit4] 2> 2850658 INFO (zkCallback-2898-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated cluster state version to 3 [junit4] 2> 2850709 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001/cores/collection1 [junit4] 2> 2850710 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001 [junit4] 2> 2850711 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 2850714 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@350dd9a0{/_djf,null,AVAILABLE} [junit4] 2> 2850714 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.e.j.s.ServerConnector Started ServerConnector@812a66a{HTTP/1.1}{127.0.0.1:34836} [junit4] 2> 2850715 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.e.j.s.Server Started @2853607ms [junit4] 2> 2850715 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001/cores, hostPort=34836, solrconfig=solrconfig.xml, hostContext=/_djf, solr.data.dir=hdfs://localhost:52566/hdfs__localhost_52566__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-5.3_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001_tempDir-002_jetty1} [junit4] 2> 2850715 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@3827de24 [junit4] 2> 2850715 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001/' [junit4] 2> 2850732 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 2850733 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 2850735 INFO (zkCallback-2900-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@725b4be0 name:ZooKeeperConnection Watcher:127.0.0.1:46693/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 2850735 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 2850736 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 2850736 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 2850737 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001/solr.xml [junit4] 2> 2850750 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001/cores [junit4] 2> 2850751 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.CoreContainer New CoreContainer 436126424 [junit4] 2> 2850751 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001/] [junit4] 2> 2850751 INFO (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001/lib [junit4] 2> 2850751 WARN (TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[98D860F4D879C087]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_98D860F4D879C087-001/shard-1-001/lib). [junit4] 2> 2850764 INFO (zkCallback-2896-thread-1-processing-n:127.0.0.1:59004__djf) [n:127.0.0.1:59004__djf ] 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> 2850764 INFO (zkCallback-2898-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster st [...truncated too long message...] .hdfs.server.namenode.NameNode.stop(NameNode.java:822) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:197) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.teardownClass(HdfsUnloadDistributedZkTest.java:47) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:606) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> Caused by: java.lang.NullPointerException [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198) [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223) [junit4] 2> ... 53 more [junit4] 2> 3230476 INFO (SUITE-HdfsUnloadDistributedZkTest-seed#[98D860F4D879C087]-worker) [n:127.0.0.1:56025_uu c:unloadcollection s:shard1 r:core_node4 x:unloadcollection4] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> Jan 07, 2016 10:42:40 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY, chunkSize=2, maxDocsPerChunk=674, blockSize=1), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, chunkSize=2, blockSize=1)), sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=es_MX, timezone=Pacific/Yap [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=4,threads=2,free=388823760,total=527958016 [junit4] 2> NOTE: All tests run in this JVM: [TestStressReorder, TestSolrQueryParser, TestClassNameShortening, XmlUpdateRequestHandlerTest, TestSurroundQueryParser, TestRebalanceLeaders, TestUniqueKeyFieldResource, NumericFieldsTest, DirectSolrSpellCheckerTest, HdfsRecoverLeaseTest, TestLuceneMatchVersion, TestAuthenticationFramework, ChangedSchemaMergeTest, HdfsChaosMonkeySafeLeaderTest, DistributedFacetPivotSmallAdvancedTest, HLLUtilTest, TestRecoveryHdfs, TestZkChroot, PluginInfoTest, TestQueryTypes, SpellCheckCollatorTest, TestSolrConfigHandler, TestCustomSort, TestSolrJ, TestGroupingSearch, DirectUpdateHandlerOptimizeTest, BasicAuthIntegrationTest, PrimUtilsTest, PathHierarchyTokenizerFactoryTest, TestCrossCoreJoin, SolrIndexSplitterTest, TestManagedSchemaDynamicFieldResource, RecoveryZkTest, SOLR749Test, AutoCommitTest, TestCollapseQParserPlugin, OpenExchangeRatesOrgProviderTest, DocExpirationUpdateProcessorFactoryTest, TestQuerySenderNoQuery, BasicDistributedZk2Test, SuggesterTest, TestTolerantSearch, TestXIncludeConfig, DeleteInactiveReplicaTest, ConnectionManagerTest, FileBasedSpellCheckerTest, TestCollationField, SimpleFacetsTest, ResponseLogComponentTest, CleanupOldIndexTest, TestPivotHelperCode, TestDocSet, SortByFunctionTest, TestReload, TestSimpleTrackingShardHandler, ConcurrentDeleteAndCreateCollectionTest, TestDocBasedVersionConstraints, TestExactStatsCache, MultiThreadedOCPTest, TestSort, TestConfigSetProperties, QueryResultKeyTest, QueryEqualityTest, TestManagedResource, TestCollationFieldDocValues, TestQueryUtils, DeleteShardTest, DistributedQueryComponentCustomSortTest, SampleTest, CoreAdminRequestStatusTest, BadIndexSchemaTest, DeleteReplicaTest, BinaryUpdateRequestHandlerTest, CollectionReloadTest, AddBlockUpdateTest, PolyFieldTest, TestBlendedInfixSuggestions, CollectionsAPIAsyncDistributedZkTest, TestManagedSynonymFilterFactory, TestRecovery, StatsComponentTest, TestCryptoKeys, AddSchemaFieldsUpdateProcessorFactoryTest, TestTrie, SolrCoreCheckLockOnStartupTest, HardAutoCommitTest, TestPerFieldSimilarity, TestExclusionRuleCollectionAccess, UnloadDistributedZkTest, OverseerTest, LeaderElectionIntegrationTest, BasicZkTest, FullSolrCloudDistribCmdsTest, LeaderElectionTest, TestRandomDVFaceting, TestDistributedSearch, TestFaceting, DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, ZkControllerTest, TestJoin, TestStressVersions, TestCoreContainer, TestSolr4Spatial, SolrCmdDistributorTest, QueryElevationComponentTest, PeerSyncTest, ConvertedLegacyTest, BasicFunctionalityTest, DirectUpdateHandlerTest, OverseerCollectionProcessorTest, TestIndexSearcher, HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, SimplePostToolTest, SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser, SuggesterFSTTest, SolrRequestParserTest, TestFoldingMultitermQuery, DocValuesTest, TestCSVLoader, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, SchemaVersionSpecificBehaviorTest, TestPseudoReturnFields, TestUpdate, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, StatelessScriptUpdateProcessorFactoryTest, DocValuesMultiTest, DistanceFunctionTest, SolrInfoMBeanTest, XsltUpdateRequestHandlerTest, CacheHeaderTest, DocumentAnalysisRequestHandlerTest, TestOmitPositions, TestValueSourceCache, TermVectorComponentTest, MoreLikeThisHandlerTest, RequiredFieldsTest, FieldAnalysisRequestHandlerTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, RegexBoostProcessorTest, TestJmxIntegration, ReturnFieldsTest, JSONWriterTest, TestCSVResponseWriter, MBeansHandlerTest, QueryParsingTest, UniqFieldsUpdateProcessorFactoryTest, TestPartialUpdateDeduplication, CSVRequestHandlerTest, SearchHandlerTest, TestBinaryResponseWriter, TestLFUCache, AssignTest, AsyncMigrateRouteKeyTest, DistribJoinFromCollectionTest, LeaderInitiatedRecoveryOnCommitTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerRolesTest, SSLMigrationTest, SaslZkACLProviderTest, SolrCloudExampleTest, TestRequestStatusCollectionAPI, HdfsBasicDistributedZkTest, HdfsRecoveryZkTest, HdfsThreadLeakTest, HdfsUnloadDistributedZkTest] [junit4] Completed [427/533] on J2 in 97.54s, 1 test, 1 error <<< FAILURES! [...truncated 343 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:733: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:670: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/build.xml:230: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/solr/common-build.xml:524: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/lucene/common-build.xml:1449: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.3/lucene/common-build.xml:1003: There were test failures: 533 suites, 2104 tests, 2 errors, 26 ignored (14 assumptions) Total time: 192 minutes 49 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org