Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/768/
4 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest Error Message: ERROR: SolrIndexSearcher opens=31 closes=30 Stack Trace: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=31 closes=30 at __randomizedtesting.SeedInfo.seed([EF6380E83FB00BFF]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:467) at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:233) at sun.reflect.GeneratedMethodAccessor70.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest Error Message: 2 threads leaked from SUITE scope at org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest: 1) Thread[id=24187, name=qtp703560321-24187, state=WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:502) at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.blockUntilFinished(ConcurrentUpdateSolrClient.java:404) at org.apache.solr.update.StreamingSolrClients.blockUntilFinished(StreamingSolrClients.java:103) at org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:231) at org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:89) at org.apache.solr.update.processor.DistributedUpdateProcessor.doFinish(DistributedUpdateProcessor.java:781) at org.apache.solr.update.processor.DistributedUpdateProcessor.finish(DistributedUpdateProcessor.java:1655) at org.apache.solr.update.processor.LogUpdateProcessor.finish(LogUpdateProcessorFactory.java:183) at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:83) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2079) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:667) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:460) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:210) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:179) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:106) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83) at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:300) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97) at org.eclipse.jetty.server.Server.handle(Server.java:499) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257) at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=24209, name=searcherExecutor-7090-thread-1, state=WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from SUITE scope at org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest: 1) Thread[id=24187, name=qtp703560321-24187, state=WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:502) at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.blockUntilFinished(ConcurrentUpdateSolrClient.java:404) at org.apache.solr.update.StreamingSolrClients.blockUntilFinished(StreamingSolrClients.java:103) at org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:231) at org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:89) at org.apache.solr.update.processor.DistributedUpdateProcessor.doFinish(DistributedUpdateProcessor.java:781) at org.apache.solr.update.processor.DistributedUpdateProcessor.finish(DistributedUpdateProcessor.java:1655) at org.apache.solr.update.processor.LogUpdateProcessor.finish(LogUpdateProcessorFactory.java:183) at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:83) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2079) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:667) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:460) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:210) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:179) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:106) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83) at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:300) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97) at org.eclipse.jetty.server.Server.handle(Server.java:499) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257) at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555) at java.lang.Thread.run(Thread.java:745) 2) Thread[id=24209, name=searcherExecutor-7090-thread-1, state=WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039) at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) at __randomizedtesting.SeedInfo.seed([EF6380E83FB00BFF]:0) REGRESSION: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=6229, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=6229, name=collection3, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:59445/vgva: collection already exists: awholynewstresscollection_collection3_6 at __randomizedtesting.SeedInfo.seed([EF6380E83FB00BFF]: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:372) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1574) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1595) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:888) FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=77534, name=collection1, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=77534, 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:53474: Could not find collection : awholynewstresscollection_collection1_0 at __randomizedtesting.SeedInfo.seed([EF6380E83FB00BFF]: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:372) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895) Build Log: [...truncated 9985 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/init-core-data-001 [junit4] 2> 780294 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF6380E83FB00BFF]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 780295 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[EF6380E83FB00BFF]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /vgva/ [junit4] 2> 780301 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 780302 INFO (Thread-3676) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 780302 INFO (Thread-3676) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 780402 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.ZkTestServer start zk server on port:39273 [junit4] 2> 780402 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 780417 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 780445 INFO (zkCallback-428-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@308f028c name:ZooKeeperConnection Watcher:127.0.0.1:39273 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 780445 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 780446 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 780446 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 780456 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 780462 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 780504 INFO (zkCallback-429-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@130e963e name:ZooKeeperConnection Watcher:127.0.0.1:39273/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 780504 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 780505 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 780505 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 780508 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 780514 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 780516 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 780518 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 780518 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 780520 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 780521 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 780522 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 780523 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 780524 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 780525 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 780526 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 780526 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 780528 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 780528 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 780529 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 780530 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 780531 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 780531 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 780533 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 780533 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 780534 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 780535 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 780536 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 780536 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 781107 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1 [junit4] 2> 781128 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 781146 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@48fd1a20{/vgva,null,AVAILABLE} [junit4] 2> 781148 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.e.j.s.ServerConnector Started ServerConnector@3faadf0a{HTTP/1.1}{127.0.0.1:58454} [junit4] 2> 781148 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.e.j.s.Server Started @786511ms [junit4] 2> 781148 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/tempDir-001/control/data, hostContext=/vgva, hostPort=58454, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores} [junit4] 2> 781149 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 781149 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/' [junit4] 2> 781198 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 781207 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 781218 INFO (zkCallback-430-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@518fd33d name:ZooKeeperConnection Watcher:127.0.0.1:39273/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 781218 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 781219 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 781222 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 781222 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/solr.xml [junit4] 2> 781235 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores [junit4] 2> 781235 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.CoreContainer New CoreContainer 1006353199 [junit4] 2> 781235 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/] [junit4] 2> 781236 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/lib [junit4] 2> 781236 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/lib). [junit4] 2> 781256 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] 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> 781257 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 781257 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 781258 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 781258 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39273/solr [junit4] 2> 781258 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 781258 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 781263 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 781286 INFO (zkCallback-432-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@218b2e69 name:ZooKeeperConnection Watcher:127.0.0.1:39273 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 781289 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 781289 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 781298 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 781306 INFO (zkCallback-433-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@61103bf0 name:ZooKeeperConnection Watcher:127.0.0.1:39273/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 781306 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 781308 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 781310 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 781313 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 781314 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 781316 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 781318 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 781319 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 781320 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 781321 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 781322 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58454_vgva [junit4] 2> 781322 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:58454_vgva [junit4] 2> 781324 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 781325 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 781326 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 781327 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94367212718325764-127.0.0.1:58454_vgva-n_0000000000 [junit4] 2> 781327 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58454_vgva [junit4] 2> 781327 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 781328 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.Overseer Overseer (id=94367212718325764-127.0.0.1:58454_vgva-n_0000000000) starting [junit4] 2> 781331 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 781342 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 781343 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 781344 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 781353 INFO (OverseerCollectionProcessor-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.OverseerProcessor Process current queue of overseer operations [junit4] 2> 781362 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 781400 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 781400 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 781401 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores [junit4] 2> 781402 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1, collection=control_collection, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 781402 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/ [junit4] 2> 781402 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 781404 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 781405 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 781406 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 781406 INFO (zkCallback-433-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 781407 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:58454/vgva", [junit4] 2> "node_name":"127.0.0.1:58454_vgva", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 781408 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:58454/vgva", [junit4] 2> "node_name":"127.0.0.1:58454_vgva", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 781408 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 781408 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 781409 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1 [junit4] 2> 781409 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:58454_vgva ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 781409 INFO (zkCallback-433-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] 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> 781409 INFO (zkCallback-433-thread-2-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] 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> 782406 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 782406 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 782407 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 782407 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 782408 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 782408 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/' [junit4] 2> 782424 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 782428 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 782432 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 782439 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 782442 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 782452 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 782566 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 782572 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 782573 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 782590 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 782593 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 782596 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 782597 WARN (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 782597 WARN (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 782597 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 782598 WARN (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 782598 WARN (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 782600 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1 [junit4] 2> 782600 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 782600 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 782601 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/], dataDir=[null] [junit4] 2> 782601 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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@5cb37d16 [junit4] 2> 782602 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/data [junit4] 2> 782602 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/data/index/ [junit4] 2> 782603 WARN (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 782603 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/data/index [junit4] 2> 782603 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=27, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 782604 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@3db8b1e6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@77d40f57),segFN=segments_1,generation=1} [junit4] 2> 782604 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 782608 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 782608 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 782608 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 782608 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 782608 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 782609 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782609 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782609 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782609 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782611 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 782612 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 782613 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 782614 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 782618 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file [junit4] 2> 782618 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782619 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/data/ [junit4] 2> 782619 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 782623 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 782623 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 782624 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 782624 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 782624 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 782625 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@3db8b1e6 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@77d40f57),segFN=segments_1,generation=1} [junit4] 2> 782625 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 782625 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3de499c6[collection1] main [junit4] 2> 782625 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782626 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782626 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782627 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 782627 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 782627 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782627 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782628 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782628 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 782628 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 782628 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782628 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 782629 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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> 782629 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva 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 1509875405932199936 [junit4] 2> 782631 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 1509875405932199936 [junit4] 2> 782631 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 782632 INFO (searcherExecutor-1569-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3de499c6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 782632 INFO (coreLoadExecutor-1568-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 782638 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva 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:58454/vgva collection:control_collection shard:shard1 [junit4] 2> 782639 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva 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> 782643 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva 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/94367212718325764-core_node1-n_0000000000 [junit4] 2> 782644 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1 [junit4] 2> 782647 INFO (zkCallback-433-thread-2-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 782647 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 782647 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva 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> 782647 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:58454/vgva/collection1/ [junit4] 2> 782647 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 782647 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] 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> 782648 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:58454/vgva/collection1/ has no replicas [junit4] 2> 782648 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva 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:58454/vgva/collection1/ shard1 [junit4] 2> 782648 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 782651 INFO (zkCallback-433-thread-2-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 782652 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] 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:58454/vgva", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 782754 INFO (zkCallback-433-thread-2-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] 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> 782754 INFO (zkCallback-433-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] 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> 782803 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:58454/vgva/collection1/ and leader is http://127.0.0.1:58454/vgva/collection1/ [junit4] 2> 782803 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva 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:58454/vgva [junit4] 2> 782803 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 782804 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 782804 INFO (coreZkRegister-1562-thread-1-processing-n:127.0.0.1:58454_vgva x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:58454_vgva 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> 782805 INFO (zkCallback-433-thread-2-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 782806 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:58454/vgva", [junit4] 2> "node_name":"127.0.0.1:58454_vgva", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 2 [junit4] 2> 782807 INFO (OverseerStateUpdate-94367212718325764-127.0.0.1:58454_vgva-n_0000000000) [n:127.0.0.1:58454_vgva ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:58454/vgva", [junit4] 2> "node_name":"127.0.0.1:58454_vgva", [junit4] 2> "numShards":"1", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 782910 INFO (zkCallback-433-thread-2-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] 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> 782911 INFO (zkCallback-433-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] 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> 782911 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 782913 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 782914 INFO (zkCallback-435-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@66d72dd5 name:ZooKeeperConnection Watcher:127.0.0.1:39273/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 782914 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 782915 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 782915 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 782917 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 783267 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/cores/collection1 [junit4] 2> 783268 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001 [junit4] 2> 783274 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.e.j.s.Server jetty-9.2.11.v20150529 [junit4] 2> 783332 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3d890d21{/vgva,null,AVAILABLE} [junit4] 2> 783333 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.e.j.s.ServerConnector Started ServerConnector@878b518{HTTP/1.1}{127.0.0.1:47653} [junit4] 2> 783333 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.e.j.s.Server Started @788696ms [junit4] 2> 783333 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, hostContext=/vgva, hostPort=47653, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/cores} [junit4] 2> 783334 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 783334 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/' [junit4] 2> 783351 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 783367 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 783375 INFO (zkCallback-436-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@24f251ac name:ZooKeeperConnection Watcher:127.0.0.1:39273/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 783375 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 783376 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 783377 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 783377 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/solr.xml [junit4] 2> 783382 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/cores [junit4] 2> 783382 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.CoreContainer New CoreContainer 28478889 [junit4] 2> 783383 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/] [junit4] 2> 783383 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/lib [junit4] 2> 783383 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/lib). [junit4] 2> 783390 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] 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> 783392 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 783392 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 783392 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 783392 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39273/solr [junit4] 2> 783392 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 783393 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 783395 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 783402 INFO (zkCallback-438-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@553e717c name:ZooKeeperConnection Watcher:127.0.0.1:39273 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 783422 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 783423 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 783442 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 783468 INFO (zkCallback-439-thread-1-processing-n:127.0.0.1:47653_vgva) [n:127.0.0.1:47653_vgva ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5c6b11a4 name:ZooKeeperConnection Watcher:127.0.0.1:39273/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 783470 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 783474 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 784477 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:47653_vgva [junit4] 2> 784478 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:47653_vgva [junit4] 2> 784479 INFO (zkCallback-435-thread-1) [ ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 784479 INFO (zkCallback-433-thread-2-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 784479 INFO (zkCallback-433-thread-1-processing-n:127.0.0.1:58454_vgva) [n:127.0.0.1:58454_vgva ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 784481 INFO (zkCallback-439-thread-1-processing-n:127.0.0.1:47653_vgva) [n:127.0.0.1:47653_vgva ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1) [junit4] 2> 784482 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 784482 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94367212718325768-127.0.0.1:47653_vgva-n_0000000001 [junit4] 2> 784483 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/94367212718325764-127.0.0.1:58454_vgva-n_0000000000 to know if I could be the leader [junit4] 2> 784539 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 784540 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 784540 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/cores [junit4] 2> 784541 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/cores/collection1, collection=collection1, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_EF6380E83FB00BFF-001/shard-1-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 784542 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[EF6380E83FB00BFF]) [n:127.0.0.1:47653_vgva ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.cl [...truncated too long message...] .hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72) [junit4] 2> at org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720) [junit4] 2> at org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:197) [junit4] 2> at org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.teardownClass(HdfsCollectionsAPIDistributedZkTest.java:50) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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> 6748222 INFO (SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[EF6380E83FB00BFF]-worker) [n:127.0.0.1:43635_ c:addReplicaColl s:shard1 r:core_node1 x:addReplicaColl_shard1_replica1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> Aug 18, 2015 6:02:42 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {other_tl1=PostingsFormat(name=Memory doPackFST= true), range_facet_l_dv=PostingsFormat(name=LuceneFixedGap), _version_=PostingsFormat(name=Memory doPackFST= true), multiDefault=FSTOrd50, a_t=PostingsFormat(name=Memory doPackFST= true), intDefault=PostingsFormat(name=Memory doPackFST= true), a_i1=PostingsFormat(name=Memory doPackFST= true), id=PostingsFormat(name=LuceneFixedGap), range_facet_i_dv=PostingsFormat(name=Memory doPackFST= true), text=PostingsFormat(name=Memory doPackFST= false), range_facet_l=PostingsFormat(name=Memory doPackFST= true), timestamp=PostingsFormat(name=Memory doPackFST= true)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), range_facet_i_dv=DocValuesFormat(name=Lucene50), timestamp=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, locale=es_CU, timezone=Australia/Queensland [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=4,threads=2,free=81295496,total=528482304 [junit4] 2> NOTE: All tests run in this JVM: [AnalyticsQueryTest, TestConfigSets, CacheHeaderTest, TestCopyFieldCollectionResource, ZkCLITest, TestCollapseQParserPlugin, FacetPivotSmallTest, TestManagedSynonymFilterFactory, ReplicationFactorTest, FieldAnalysisRequestHandlerTest, CopyFieldTest, DistribCursorPagingTest, DocValuesMultiTest, TestIntervalFaceting, EchoParamsTest, CustomCollectionTest, TestLeaderElectionZkExpiry, OverseerRolesTest, OutOfBoxZkACLAndCredentialsProvidersTest, TestRestoreCore, CoreAdminHandlerTest, ZkControllerTest, CurrencyFieldOpenExchangeTest, ConvertedLegacyTest, HLLUtilTest, JSONWriterTest, TestSolrXml, TestSolrDeletionPolicy2, TestMissingGroups, TestLMDirichletSimilarityFactory, TestSchemaManager, ResourceLoaderTest, TestHighFrequencyDictionaryFactory, LukeRequestHandlerTest, HdfsThreadLeakTest, DistanceFunctionTest, TestJsonRequest, RAMDirectoryFactoryTest, TestFieldCollectionResource, SystemInfoHandlerTest, HdfsChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest, TestCoreDiscovery, TestManagedSchema, SpellingQueryConverterTest, HdfsUnloadDistributedZkTest, TestCoreContainer, TestReloadAndDeleteDocs, DistributedTermsComponentTest, TestRTimerTree, AsyncCallRequestStatusResponseTest, TestDistributedGrouping, SuggesterTSTTest, ShowFileRequestHandlerTest, DistributedFacetPivotSmallTest, TestHighlightDedupGrouping, UpdateParamsTest, TestSearchPerf, ZkStateWriterTest, SpellPossibilityIteratorTest, TestReRankQParserPlugin, ReturnFieldsTest, TestCollectionAPI, DistanceUnitsTest, TestSuggestSpellingConverter, TestAddFieldRealTimeGet, TestManagedSchemaDynamicFieldResource, CdcrRequestHandlerTest, TestAtomicUpdateErrorCases, DistributedExpandComponentTest, TestLMJelinekMercerSimilarityFactory, MigrateRouteKeyTest, RemoteQueryErrorTest, TestSolrDynamicMBean, TestCloudInspectUtil, TestWriterPerf, RankQueryTest, TestOmitPositions, JsonLoaderTest, UUIDUpdateProcessorFallbackTest, AlternateDirectoryTest, AtomicUpdatesTest, ChaosMonkeySafeLeaderTest, AssignTest, StatelessScriptUpdateProcessorFactoryTest, SaslZkACLProviderTest, TestStressUserVersions, TestLFUCache, TestSimpleQParserPlugin, BasicDistributedZkTest, BasicDistributedZk2Test, SyncSliceTest, OpenCloseCoreStressTest, ShardRoutingTest, BasicZkTest, ClusterStateUpdateTest, TestRandomFaceting, ZkSolrClientTest, ShardRoutingCustomTest, TestDistributedSearch, PreAnalyzedFieldTest, DateFieldTest, ClusterStateTest, TestLRUCache, TestUtils, TestDocumentBuilder, SliceStateTest, FileUtilsTest, DistributedMLTComponentTest, TestRTGBase, DistributedIntervalFacetingTest, SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort, TestSimpleTrackingShardHandler, TestJettySolrRunner, ActionThrottleTest, AliasIntegrationTest, AsyncMigrateRouteKeyTest, CdcrReplicationHandlerTest, CollectionReloadTest, DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest, DistribDocExpirationUpdateProcessorTest, MultiThreadedOCPTest, SharedFSAutoReplicaFailoverUtilsTest, SolrCloudExampleTest, SolrXmlInZkTest, TestAuthenticationFramework, TestMiniSolrCloudClusterSSL, TestRandomRequestDistribution, TestShortCircuitedRequests, TestSolrCloudWithKerberosAlt, HdfsCollectionsAPIDistributedZkTest] [junit4] Completed [540/540] on J1 in 1523.43s, 1 test, 1 error <<< FAILURES! [...truncated 13 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:782: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:719: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:514: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1429: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:984: There were test failures: 540 suites, 2131 tests, 2 suite-level errors, 2 errors, 26 ignored (14 assumptions) Total time: 267 minutes 55 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org