Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/44/
4 tests failed. FAILED: org.apache.solr.TestDistributedSearch.test Error Message: Captured an uncaught exception in thread: Thread[id=32313, name=Thread-31915, state=RUNNABLE, group=TGRP-TestDistributedSearch] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=32313, name=Thread-31915, state=RUNNABLE, group=TGRP-TestDistributedSearch] at __randomizedtesting.SeedInfo.seed([FF7B6F80A8BACE99:772F505A0646A361]:0) Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:53032/gr_y/collection1: java.lang.NullPointerException at org.apache.solr.search.grouping.distributed.responseprocessor.TopGroupsShardResponseProcessor.process(TopGroupsShardResponseProcessor.java:105) at org.apache.solr.handler.component.QueryComponent.handleGroupedResponses(QueryComponent.java:753) at org.apache.solr.handler.component.QueryComponent.handleResponses(QueryComponent.java:736) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:426) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:155) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2015) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:652) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:460) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:229) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:184) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1160) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1092) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134) at org.eclipse.jetty.server.Server.handle(Server.java:518) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:308) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:244) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95) at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:246) at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:156) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) at java.lang.Thread.run(Thread.java:745) at __randomizedtesting.SeedInfo.seed([FF7B6F80A8BACE99]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:957) at org.apache.solr.TestDistributedSearch$1.run(TestDistributedSearch.java:1114) FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=107907, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=107907, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Caused by: org.apache.solr.common.SolrException: Error reading cluster properties at __randomizedtesting.SeedInfo.seed([FF7B6F80A8BACE99]:0) at org.apache.solr.common.cloud.ZkStateReader.getClusterProps(ZkStateReader.java:769) at org.apache.solr.common.cloud.ZkStateReader.getBaseUrlForNodeName(ZkStateReader.java:863) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1090) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:962) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:898) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:994) Caused by: org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /clusterprops.json at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) at org.apache.zookeeper.ZooKeeper.exists(ZooKeeper.java:1045) at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:314) at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:311) at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) at org.apache.solr.common.cloud.SolrZkClient.exists(SolrZkClient.java:311) at org.apache.solr.common.cloud.ZkStateReader.getClusterProps(ZkStateReader.java:760) ... 6 more FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh Error Message: Could not find collection : c1 Stack Trace: org.apache.solr.common.SolrException: Could not find collection : c1 at __randomizedtesting.SeedInfo.seed([FF7B6F80A8BACE99:E0C11E7778DA085C]:0) at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) 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:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) 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:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication Error Message: timed out waiting for collection1 startAt time to exceed: Thu Apr 21 00:20:55 DAVT 2016 Stack Trace: java.lang.AssertionError: timed out waiting for collection1 startAt time to exceed: Thu Apr 21 00:20:55 DAVT 2016 at __randomizedtesting.SeedInfo.seed([FF7B6F80A8BACE99:24D06F46AD92A72A]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1423) at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:775) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) 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:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) 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:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 11190 lines...] [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_FF7B6F80A8BACE99-001/init-core-data-001 [junit4] 2> 59310 INFO (SUITE-ZkStateReaderTest-seed#[FF7B6F80A8BACE99]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 59313 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched [junit4] 2> 59313 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 59328 INFO (Thread-85) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 59328 INFO (Thread-85) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 59424 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer start zk server on port:58545 [junit4] 2> 59424 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 59425 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 59427 INFO (zkCallback-41-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6312879 name:ZooKeeperConnection Watcher:127.0.0.1:58545 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 59428 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 59428 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 59429 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 59432 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 59456 INFO (zkCallback-42-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@795af37c name:ZooKeeperConnection Watcher:127.0.0.1:58545 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 59460 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 59460 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 59460 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 59469 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 59484 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 59770 INFO (zkCallback-43-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@cdbe233 name:ZooKeeperConnection Watcher:127.0.0.1:58545/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 59770 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 59771 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 59772 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 59773 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 59775 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 59776 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 59777 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 59777 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 59778 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 59779 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 59780 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 59781 INFO (zkCallback-43-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 59782 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 59783 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 59783 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1] [junit4] 2> 59784 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:58545 58545 [junit4] 2> 59970 INFO (Thread-85) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:58545 58545 [junit4] 2> 59970 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched [junit4] 2> 59972 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation [junit4] 2> 59972 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 59972 INFO (Thread-86) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 59972 INFO (Thread-86) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 60076 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer start zk server on port:37574 [junit4] 2> 60076 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 60098 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 60114 INFO (zkCallback-44-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@265cbc5b name:ZooKeeperConnection Watcher:127.0.0.1:37574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 60116 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 60116 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 60117 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x154348022db0000, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 60118 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 60119 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 60123 INFO (zkCallback-45-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@33bad1b0 name:ZooKeeperConnection Watcher:127.0.0.1:37574 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 60123 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 60123 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 60123 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 60125 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 60140 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 60152 INFO (zkCallback-46-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@39b97145 name:ZooKeeperConnection Watcher:127.0.0.1:37574/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 60152 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 60153 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 60153 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 60154 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 60155 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 60155 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 60156 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 60157 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 60157 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 60158 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 60158 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 60158 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 60159 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 60165 INFO (zkCallback-46-thread-2) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 60182 INFO (zkCallback-46-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0]) [junit4] 2> 60183 INFO (zkCallback-46-thread-3) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 60212 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37574 37574 [junit4] 2> 60392 INFO (Thread-86) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37574 37574 [junit4] 2> 60396 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation [junit4] 2> 60399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh [junit4] 2> 60399 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 60406 INFO (Thread-87) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 60406 INFO (Thread-87) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 60508 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer start zk server on port:43053 [junit4] 2> 60508 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 60532 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 60538 INFO (zkCallback-47-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@574c3bd name:ZooKeeperConnection Watcher:127.0.0.1:43053 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 60539 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 60539 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 60941 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 60941 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 60946 INFO (zkCallback-48-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@8aeb0a9 name:ZooKeeperConnection Watcher:127.0.0.1:43053 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 60946 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 60946 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 60946 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 60949 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 60956 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 60969 INFO (zkCallback-49-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@752d5b9e name:ZooKeeperConnection Watcher:127.0.0.1:43053/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 60970 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 60970 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 60971 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 60973 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 60974 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 60974 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 60975 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 60975 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 60976 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 60976 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 60977 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 60977 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 60979 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 60992 INFO (zkCallback-49-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 60992 WARN (zkCallback-49-thread-1) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections] [junit4] 2> 61000 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]-EventThread) [ ] o.a.z.ClientCnxn Error while calling watcher [junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$8/553631725@1bbb50ee rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@5eb9cdfd[Shutting down, pool size = 1, active threads = 1, queued tasks = 0, completed tasks = 2] [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214) [junit4] 2> at java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266) [junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522) [junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498) [junit4] 2> 61001 INFO (zkCallback-49-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 61001 WARN (zkCallback-49-thread-2) [ ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /clusterstate.json] [junit4] 2> 61002 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43053 43053 [junit4] 2> 61422 INFO (Thread-87) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43053 43053 [junit4] 2> 61462 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh [junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefresh -Dtests.seed=FF7B6F80A8BACE99 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt -Dtests.locale=en-MT -Dtests.timezone=Pacific/Bougainville -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 1.07s J0 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<< [junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1 [junit4] > at __randomizedtesting.SeedInfo.seed([FF7B6F80A8BACE99:E0C11E7778DA085C]:0) [junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170) [junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136) [junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 61467 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 61467 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 61470 INFO (Thread-88) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 61471 INFO (Thread-88) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 61630 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer start zk server on port:35383 [junit4] 2> 61631 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 61631 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 61635 INFO (zkCallback-50-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@69170e0f name:ZooKeeperConnection Watcher:127.0.0.1:35383 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 61635 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 61635 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 61637 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 61637 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 61644 INFO (zkCallback-51-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1e5c365b name:ZooKeeperConnection Watcher:127.0.0.1:35383 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 61644 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 61645 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 61645 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 61647 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 61647 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 61649 INFO (zkCallback-52-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@cef60ab name:ZooKeeperConnection Watcher:127.0.0.1:35383/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 61649 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 61650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 61650 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 61651 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 61651 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 61652 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 61653 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 61653 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 61654 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 61654 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 61655 INFO (zkCallback-52-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 61662 INFO (zkCallback-52-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 61662 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 61663 INFO (zkCallback-52-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 61729 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35383 35383 [junit4] 2> 62189 INFO (Thread-88) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35383 35383 [junit4] 2> 62190 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 62191 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 62192 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 62204 INFO (Thread-89) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 62204 INFO (Thread-89) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 62300 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer start zk server on port:36258 [junit4] 2> 62300 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 62301 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 62304 INFO (zkCallback-53-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5d5b8571 name:ZooKeeperConnection Watcher:127.0.0.1:36258 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 62304 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 62305 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 62306 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 62307 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 62313 INFO (zkCallback-54-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@412a014f name:ZooKeeperConnection Watcher:127.0.0.1:36258 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 62313 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 62313 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 62313 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 62318 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 62319 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 62321 INFO (zkCallback-55-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@36adda92 name:ZooKeeperConnection Watcher:127.0.0.1:36258/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 62321 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 62321 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 62322 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 62323 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 62324 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 62325 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 62326 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 62327 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 62328 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 62328 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 62330 INFO (zkCallback-55-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 62330 INFO (zkCallback-55-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 62331 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 62332 INFO (zkCallback-55-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 62348 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36258 36258 [junit4] 2> 62596 INFO (Thread-89) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:36258 36258 [junit4] 2> 62608 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 62610 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay [junit4] 2> 62610 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 62620 INFO (Thread-90) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 62620 INFO (Thread-90) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 62720 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer start zk server on port:56358 [junit4] 2> 62720 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 62736 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 62772 INFO (zkCallback-56-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@58f4391b name:ZooKeeperConnection Watcher:127.0.0.1:56358 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 62773 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 62773 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 62787 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 62793 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 62797 INFO (zkCallback-57-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4e4d5e9e name:ZooKeeperConnection Watcher:127.0.0.1:56358 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 62797 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 62798 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 62798 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 62800 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 62800 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 62803 INFO (zkCallback-58-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4d224a27 name:ZooKeeperConnection Watcher:127.0.0.1:56358/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 62803 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 62803 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 62804 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 62806 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 62807 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 62807 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 62808 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 62809 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 62809 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 62810 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 62810 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 62810 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 62816 INFO (zkCallback-58-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 62816 INFO (zkCallback-58-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 62862 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 62863 INFO (zkCallback-58-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0]) [junit4] 2> 62864 INFO (zkCallback-58-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 62864 INFO (zkCallback-58-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 62866 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56358 56358 [junit4] 2> 63120 INFO (Thread-90) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56358 56358 [junit4] 2> 63121 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay [junit4] 2> 63122 INFO (SUITE-ZkStateReaderTest-seed#[FF7B6F80A8BACE99]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_FF7B6F80A8BACE99-001 [junit4] 2> Apr 20, 2016 4:28:16 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Lucene60, sim=ClassicSimilarity, locale=en-MT, timezone=Pacific/Bougainville [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=219252240,total=329252864 [junit4] 2> NOTE: All tests run in this JVM: [ResourceLoaderTest, TestAuthorizationFramework, OutputWriterTest, DateRangeFieldTest, TestSolrQueryParserResource, ZkStateReaderTest] [junit4] Completed [19/591 (1!)] on J0 in 4.39s, 6 tests, 1 error <<< FAILURES! [...truncated 312 lines...] [junit4] Suite: org.apache.solr.TestDistributedSearch [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/init-core-data-001 [junit4] 2> 87806 INFO (SUITE-TestDistributedSearch-seed#[FF7B6F80A8BACE99]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) [junit4] 2> 87806 INFO (SUITE-TestDistributedSearch-seed#[FF7B6F80A8BACE99]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /gr_y/ [junit4] 2> 87995 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1 [junit4] 2> 88005 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 88073 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4a2fc678{/gr_y,null,AVAILABLE} [junit4] 2> 88074 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.e.j.s.ServerConnector Started ServerConnector@54bba0e1{HTTP/1.1,[http/1.1]}{127.0.0.1:45946} [junit4] 2> 88074 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.e.j.s.Server Started @93450ms [junit4] 2> 88074 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/gr_y, hostPort=45946, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores} [junit4] 2> 88074 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 88074 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control' [junit4] 2> 88075 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 88075 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 88075 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/solr.xml [junit4] 2> 88096 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores [junit4] 2> 88096 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer New CoreContainer 1010270595 [junit4] 2> 88096 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control] [junit4] 2> 88097 WARN (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/lib [junit4] 2> 88098 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] 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> 88098 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 88099 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 88099 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 88099 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 88099 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 88100 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores [junit4] 2> 88108 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/, configSet=collection1} [junit4] 2> 88108 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1 [junit4] 2> 88108 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 88233 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1' [junit4] 2> 88233 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 88233 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 88233 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 88233 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 88248 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0 [junit4] 2> 88248 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 88282 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 88287 WARN (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 88288 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 88339 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 88356 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 88778 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 88783 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 88783 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 88812 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 88827 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 88828 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 88828 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 88830 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1' [junit4] 2> 88830 INFO (coreLoadExecutor-176-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1 [junit4] 2> 88830 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 88830 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 88830 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@b345582 [junit4] 2> 88830 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1/data [junit4] 2> 88831 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1/data/index/ [junit4] 2> 88831 WARN (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 88831 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1/data/index [junit4] 2> 88831 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=51.376953125, floorSegmentMB=0.982421875, forceMergeDeletesPctAllowed=2.314092240309382, segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5840385616671532 [junit4] 2> 88849 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@75e18cca lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2f66c197),segFN=segments_1,generation=1} [junit4] 2> 88849 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 88855 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 88856 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ 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-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1/data/ [junit4] 2> 88856 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/control/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 88859 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 88861 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 88862 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 88862 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 88865 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 88866 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/sql,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump [junit4] 2> 88866 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 88877 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 88877 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 88878 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1357378187, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 88878 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@75e18cca lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2f66c197),segFN=segments_1,generation=1} [junit4] 2> 88878 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 88878 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@77f212db[collection1] main] [junit4] 2> 88879 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 88879 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 88879 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 88879 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 88902 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 88942 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 88942 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 88943 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 88943 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 88943 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 88943 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 88943 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 88943 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 88944 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 88944 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 88949 INFO (coreLoadExecutor-176-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 88950 INFO (searcherExecutor-177-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@77f212db[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 89473 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 89474 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 89513 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@608f3b5d{/gr_y,null,AVAILABLE} [junit4] 2> 89514 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.e.j.s.ServerConnector Started ServerConnector@13bd0324{HTTP/1.1,[http/1.1]}{127.0.0.1:42604} [junit4] 2> 89514 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.e.j.s.Server Started @94890ms [junit4] 2> 89514 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/gr_y, hostPort=42604, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0/cores} [junit4] 2> 89514 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 89514 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0' [junit4] 2> 89514 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 89514 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 89515 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0/solr.xml [junit4] 2> 89524 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0/cores [junit4] 2> 89524 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer New CoreContainer 165988372 [junit4] 2> 89524 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0] [junit4] 2> 89524 WARN (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0/lib [junit4] 2> 89524 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] 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> 89525 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 89526 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 89526 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 89526 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 89526 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 89526 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_FF7B6F80A8BACE99-001/tempDir-001/shard0/cores [junit4] 2> 89533 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/, configSet=collection1} [junit4] 2> 89533 INFO (TEST-TestDistributedSearch.test-seed#[FF7B6F80A8BACE99]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Nightly [...truncated too long message...] g-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-common-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/mockito-core-1.9.5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/analysis/icu/lucene-analyzers-icu-6.1.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/build/queryparser/classes/test:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/contrib/analysis-extras/lib/icu4j-56.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.3.4.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J0-20160420_162707_968.events @/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/temp/junit4-J0-20160420_162707_968.suites -stdin [junit4] ERROR: JVM J0 ended with an exception: Quit event not received from the forked process? This may indicate JVM crash or runner bugs. [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1501) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:121) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:955) [junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:952) [junit4] at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] at java.lang.Thread.run(Thread.java:745) BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:529: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014: At least one slave process threw an exception, first: Quit event not received from the forked process? This may indicate JVM crash or runner bugs. Total time: 365 minutes 4 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org