You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2016/04/17 22:29:53 UTC

[JENKINS] Lucene-Solr-Tests-master - Build # 1085 - Still Failing

Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1085/

3 tests failed.
FAILED:  org.apache.solr.cloud.TestRandomRequestDistribution.test

Error Message:
Shard a1x2_shard1_replica1 received all 10 requests

Stack Trace:
java.lang.AssertionError: Shard a1x2_shard1_replica1 received all 10 requests
	at __randomizedtesting.SeedInfo.seed([487CCA24F7C674D7:C028F5FE593A192F]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.cloud.TestRandomRequestDistribution.testRequestTracking(TestRandomRequestDistribution.java:122)
	at org.apache.solr.cloud.TestRandomRequestDistribution.test(TestRandomRequestDistribution.java:65)
	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 org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
	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:  junit.framework.TestSuite.org.apache.solr.schema.TestManagedSchemaAPI

Error Message:
ObjectTracker found 1 object(s) that were not released!!! [MockDirectoryWrapper]

Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [MockDirectoryWrapper]
	at __randomizedtesting.SeedInfo.seed([487CCA24F7C674D7]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNull(Assert.java:551)
	at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:255)
	at sun.reflect.GeneratedMethodAccessor16.invoke(Unknown Source)
	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$7.evaluate(RandomizedRunner.java:834)
	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.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
	at __randomizedtesting.SeedInfo.seed([487CCA24F7C674D7:23336A598EC9A9ED]:0)
	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:134)
	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:45)
	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 11170 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_487CCA24F7C674D7-001/init-core-data-001
   [junit4]   2> 875527 INFO  (SUITE-ZkStateReaderTest-seed#[487CCA24F7C674D7]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 875536 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 875537 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 875673 INFO  (Thread-3180) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 875673 INFO  (Thread-3180) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 875773 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer start zk server on port:50664
   [junit4]   2> 875773 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 875816 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 875859 INFO  (zkCallback-658-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6159c2b9 name:ZooKeeperConnection Watcher:127.0.0.1:50664 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 875859 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 875860 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 875869 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 875888 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 875928 INFO  (zkCallback-659-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5b9ed714 name:ZooKeeperConnection Watcher:127.0.0.1:50664 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 875928 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 875928 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 875928 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 875932 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 875969 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 875976 INFO  (zkCallback-660-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1820b19 name:ZooKeeperConnection Watcher:127.0.0.1:50664/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 875976 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 875976 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 875981 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 875981 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 875982 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 875982 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 875982 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 875983 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 875983 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 875984 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 875985 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 875987 INFO  (zkCallback-660-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 875987 WARN  (zkCallback-660-thread-1) [    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections]
   [junit4]   2> 876016 INFO  (zkCallback-660-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> 876016 WARN  (zkCallback-660-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> 876017 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50664 50664
   [junit4]   2> 876208 INFO  (Thread-3180) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50664 50664
   [junit4]   2> 876208 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithExplicitRefreshLazy -Dtests.seed=487CCA24F7C674D7 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=es-PR -Dtests.timezone=Africa/Bujumbura -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.68s J2 | ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([487CCA24F7C674D7:23336A598EC9A9ED]:0)
   [junit4]    > 	at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:134)
   [junit4]    > 	at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:45)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 876215 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 876216 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 876224 INFO  (Thread-3181) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 876224 INFO  (Thread-3181) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 876320 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer start zk server on port:44183
   [junit4]   2> 876320 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 876340 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 876348 INFO  (zkCallback-661-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4d92792d name:ZooKeeperConnection Watcher:127.0.0.1:44183 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 876348 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 876349 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 876356 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 876357 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 876357 INFO  (zkCallback-662-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2c93e0e9 name:ZooKeeperConnection Watcher:127.0.0.1:44183 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 876357 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 876357 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 876357 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 876364 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 876368 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 876372 INFO  (zkCallback-663-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3dfc7261 name:ZooKeeperConnection Watcher:127.0.0.1:44183/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 876372 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 876372 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 876379 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 876379 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 876384 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 876384 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 876385 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 876385 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 876386 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 876386 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 876386 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 876387 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 876387 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 876388 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 876389 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 876395 INFO  (zkCallback-663-thread-2) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 876395 WARN  (zkCallback-663-thread-2) [    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /collections]
   [junit4]   2> 876395 ERROR (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]-EventThread) [    ] o.a.z.ClientCnxn Error while calling watcher 
   [junit4]   2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$6/792926627@64dbb8c8 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@21d92a37[Shutting down, pool size = 2, active threads = 2, queued tasks = 0, completed tasks = 0]
   [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> 876396 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44183 44183
   [junit4]   2> 876674 INFO  (Thread-3181) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44183 44183
   [junit4]   2> 876684 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 876720 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 876721 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 876737 INFO  (Thread-3182) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 876737 INFO  (Thread-3182) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 876836 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer start zk server on port:50817
   [junit4]   2> 876836 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 876836 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 876839 INFO  (zkCallback-664-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5bf8eed2 name:ZooKeeperConnection Watcher:127.0.0.1:50817 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 876839 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 876839 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 876840 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 876840 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 876841 INFO  (zkCallback-665-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@151c3500 name:ZooKeeperConnection Watcher:127.0.0.1:50817 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 876841 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 876841 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 876841 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 876843 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 876843 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 876844 INFO  (zkCallback-666-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@c480d09 name:ZooKeeperConnection Watcher:127.0.0.1:50817/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 876844 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 876844 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 876845 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 876845 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 876846 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 876846 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 876847 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 876848 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 876848 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 876849 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 876849 INFO  (zkCallback-666-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 876852 INFO  (zkCallback-666-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> 876853 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 876853 INFO  (zkCallback-666-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> 876905 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50817 50817
   [junit4]   2> 877099 INFO  (Thread-3182) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:50817 50817
   [junit4]   2> 877100 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 877102 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 877102 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 877108 INFO  (Thread-3183) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 877108 INFO  (Thread-3183) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 877208 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer start zk server on port:57577
   [junit4]   2> 877208 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 877212 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 877228 INFO  (zkCallback-667-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@215e00f9 name:ZooKeeperConnection Watcher:127.0.0.1:57577 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 877232 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 877232 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 877264 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 877272 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 877288 INFO  (zkCallback-668-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@54a2eca3 name:ZooKeeperConnection Watcher:127.0.0.1:57577 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 877292 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 877292 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 877292 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 877301 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 877302 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 877302 INFO  (zkCallback-669-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@77ff4f11 name:ZooKeeperConnection Watcher:127.0.0.1:57577/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 877305 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 877306 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 877306 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 877307 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 877307 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 877308 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 877308 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 877309 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 877312 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 877313 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 877313 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 877313 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 877313 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 877314 INFO  (zkCallback-669-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 877315 INFO  (zkCallback-669-thread-1) [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 877315 INFO  (zkCallback-669-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> 877316 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 877316 INFO  (zkCallback-669-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> 877317 INFO  (zkCallback-669-thread-2) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 877368 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57577 57577
   [junit4]   2> 877703 INFO  (Thread-3183) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57577 57577
   [junit4]   2> 877704 INFO  (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> 877706 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 877706 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 877708 INFO  (Thread-3184) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 877708 INFO  (Thread-3184) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 877812 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer start zk server on port:45279
   [junit4]   2> 877812 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 877828 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 877854 INFO  (zkCallback-670-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1adcc381 name:ZooKeeperConnection Watcher:127.0.0.1:45279 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 877857 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 877857 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 877888 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 877900 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 877916 INFO  (zkCallback-671-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@53a9d751 name:ZooKeeperConnection Watcher:127.0.0.1:45279 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 877920 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 877920 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 877920 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 877928 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 877928 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 877929 INFO  (zkCallback-672-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@46b865b5 name:ZooKeeperConnection Watcher:127.0.0.1:45279/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 877929 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 877929 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 877929 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 877930 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 877931 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 877931 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 877932 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 877932 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 877933 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 877933 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 877934 INFO  (zkCallback-672-thread-1) [    ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 877934 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json
   [junit4]   2> 877935 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 877935 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 877935 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
   [junit4]   2> 877936 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45279 45279
   [junit4]   2> 878225 INFO  (Thread-3184) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:45279 45279
   [junit4]   2> 878226 INFO  (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 878228 INFO  (SUITE-ZkStateReaderTest-seed#[487CCA24F7C674D7]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_487CCA24F7C674D7-001
   [junit4]   2> Apr 17, 2016 7:52:02 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=Asserting(Lucene60): {}, docValues:{}, maxPointsInLeafNode=1142, maxMBSortInHeap=6.033674544333696, sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=es-PR, timezone=Africa/Bujumbura
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=312692008,total=519569408
   [junit4]   2> NOTE: All tests run in this JVM: [TestMaxScoreQueryParser, TestDownShardTolerantSearch, BlockJoinFacetDistribTest, TestPerFieldSimilarityWithDefaultOverride, TestExpandComponent, TestOverriddenPrefixQueryForCustomFieldType, TriLevelCompositeIdRoutingTest, FieldMutatingUpdateProcessorTest, TestSolrJ, SolrCoreCheckLockOnStartupTest, DistributedDebugComponentTest, CheckHdfsIndexTest, PrimitiveFieldTypeTest, TestIntervalFaceting, TestReloadDeadlock, CurrencyFieldXmlFileTest, HdfsWriteToMultipleCollectionsTest, OverseerCollectionConfigSetProcessorTest, FieldAnalysisRequestHandlerTest, BadComponentTest, LukeRequestHandlerTest, CleanupOldIndexTest, SliceStateTest, TestXIncludeConfig, LeaderInitiatedRecoveryOnCommitTest, LeaderElectionTest, DocValuesMultiTest, TestComplexPhraseQParserPlugin, TermVectorComponentDistributedTest, CollectionsAPISolrJTest, TestCollectionAPI, TestSearchPerf, TestNRTOpen, TestPerFieldSimilarity, CdcrRequestHandlerTest, TestFieldTypeResource, TestDefaultSearchFieldResource, EnumFieldTest, RegexBoostProcessorTest, ChangedSchemaMergeTest, TestManagedResource, TestFastWriter, TestAnalyzeInfixSuggestions, TolerantUpdateProcessorTest, TestSmileRequest, TestRecovery, StatsComponentTest, AssignTest, HdfsRecoveryZkTest, FullSolrCloudDistribCmdsTest, DistributedFacetPivotWhiteBoxTest, DirectUpdateHandlerTest, QueryResultKeyTest, TestAuthorizationFramework, TestImplicitCoreProperties, MergeStrategyTest, TestXmlQParser, TestSweetSpotSimilarityFactory, TestSolrIndexConfig, DeleteLastCustomShardedReplicaTest, SuggesterTSTTest, QueryParsingTest, BadIndexSchemaTest, AddSchemaFieldsUpdateProcessorFactoryTest, CloneFieldUpdateProcessorFactoryTest, ReplicationFactorTest, TestBulkSchemaAPI, SharedFSAutoReplicaFailoverTest, HdfsLockFactoryTest, TestSizeLimitedDistributedMap, TestTolerantSearch, ZkStateReaderTest]
   [junit4] Completed [204/587 (1!)] on J2 in 3.49s, 5 tests, 1 error <<< FAILURES!

[...truncated 42 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestRandomRequestDistribution
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/init-core-data-001
   [junit4]   2> 958014 INFO  (SUITE-TestRandomRequestDistribution-seed#[487CCA24F7C674D7]-worker) [    ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_xi/a
   [junit4]   2> 958015 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 958016 INFO  (Thread-3559) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 958016 INFO  (Thread-3559) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 958120 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkTestServer start zk server on port:58893
   [junit4]   2> 958120 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 958128 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 958152 INFO  (zkCallback-801-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2d83f4ff name:ZooKeeperConnection Watcher:127.0.0.1:58893 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 958152 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 958152 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 958152 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 958224 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 958236 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 958260 INFO  (zkCallback-802-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7b155dfe name:ZooKeeperConnection Watcher:127.0.0.1:58893/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 958264 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 958264 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 958264 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 958316 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 958352 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 958370 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 958397 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
   [junit4]   2> 958397 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 958398 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
   [junit4]   2> 958399 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 958400 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 958400 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 958402 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
   [junit4]   2> 958402 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 958403 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
   [junit4]   2> 958403 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 958404 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
   [junit4]   2> 958405 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 958406 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
   [junit4]   2> 958406 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 958408 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 958408 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 958409 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 958409 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 958409 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
   [junit4]   2> 958409 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 958410 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
   [junit4]   2> 958410 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 958475 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores/collection1
   [junit4]   2> 958477 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 958478 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5cc4efab{/_xi/a,null,AVAILABLE}
   [junit4]   2> 958482 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.e.j.s.ServerConnector Started ServerConnector@6c596e5{HTTP/1.1,[http/1.1]}{127.0.0.1:59680}
   [junit4]   2> 958482 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.e.j.s.Server Started @965015ms
   [junit4]   2> 958482 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/tempDir-001/control/data, hostContext=/_xi/a, hostPort=59680, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores}
   [junit4]   2> 958482 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 958483 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001'
   [junit4]   2> 958483 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 958483 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 958483 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 958485 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 958488 INFO  (zkCallback-803-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@300b584 name:ZooKeeperConnection Watcher:127.0.0.1:58893/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 958488 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 958488 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 958497 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
   [junit4]   2> 958497 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/solr.xml
   [junit4]   2> 958501 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores
   [junit4]   2> 958501 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.CoreContainer New CoreContainer 1337960145
   [junit4]   2> 958501 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001]
   [junit4]   2> 958501 WARN  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/lib
   [junit4]   2> 958501 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] 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,
   [junit4]   2> 958559 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
   [junit4]   2> 958564 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 958564 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 958564 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58893/solr
   [junit4]   2> 958564 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 958564 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 958576 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 958607 INFO  (zkCallback-806-thread-1) [    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1eac33bc name:ZooKeeperConnection Watcher:127.0.0.1:58893 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 958612 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 958612 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 958622 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$17/627157155@37635d50
   [junit4]   2> 958622 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 958640 INFO  (zkCallback-807-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2604d2f1 name:ZooKeeperConnection Watcher:127.0.0.1:58893/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 958644 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 958644 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 958652 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 958653 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 958654 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 958655 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 958656 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 958656 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 958657 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 958657 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 958658 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 958658 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 958659 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 958659 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 958660 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 958660 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000
   [junit4]   2> 958660 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59680__xi%2Fa
   [junit4]   2> 958660 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 958668 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.Overseer Overseer (id=95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000) starting
   [junit4]   2> 958668 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 958671 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 958680 INFO  (OverseerCollectionConfigSetProcessor-95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
   [junit4]   2> 958680 INFO  (OverseerStateUpdate-95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 958692 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59680__xi%2Fa
   [junit4]   2> 958693 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:59680__xi%2Fa
   [junit4]   2> 958693 INFO  (OverseerStateUpdate-95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0)
   [junit4]   2> 958693 INFO  (zkCallback-807-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0])
   [junit4]   2> 958710 INFO  (zkCallback-807-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 958714 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 958714 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 958715 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores
   [junit4]   2> 958716 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=control_collection, coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 958716 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores/collection1
   [junit4]   2> 958716 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 958717 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2
   [junit4]   2> 958717 INFO  (TEST-TestRandomRequestDistribution.test-seed#[487CCA24F7C674D7]) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 958717 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.ZkController publishing state=down
   [junit4]   2> 958717 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property
   [junit4]   2> 958718 INFO  (OverseerStateUpdate-95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:59680/_xi/a",
   [junit4]   2>   "node_name":"127.0.0.1:59680__xi%2Fa",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 958718 INFO  (OverseerStateUpdate-95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:59680/_xi/a",
   [junit4]   2>   "node_name":"127.0.0.1:59680__xi%2Fa",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 958718 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.ZkController look for our core node name
   [junit4]   2> 958718 INFO  (OverseerStateUpdate-95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection
   [junit4]   2> 958719 INFO  (OverseerStateUpdate-95743036761178116-127.0.0.1:59680__xi%2Fa-n_0000000000) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
   [junit4]   2> 958719 INFO  (zkCallback-807-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 959723 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
   [junit4]   2> 959723 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection
   [junit4]   2> 959727 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 959727 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection]
   [junit4]   2> 959727 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 959727 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores/collection1'
   [junit4]   2> 959727 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 959727 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 959728 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 
   [junit4]   2> 959741 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 959744 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 959757 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 959762 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 960212 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 960216 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 960217 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 960222 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 960224 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 960225 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 960227 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 960228 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2
   [junit4]   2> 960228 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection   x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection
   [junit4]   2> 960229 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 960230 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores/collection1/data/]
   [junit4]   2> 960230 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4d31d43b
   [junit4]   2> 960231 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores/collection1/data
   [junit4]   2> 960232 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores/collection1/data/index/
   [junit4]   2> 960232 WARN  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J2/temp/solr.cloud.TestRandomRequestDistribution_487CCA24F7C674D7-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 960232 INFO  (coreLoadExecutor-2775-thread-1-processing-n:127.0.0.1:59680__xi%2Fa) [n:127.0.0.1:59680__xi%2Fa c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for

[...truncated too long message...]

ntroller listener throws error
   [junit4]   2> org.apache.solr.common.SolrException: Unable to reload core [testschemaapi_shard1_replica1]
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:945)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.lambda$getConfListener$6(SolrCore.java:2488)
   [junit4]   2> 	at org.apache.solr.cloud.ZkController$4.run(ZkController.java:2424)
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Could not find config name for collection:testschemaapi
   [junit4]   2> 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:772)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.reload(SolrCore.java:461)
   [junit4]   2> 	at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:939)
   [junit4]   2> 	... 2 more
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Could not find config name for collection:testschemaapi
   [junit4]   2> 	at org.apache.solr.rest.ManagedResourceStorage.newStorageIO(ManagedResourceStorage.java:101)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.initRestManager(SolrCore.java:2283)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.<init>(SolrCore.java:748)
   [junit4]   2> 	... 4 more
   [junit4]   2> Apr 17, 2016 8:24:49 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=Asserting(Lucene60): {_version_=Lucene50(blocksize=128), id=Lucene50(blocksize=128), myNewField1=Lucene50(blocksize=128), myNewField=PostingsFormat(name=Asserting)}, docValues:{}, maxPointsInLeafNode=1147, maxMBSortInHeap=6.548900399023592, sim=ClassicSimilarity, locale=pt-PT, timezone=NST
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=36651128,total=530055168
   [junit4]   2> NOTE: All tests run in this JVM: [DefaultValueUpdateProcessorTest, TestSolr4Spatial2, TestRealTimeGet, ExternalFileFieldSortTest, TestMacros, PreAnalyzedFieldTest, PreAnalyzedUpdateProcessorTest, TestManagedSynonymFilterFactory, CustomCollectionTest, ExplicitHLLTest, TestManagedSchema, TestSchemaVersionResource, QueryElevationComponentTest, TestConfigOverlay, TestPKIAuthenticationPlugin, PingRequestHandlerTest, FileBasedSpellCheckerTest, TestConfig, TestFieldResource, TestSolrCloudWithKerberosAlt, SystemInfoHandlerTest, HdfsChaosMonkeyNothingIsSafeTest, URLClassifyProcessorTest, BlockJoinFacetRandomTest, TestManagedResourceStorage, CloudMLTQParserTest, TestDocSet, TestPhraseSuggestions, CopyFieldTest, AtomicUpdatesTest, TestSchemaNameResource, CursorPagingTest, TestSolr4Spatial, LeaderInitiatedRecoveryOnShardRestartTest, DistributedFacetPivotSmallAdvancedTest, TestIBSimilarityFactory, CollectionTooManyReplicasTest, TestReRankQParserPlugin, CloudExitableDirectoryReaderTest, TestLazyCores, UUIDUpdateProcessorFallbackTest, IndexSchemaRuntimeFieldTest, TestSolrQueryResponse, HighlighterMaxOffsetTest, DistributedQueryElevationComponentTest, PolyFieldTest, AddBlockUpdateTest, TestComponentsName, DeleteReplicaTest, DisMaxRequestHandlerTest, TestHighFrequencyDictionaryFactory, OverseerRolesTest, TestCloudInspectUtil, TestRandomFaceting, PrimUtilsTest, TestUseDocValuesAsStored, SignatureUpdateProcessorFactoryTest, TestInfoStreamLogging, TestCryptoKeys, TestRequestStatusCollectionAPI, JSONWriterTest, TestOmitPositions, ResponseHeaderTest, SpatialRPTFieldTypeTest, TestBlendedInfixSuggestions, TestBadConfig, TestBinaryField, ActionThrottleTest, DocumentAnalysisRequestHandlerTest, OutOfBoxZkACLAndCredentialsProvidersTest, BufferStoreTest, TestReplicationHandler, TestLRUCache, TestReloadAndDeleteDocs, RestartWhileUpdatingTest, RAMDirectoryFactoryTest, ZkStateWriterTest, CurrencyFieldOpenExchangeTest, AnalyticsQueryTest, ResourceLoaderTest, TestMiniSolrCloudCluster, SyncSliceTest, BasicZkTest, SolrRequestParserTest, TestLMDirichletSimilarityFactory, TestMiniSolrCloudClusterSSL, TestQueryWrapperFilter, SuggestComponentTest, TestAnalyzedSuggestions, TestAtomicUpdateErrorCases, TestFunctionQuery, CacheHeaderTest, AlternateDirectoryTest, BasicDistributedZkTest, TestHighlightDedupGrouping, UnloadDistributedZkTest, OpenCloseCoreStressTest, OverseerTest, LeaderElectionIntegrationTest, ShardRoutingTest, ClusterStateUpdateTest, ZkSolrClientTest, TestZkChroot, ShardRoutingCustomTest, TestDistributedSearch, TestJoin, HardAutoCommitTest, DistributedTermsComponentTest, SpellCheckComponentTest, TestSort, BasicFunctionalityTest, TestIndexSearcher, ShowFileRequestHandlerTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, TestExtendedDismaxParser, SpellCheckCollatorTest, SuggesterFSTTest, SuggesterTest, SuggesterWFSTTest, TestCSVLoader, WordBreakSolrSpellCheckerTest, TestPseudoReturnFields, TestWordDelimiterFilterFactory, StatelessScriptUpdateProcessorFactoryTest, DistanceFunctionTest, SolrInfoMBeanTest, TestQueryUtils, StandardRequestHandlerTest, DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory, TermsComponentTest, XmlUpdateRequestHandlerTest, TestValueSourceCache, TestIndexingPerformance, RequiredFieldsTest, TestSolrQueryParser, FastVectorHighlighterTest, IndexSchemaTest, ReturnFieldsTest, JsonLoaderTest, TestPartialUpdateDeduplication, SearchHandlerTest, HighlighterConfigTest, SOLR749Test, UpdateParamsTest, ResponseLogComponentTest, TestStressRecovery, TestMergePolicyConfig, MultiTermTest, SampleTest, MinimalSchemaTest, TestElisionMultitermQuery, OutputWriterTest, TestFuzzyAnalyzedSuggestions, TestSolrCoreProperties, TestPostingsSolrHighlighter, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestCodecSupport, SynonymTokenizerTest, EchoParamsTest, TestLMJelinekMercerSimilarityFactory, TestJmxMonitoredMap, TimeZoneUtilsTest, TestFastOutputStream, ScriptEngineTest, DateMathParserTest, TestSystemIdResolver, TestSuggestSpellingConverter, DateFieldTest, DOMUtilTest, ClusterStateTest, TestUtils, ZkNodePropsTest, UUIDFieldTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, SolrTestCaseJ4Test, TestCrossCoreJoin, TestDistributedMissingSort, TestEmbeddedSolrServerConstructors, TestJettySolrRunner, AliasIntegrationTest, CdcrReplicationDistributedZkTest, CdcrReplicationHandlerTest, CdcrVersionReplicationTest, ConcurrentDeleteAndCreateCollectionTest, ConnectionManagerTest, DeleteShardTest, DistribDocExpirationUpdateProcessorTest, DistributedQueueTest, DistributedVersionInfoTest, LeaderFailoverAfterPartitionTest, OverseerTaskQueueTest, RecoveryAfterSoftCommitTest, SSLMigrationTest, SaslZkACLProviderTest, ShardSplitTest, TestTolerantUpdateProcessorRandomCloud, HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsTlogReplayBufferedWhileIndexingTest, StressHdfsTest, DirectoryFactoryTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, TestConfigSetProperties, TestConfigSets, TestInitParams, TestShardHandlerFactory, TestSolrConfigHandler, TestSolrDynamicMBean, TestSolrXml, RequestLoggingTest, TestBlobHandler, TestReplicationHandlerBackup, TestReqParamsAPI, TestRestoreCore, TestSQLHandler, TestSolrConfigHandlerConcurrent, CoreAdminCreateDiscoverTest, CoreAdminRequestStatusTest, CoreMergeIndexesAdminHandlerTest, InfoHandlerTest, SecurityConfHandlerTest, SegmentsInfoRequestHandlerTest, DistributedExpandComponentTest, DistributedFacetPivotLargeTest, DistributedFacetPivotSmallTest, DistributedQueryComponentCustomSortTest, TestPivotHelperCode, JavabinLoaderTest, WrapperMergePolicyFactoryTest, SmileWriterTest, TestCustomDocTransformer, TestGeoJSONResponseWriter, TestRawResponseWriter, TestRawTransformer, TestDynamicFieldCollectionResource, TestDynamicFieldResource, TestFieldCollectionResource, TestSchemaSimilarityResource, TestSolrQueryParserDefaultOperatorResource, TestSolrQueryParserResource, TestUniqueKeyFieldResource, DateRangeFieldTest, TestCollationFieldDocValues, TestManagedSchemaAPI]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestManagedSchemaAPI -Dtests.seed=487CCA24F7C674D7 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=pt-PT -Dtests.timezone=NST -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | TestManagedSchemaAPI (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [MockDirectoryWrapper]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([487CCA24F7C674D7]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:255)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [533/587 (3!)] on J0 in 15.47s, 1 test, 1 failure <<< FAILURES!

[...truncated 202 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/common-build.xml:529: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014: There were test failures: 587 suites (10 ignored), 2360 tests, 1 suite-level error, 1 error, 1 failure, 85 ignored (70 assumptions) [seed: 487CCA24F7C674D7]

Total time: 91 minutes 25 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any




[JENKINS] Lucene-Solr-Tests-master - Build # 1089 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1089/

1 tests failed.
FAILED:  org.apache.lucene.spatial3d.TestGeo3DPoint.testRandomMedium

Error Message:
FAIL: id=18625 should have matched but did not   shape=GeoWideRectangle: {planetmodel=PlanetModel.WGS84, toplat=0.3743498221665625(21.448664871616945), bottomlat=0.017453291479645996(0.9999999403953552), leftlon=0.017453291479645996(0.9999999403953552), rightlon=2.4457272005608357E-47(1.401298464324817E-45)}   world bounds=( minX=-1.0011188539924791 maxX=1.0011188539924791 minY=-1.0011188539924791 maxY=1.0011188539924791 minZ=-0.9977622920221051 maxZ=0.9977622920221051   quantized point=[X=1.000965351584433, Y=-2.3309114714909325E-10, Z=0.017471914977685885] within shape? true   unquantized point=[lat=0.017453292519943295, lon=-3.438381890243815E-255([X=1.000965351371868, Y=-3.441701136918568E-255, Z=0.017471915199092084])] within shape? true   docID=18532 deleted?=false   query=PointInGeo3DShapeQuery: field=point: Shape: GeoWideRectangle: {planetmodel=PlanetModel.WGS84, toplat=0.3743498221665625(21.448664871616945), bottomlat=0.017453291479645996(0.9999999403953552), leftlon=0.017453291479645996(0.9999999403953552), rightlon=2.4457272005608357E-47(1.401298464324817E-45)}   explanation:     target is in leaf _24(7.0.0):c251/1:delGen=1 of full reader StandardDirectoryReader(segments:214:nrt _r(7.0.0):c6198/78:delGen=1 _1h(7.0.0):c6259/51:delGen=1 _1f(7.0.0):c251/3:delGen=1 _1g(7.0.0):c251 _1i(7.0.0):c251 _1j(7.0.0):c251/2:delGen=1 _1k(7.0.0):c251/2:delGen=1 _1l(7.0.0):c251/3:delGen=1 _1m(7.0.0):c251/2:delGen=1 _1n(7.0.0):c251/1:delGen=1 _1o(7.0.0):c251/2:delGen=1 _1p(7.0.0):c251/1 _1q(7.0.0):c251 _1r(7.0.0):c251 _1s(7.0.0):c251 _1t(7.0.0):c251/1 _1u(7.0.0):c251/1 _1v(7.0.0):c251 _1w(7.0.0):c251/1 _1x(7.0.0):c251/2:delGen=1 _1y(7.0.0):c251/1 _1z(7.0.0):c251/1 _20(7.0.0):c251/1 _21(7.0.0):c251/1 _22(7.0.0):c251/1 _23(7.0.0):c251/1:delGen=1 _24(7.0.0):c251/1:delGen=1 _26(7.0.0):c251/1:delGen=1 _27(7.0.0):c251 _28(7.0.0):c251 _29(7.0.0):c251 _2a(7.0.0):c251 _2b(7.0.0):c251 _2c(7.0.0):c251 _2d(7.0.0):c251 _2e(7.0.0):c251/1:delGen=1 _2f(7.0.0):c251/1:delGen=1 _2g(7.0.0):c251/1 _2h(7.0.0):c251 _2i(7.0.0):c251 _2j(7.0.0):c251 _2k(7.0.0):c251/2:delGen=1 _2l(7.0.0):c251 _2m(7.0.0):c251 _2n(7.0.0):c251 _2o(7.0.0):c251 _2p(7.0.0):c251 _2q(7.0.0):c251/1:delGen=1 _2r(7.0.0):c251 _2s(7.0.0):c251 _2u(7.0.0):c251 _2v(7.0.0):c251 _2w(7.0.0):c34)     full BKD path to target doc:       Cell(x=-1.001096807299417 TO 1.0011188539924791 y=-1.0010837504657184 TO 1.0010480273826885 z=-0.997762292058209 TO 0.9977622920582089); Shape relationship = WITHIN; Quantized point within cell = true; Unquantized point within cell = true     on cell Cell(x=-1.001096807299417 TO 1.0011188539924791 y=-1.0010837504657184 TO 1.0010480273826885 z=-0.997762292058209 TO 0.9977622920582089); Shape relationship = WITHIN; Quantized point within cell = true; Unquantized point within cell = true, wrapped visitor returned CELL_CROSSES_QUERY   leaf visit docID=51 x=1.000965351584433 y=-2.3309114714909325E-10 z=0.017471914977685885   

Stack Trace:
java.lang.AssertionError: FAIL: id=18625 should have matched but did not
  shape=GeoWideRectangle: {planetmodel=PlanetModel.WGS84, toplat=0.3743498221665625(21.448664871616945), bottomlat=0.017453291479645996(0.9999999403953552), leftlon=0.017453291479645996(0.9999999403953552), rightlon=2.4457272005608357E-47(1.401298464324817E-45)}
  world bounds=( minX=-1.0011188539924791 maxX=1.0011188539924791 minY=-1.0011188539924791 maxY=1.0011188539924791 minZ=-0.9977622920221051 maxZ=0.9977622920221051
  quantized point=[X=1.000965351584433, Y=-2.3309114714909325E-10, Z=0.017471914977685885] within shape? true
  unquantized point=[lat=0.017453292519943295, lon=-3.438381890243815E-255([X=1.000965351371868, Y=-3.441701136918568E-255, Z=0.017471915199092084])] within shape? true
  docID=18532 deleted?=false
  query=PointInGeo3DShapeQuery: field=point: Shape: GeoWideRectangle: {planetmodel=PlanetModel.WGS84, toplat=0.3743498221665625(21.448664871616945), bottomlat=0.017453291479645996(0.9999999403953552), leftlon=0.017453291479645996(0.9999999403953552), rightlon=2.4457272005608357E-47(1.401298464324817E-45)}
  explanation:
    target is in leaf _24(7.0.0):c251/1:delGen=1 of full reader StandardDirectoryReader(segments:214:nrt _r(7.0.0):c6198/78:delGen=1 _1h(7.0.0):c6259/51:delGen=1 _1f(7.0.0):c251/3:delGen=1 _1g(7.0.0):c251 _1i(7.0.0):c251 _1j(7.0.0):c251/2:delGen=1 _1k(7.0.0):c251/2:delGen=1 _1l(7.0.0):c251/3:delGen=1 _1m(7.0.0):c251/2:delGen=1 _1n(7.0.0):c251/1:delGen=1 _1o(7.0.0):c251/2:delGen=1 _1p(7.0.0):c251/1 _1q(7.0.0):c251 _1r(7.0.0):c251 _1s(7.0.0):c251 _1t(7.0.0):c251/1 _1u(7.0.0):c251/1 _1v(7.0.0):c251 _1w(7.0.0):c251/1 _1x(7.0.0):c251/2:delGen=1 _1y(7.0.0):c251/1 _1z(7.0.0):c251/1 _20(7.0.0):c251/1 _21(7.0.0):c251/1 _22(7.0.0):c251/1 _23(7.0.0):c251/1:delGen=1 _24(7.0.0):c251/1:delGen=1 _26(7.0.0):c251/1:delGen=1 _27(7.0.0):c251 _28(7.0.0):c251 _29(7.0.0):c251 _2a(7.0.0):c251 _2b(7.0.0):c251 _2c(7.0.0):c251 _2d(7.0.0):c251 _2e(7.0.0):c251/1:delGen=1 _2f(7.0.0):c251/1:delGen=1 _2g(7.0.0):c251/1 _2h(7.0.0):c251 _2i(7.0.0):c251 _2j(7.0.0):c251 _2k(7.0.0):c251/2:delGen=1 _2l(7.0.0):c251 _2m(7.0.0):c251 _2n(7.0.0):c251 _2o(7.0.0):c251 _2p(7.0.0):c251 _2q(7.0.0):c251/1:delGen=1 _2r(7.0.0):c251 _2s(7.0.0):c251 _2u(7.0.0):c251 _2v(7.0.0):c251 _2w(7.0.0):c34)
    full BKD path to target doc:
      Cell(x=-1.001096807299417 TO 1.0011188539924791 y=-1.0010837504657184 TO 1.0010480273826885 z=-0.997762292058209 TO 0.9977622920582089); Shape relationship = WITHIN; Quantized point within cell = true; Unquantized point within cell = true
    on cell Cell(x=-1.001096807299417 TO 1.0011188539924791 y=-1.0010837504657184 TO 1.0010480273826885 z=-0.997762292058209 TO 0.9977622920582089); Shape relationship = WITHIN; Quantized point within cell = true; Unquantized point within cell = true, wrapped visitor returned CELL_CROSSES_QUERY
  leaf visit docID=51 x=1.000965351584433 y=-2.3309114714909325E-10 z=0.017471914977685885
  
	at __randomizedtesting.SeedInfo.seed([16F57BB108DD159E:AB2B4C1949B876F8]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.lucene.spatial3d.TestGeo3DPoint.verify(TestGeo3DPoint.java:814)
	at org.apache.lucene.spatial3d.TestGeo3DPoint.doTestRandom(TestGeo3DPoint.java:524)
	at org.apache.lucene.spatial3d.TestGeo3DPoint.testRandomMedium(TestGeo3DPoint.java:451)
	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 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 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 8917 lines...]
   [junit4] Suite: org.apache.lucene.spatial3d.TestGeo3DPoint
   [junit4] IGNOR/A 0.01s J1 | TestGeo3DPoint.testRandomBig
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestGeo3DPoint -Dtests.method=testRandomMedium -Dtests.seed=16F57BB108DD159E -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=uk-UA -Dtests.timezone=Asia/Thimbu -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 7.11s J1 | TestGeo3DPoint.testRandomMedium <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: FAIL: id=18625 should have matched but did not
   [junit4]    >   shape=GeoWideRectangle: {planetmodel=PlanetModel.WGS84, toplat=0.3743498221665625(21.448664871616945), bottomlat=0.017453291479645996(0.9999999403953552), leftlon=0.017453291479645996(0.9999999403953552), rightlon=2.4457272005608357E-47(1.401298464324817E-45)}
   [junit4]    >   world bounds=( minX=-1.0011188539924791 maxX=1.0011188539924791 minY=-1.0011188539924791 maxY=1.0011188539924791 minZ=-0.9977622920221051 maxZ=0.9977622920221051
   [junit4]    >   quantized point=[X=1.000965351584433, Y=-2.3309114714909325E-10, Z=0.017471914977685885] within shape? true
   [junit4]    >   unquantized point=[lat=0.017453292519943295, lon=-3.438381890243815E-255([X=1.000965351371868, Y=-3.441701136918568E-255, Z=0.017471915199092084])] within shape? true
   [junit4]    >   docID=18532 deleted?=false
   [junit4]    >   query=PointInGeo3DShapeQuery: field=point: Shape: GeoWideRectangle: {planetmodel=PlanetModel.WGS84, toplat=0.3743498221665625(21.448664871616945), bottomlat=0.017453291479645996(0.9999999403953552), leftlon=0.017453291479645996(0.9999999403953552), rightlon=2.4457272005608357E-47(1.401298464324817E-45)}
   [junit4]    >   explanation:
   [junit4]    >     target is in leaf _24(7.0.0):c251/1:delGen=1 of full reader StandardDirectoryReader(segments:214:nrt _r(7.0.0):c6198/78:delGen=1 _1h(7.0.0):c6259/51:delGen=1 _1f(7.0.0):c251/3:delGen=1 _1g(7.0.0):c251 _1i(7.0.0):c251 _1j(7.0.0):c251/2:delGen=1 _1k(7.0.0):c251/2:delGen=1 _1l(7.0.0):c251/3:delGen=1 _1m(7.0.0):c251/2:delGen=1 _1n(7.0.0):c251/1:delGen=1 _1o(7.0.0):c251/2:delGen=1 _1p(7.0.0):c251/1 _1q(7.0.0):c251 _1r(7.0.0):c251 _1s(7.0.0):c251 _1t(7.0.0):c251/1 _1u(7.0.0):c251/1 _1v(7.0.0):c251 _1w(7.0.0):c251/1 _1x(7.0.0):c251/2:delGen=1 _1y(7.0.0):c251/1 _1z(7.0.0):c251/1 _20(7.0.0):c251/1 _21(7.0.0):c251/1 _22(7.0.0):c251/1 _23(7.0.0):c251/1:delGen=1 _24(7.0.0):c251/1:delGen=1 _26(7.0.0):c251/1:delGen=1 _27(7.0.0):c251 _28(7.0.0):c251 _29(7.0.0):c251 _2a(7.0.0):c251 _2b(7.0.0):c251 _2c(7.0.0):c251 _2d(7.0.0):c251 _2e(7.0.0):c251/1:delGen=1 _2f(7.0.0):c251/1:delGen=1 _2g(7.0.0):c251/1 _2h(7.0.0):c251 _2i(7.0.0):c251 _2j(7.0.0):c251 _2k(7.0.0):c251/2:delGen=1 _2l(7.0.0):c251 _2m(7.0.0):c251 _2n(7.0.0):c251 _2o(7.0.0):c251 _2p(7.0.0):c251 _2q(7.0.0):c251/1:delGen=1 _2r(7.0.0):c251 _2s(7.0.0):c251 _2u(7.0.0):c251 _2v(7.0.0):c251 _2w(7.0.0):c34)
   [junit4]    >     full BKD path to target doc:
   [junit4]    >       Cell(x=-1.001096807299417 TO 1.0011188539924791 y=-1.0010837504657184 TO 1.0010480273826885 z=-0.997762292058209 TO 0.9977622920582089); Shape relationship = WITHIN; Quantized point within cell = true; Unquantized point within cell = true
   [junit4]    >     on cell Cell(x=-1.001096807299417 TO 1.0011188539924791 y=-1.0010837504657184 TO 1.0010480273826885 z=-0.997762292058209 TO 0.9977622920582089); Shape relationship = WITHIN; Quantized point within cell = true; Unquantized point within cell = true, wrapped visitor returned CELL_CROSSES_QUERY
   [junit4]    >   leaf visit docID=51 x=1.000965351584433 y=-2.3309114714909325E-10 z=0.017471914977685885
   [junit4]    >   
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([16F57BB108DD159E:AB2B4C1949B876F8]:0)
   [junit4]    > 	at org.apache.lucene.spatial3d.TestGeo3DPoint.verify(TestGeo3DPoint.java:814)
   [junit4]    > 	at org.apache.lucene.spatial3d.TestGeo3DPoint.doTestRandom(TestGeo3DPoint.java:524)
   [junit4]    > 	at org.apache.lucene.spatial3d.TestGeo3DPoint.testRandomMedium(TestGeo3DPoint.java:451)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): {id=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{id=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=324, maxMBSortInHeap=5.195186095909932, sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=uk-UA, timezone=Asia/Thimbu
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=208803288,total=351272960
   [junit4]   2> NOTE: All tests run in this JVM: [TestGeo3DPoint]
   [junit4] Completed [10/10 (1!)] on J1 in 29.40s, 13 tests, 1 failure, 1 skipped <<< FAILURES!

[...truncated 11 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build.xml:476: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:2187: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/module-build.xml:58: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014: There were test failures: 10 suites, 47 tests, 1 failure, 1 ignored (1 assumption) [seed: 16F57BB108DD159E]

Total time: 37 minutes 21 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any




Re: [JENKINS] Lucene-Solr-Tests-master - Build # 1088 - Still Failing

Posted by Robert Muir <rc...@gmail.com>.
it happens due to underflow (in this case the line is 1E-308 long and
so on, so the multiply blows it away). I committed a fix.

On Mon, Apr 18, 2016 at 7:28 AM, Apache Jenkins Server
<je...@builds.apache.org> wrote:
> Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1088/
>
> 1 tests failed.
> FAILED:  org.apache.lucene.geo.TestPolygon.testIntersectRandom
>
> Error Message:
> invalid latitude NaN; must be between -90.0 and 90.0
>
> Stack Trace:
> java.lang.IllegalArgumentException: invalid latitude NaN; must be between -90.0 and 90.0
>         at __randomizedtesting.SeedInfo.seed([5F4B62851AF7D0EA:BB2613C1230F3056]:0)
>         at org.apache.lucene.geo.GeoUtils.checkLatitude(GeoUtils.java:62)
>         at org.apache.lucene.geo.GeoTestUtil.nextLatitudeNear(GeoTestUtil.java:108)
>         at org.apache.lucene.geo.GeoTestUtil.nextPointAroundLine(GeoTestUtil.java:202)
>         at org.apache.lucene.geo.GeoTestUtil.nextPointNear(GeoTestUtil.java:257)
>         at org.apache.lucene.geo.GeoTestUtil.nextPointNear(GeoTestUtil.java:216)
>         at org.apache.lucene.geo.TestPolygon.testIntersectRandom(TestPolygon.java:226)
>         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 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 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 1368 lines...]
>    [junit4] Suite: org.apache.lucene.geo.TestPolygon
>    [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestPolygon -Dtests.method=testIntersectRandom -Dtests.seed=5F4B62851AF7D0EA -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-NZ -Dtests.timezone=Pacific/Majuro -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
>    [junit4] ERROR   16.4s J0 | TestPolygon.testIntersectRandom <<<
>    [junit4]    > Throwable #1: java.lang.IllegalArgumentException: invalid latitude NaN; must be between -90.0 and 90.0
>    [junit4]    >        at __randomizedtesting.SeedInfo.seed([5F4B62851AF7D0EA:BB2613C1230F3056]:0)
>    [junit4]    >        at org.apache.lucene.geo.GeoUtils.checkLatitude(GeoUtils.java:62)
>    [junit4]    >        at org.apache.lucene.geo.GeoTestUtil.nextLatitudeNear(GeoTestUtil.java:108)
>    [junit4]    >        at org.apache.lucene.geo.GeoTestUtil.nextPointAroundLine(GeoTestUtil.java:202)
>    [junit4]    >        at org.apache.lucene.geo.GeoTestUtil.nextPointNear(GeoTestUtil.java:257)
>    [junit4]    >        at org.apache.lucene.geo.GeoTestUtil.nextPointNear(GeoTestUtil.java:216)
>    [junit4]    >        at org.apache.lucene.geo.TestPolygon.testIntersectRandom(TestPolygon.java:226)
>    [junit4]    >        at java.lang.Thread.run(Thread.java:745)
>    [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60), sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=en-NZ, timezone=Pacific/Majuro
>    [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=144946664,total=362807296
>    [junit4]   2> NOTE: All tests run in this JVM: [TestSubScorerFreqs, TestSpanNotQuery, TestSegmentInfos, TestIndexWriterForceMerge, TestReusableStringReader, TestDocValuesIndexing, TestBlockPostingsFormat2, TestBytesRefArray, TestLucene50StoredFieldsFormat, TestShardSearching, TestTimeLimitingCollector, TestDirectMonotonic, Test4GBStoredFields, TestIsCurrent, TestCustomNorms, TestThreadedForceMerge, TestMultiFields, TestNeverDelete, TestBooleanQueryVisitSubscorers, TestFieldType, TestRegexpRandom, TestMultiCollector, Test2BSortedDocValuesOrds, TestUnicodeUtil, TestSloppyPhraseQuery2, TestLucene50CompoundFormat, TestBinaryDocument, TestLockFactory, TestAllFilesHaveChecksumFooter, TestNGramPhraseQuery, TestSpanCollection, TestDeterminizeLexicon, TestNoDeletionPolicy, TestTermScorer, TestMultiTermQueryRewrites, Test2BTerms, TestLRUQueryCache, TestNeedsScores, TestMinimize, TestWeakIdentityMap, TestTerm, TestParallelCompositeReader, TestNewestSegment, TestTragicIndexWriterDeadlock, TestDeletionPolicy, TestMultiValuedNumericRangeQuery, TestSynonymQuery, TestClassicSimilarity, TestBooleanMinShouldMatch, FuzzyTermOnShortTermsTest, TestLucene53NormsFormat, TestHighCompressionMode, TestLSBRadixSorter, TestDeterminism, TestCodecs, TestMultiTermConstantScore, TestUTF32ToUTF8, TestSentinelIntSet, TestDateSort, TestRateLimiter, TestTermVectorsWriter, TestIndexWriterDelete, TestTermRangeQuery, TestFieldReuse, TestFixedBitDocIdSet, TestFilterIterator, TestNumericRangeQuery64, TestAutomaton, TestSwappedIndexFiles, TestIndexWriter, TestIndexWriterMerging, TestIndexWriterWithThreads, TestNumericRangeQuery32, TestIndexWriterExceptions, TestIndexWriterMergePolicy, TestPersistentSnapshotDeletionPolicy, TestIndexWriterCommit, TestDirectoryReaderReopen, TestConcurrentMergeScheduler, TestDocumentsWriterStallControl, TestStressIndexing, TestRollingUpdates, TestSnapshotDeletionPolicy, TestIndexWriterUnicode, TestTermsEnum, TestBlockPostingsFormat, TestForUtil, TestLucene50SegmentInfoFormat, TestPolygon]
>    [junit4] Completed [353/419 (1!)] on J0 in 59.47s, 16 tests, 1 error <<< FAILURES!
>
> [...truncated 233 lines...]
> BUILD FAILED
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The following error occurred while executing this line:
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The following error occurred while executing this line:
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error occurred while executing this line:
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build.xml:50: The following error occurred while executing this line:
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457: The following error occurred while executing this line:
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014: There were test failures: 419 suites (1 ignored), 3501 tests, 1 error, 64 ignored (60 assumptions) [seed: 5F4B62851AF7D0EA]
>
> Total time: 11 minutes 58 seconds
> Build step 'Invoke Ant' marked build as failure
> Archiving artifacts
> Recording test results
> Email was triggered for: Failure - Any
> Sending email for trigger: Failure - Any
>
>
>
>
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
> For additional commands, e-mail: dev-help@lucene.apache.org

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org


[JENKINS] Lucene-Solr-Tests-master - Build # 1088 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1088/

1 tests failed.
FAILED:  org.apache.lucene.geo.TestPolygon.testIntersectRandom

Error Message:
invalid latitude NaN; must be between -90.0 and 90.0

Stack Trace:
java.lang.IllegalArgumentException: invalid latitude NaN; must be between -90.0 and 90.0
	at __randomizedtesting.SeedInfo.seed([5F4B62851AF7D0EA:BB2613C1230F3056]:0)
	at org.apache.lucene.geo.GeoUtils.checkLatitude(GeoUtils.java:62)
	at org.apache.lucene.geo.GeoTestUtil.nextLatitudeNear(GeoTestUtil.java:108)
	at org.apache.lucene.geo.GeoTestUtil.nextPointAroundLine(GeoTestUtil.java:202)
	at org.apache.lucene.geo.GeoTestUtil.nextPointNear(GeoTestUtil.java:257)
	at org.apache.lucene.geo.GeoTestUtil.nextPointNear(GeoTestUtil.java:216)
	at org.apache.lucene.geo.TestPolygon.testIntersectRandom(TestPolygon.java:226)
	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 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 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 1368 lines...]
   [junit4] Suite: org.apache.lucene.geo.TestPolygon
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestPolygon -Dtests.method=testIntersectRandom -Dtests.seed=5F4B62851AF7D0EA -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-NZ -Dtests.timezone=Pacific/Majuro -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   16.4s J0 | TestPolygon.testIntersectRandom <<<
   [junit4]    > Throwable #1: java.lang.IllegalArgumentException: invalid latitude NaN; must be between -90.0 and 90.0
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([5F4B62851AF7D0EA:BB2613C1230F3056]:0)
   [junit4]    > 	at org.apache.lucene.geo.GeoUtils.checkLatitude(GeoUtils.java:62)
   [junit4]    > 	at org.apache.lucene.geo.GeoTestUtil.nextLatitudeNear(GeoTestUtil.java:108)
   [junit4]    > 	at org.apache.lucene.geo.GeoTestUtil.nextPointAroundLine(GeoTestUtil.java:202)
   [junit4]    > 	at org.apache.lucene.geo.GeoTestUtil.nextPointNear(GeoTestUtil.java:257)
   [junit4]    > 	at org.apache.lucene.geo.GeoTestUtil.nextPointNear(GeoTestUtil.java:216)
   [junit4]    > 	at org.apache.lucene.geo.TestPolygon.testIntersectRandom(TestPolygon.java:226)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60), sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=en-NZ, timezone=Pacific/Majuro
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=144946664,total=362807296
   [junit4]   2> NOTE: All tests run in this JVM: [TestSubScorerFreqs, TestSpanNotQuery, TestSegmentInfos, TestIndexWriterForceMerge, TestReusableStringReader, TestDocValuesIndexing, TestBlockPostingsFormat2, TestBytesRefArray, TestLucene50StoredFieldsFormat, TestShardSearching, TestTimeLimitingCollector, TestDirectMonotonic, Test4GBStoredFields, TestIsCurrent, TestCustomNorms, TestThreadedForceMerge, TestMultiFields, TestNeverDelete, TestBooleanQueryVisitSubscorers, TestFieldType, TestRegexpRandom, TestMultiCollector, Test2BSortedDocValuesOrds, TestUnicodeUtil, TestSloppyPhraseQuery2, TestLucene50CompoundFormat, TestBinaryDocument, TestLockFactory, TestAllFilesHaveChecksumFooter, TestNGramPhraseQuery, TestSpanCollection, TestDeterminizeLexicon, TestNoDeletionPolicy, TestTermScorer, TestMultiTermQueryRewrites, Test2BTerms, TestLRUQueryCache, TestNeedsScores, TestMinimize, TestWeakIdentityMap, TestTerm, TestParallelCompositeReader, TestNewestSegment, TestTragicIndexWriterDeadlock, TestDeletionPolicy, TestMultiValuedNumericRangeQuery, TestSynonymQuery, TestClassicSimilarity, TestBooleanMinShouldMatch, FuzzyTermOnShortTermsTest, TestLucene53NormsFormat, TestHighCompressionMode, TestLSBRadixSorter, TestDeterminism, TestCodecs, TestMultiTermConstantScore, TestUTF32ToUTF8, TestSentinelIntSet, TestDateSort, TestRateLimiter, TestTermVectorsWriter, TestIndexWriterDelete, TestTermRangeQuery, TestFieldReuse, TestFixedBitDocIdSet, TestFilterIterator, TestNumericRangeQuery64, TestAutomaton, TestSwappedIndexFiles, TestIndexWriter, TestIndexWriterMerging, TestIndexWriterWithThreads, TestNumericRangeQuery32, TestIndexWriterExceptions, TestIndexWriterMergePolicy, TestPersistentSnapshotDeletionPolicy, TestIndexWriterCommit, TestDirectoryReaderReopen, TestConcurrentMergeScheduler, TestDocumentsWriterStallControl, TestStressIndexing, TestRollingUpdates, TestSnapshotDeletionPolicy, TestIndexWriterUnicode, TestTermsEnum, TestBlockPostingsFormat, TestForUtil, TestLucene50SegmentInfoFormat, TestPolygon]
   [junit4] Completed [353/419 (1!)] on J0 in 59.47s, 16 tests, 1 error <<< FAILURES!

[...truncated 233 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build.xml:50: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014: There were test failures: 419 suites (1 ignored), 3501 tests, 1 error, 64 ignored (60 assumptions) [seed: 5F4B62851AF7D0EA]

Total time: 11 minutes 58 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any




[JENKINS] Lucene-Solr-Tests-master - Build # 1087 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1087/

1 tests failed.
FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test

Error Message:
replicaCount expected:<0> but was:<1>

Stack Trace:
java.lang.AssertionError: replicaCount expected:<0> but was:<1>
	at __randomizedtesting.SeedInfo.seed([72BD83A95AE7C852:FAE9BC73F41BA5AA]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testNoConfigSetExist(CollectionsAPIDistributedZkTest.java:602)
	at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:167)
	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 org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
	at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
	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 15 lines...]
ERROR: Error fetching remote repo 'origin'
hudson.plugins.git.GitException: Failed to fetch from git://git.apache.org/lucene-solr.git
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:766)
	at hudson.plugins.git.GitSCM.retrieveChanges(GitSCM.java:1022)
	at hudson.plugins.git.GitSCM.checkout(GitSCM.java:1053)
	at hudson.scm.SCM.checkout(SCM.java:485)
	at hudson.model.AbstractProject.checkout(AbstractProject.java:1276)
	at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:607)
	at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:529)
	at hudson.model.Run.execute(Run.java:1738)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:98)
	at hudson.model.Executor.run(Executor.java:410)
Caused by: hudson.plugins.git.GitException: Command "git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*" returned status code 128:
stdout: 
stderr: fatal: read error: Connection reset by peer

	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1693)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandWithCredentials(CliGitAPIImpl.java:1441)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.access$300(CliGitAPIImpl.java:62)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl$1.execute(CliGitAPIImpl.java:313)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:152)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:145)
	at hudson.remoting.UserRequest.perform(UserRequest.java:120)
	at hudson.remoting.UserRequest.perform(UserRequest.java:48)
	at hudson.remoting.Request$2.run(Request.java:326)
	at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:68)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:745)
	at ......remote call to lucene(Native Method)
	at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1416)
	at hudson.remoting.UserResponse.retrieve(UserRequest.java:220)
	at hudson.remoting.Channel.call(Channel.java:781)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.execute(RemoteGitImpl.java:145)
	at sun.reflect.GeneratedMethodAccessor447.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.invoke(RemoteGitImpl.java:131)
	at com.sun.proxy.$Proxy116.execute(Unknown Source)
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:764)
	... 11 more
ERROR: null
Retrying after 10 seconds
 > git rev-parse --is-inside-work-tree # timeout=10
Fetching changes from the remote Git repository
 > git config remote.origin.url git://git.apache.org/lucene-solr.git # timeout=10
Cleaning workspace
 > git rev-parse --verify HEAD # timeout=10
Resetting working tree
 > git reset --hard # timeout=10
 > git clean -fdx # timeout=10
Fetching upstream changes from git://git.apache.org/lucene-solr.git
 > git --version # timeout=10
 > git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*
ERROR: Error fetching remote repo 'origin'
hudson.plugins.git.GitException: Failed to fetch from git://git.apache.org/lucene-solr.git
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:766)
	at hudson.plugins.git.GitSCM.retrieveChanges(GitSCM.java:1022)
	at hudson.plugins.git.GitSCM.checkout(GitSCM.java:1053)
	at hudson.scm.SCM.checkout(SCM.java:485)
	at hudson.model.AbstractProject.checkout(AbstractProject.java:1276)
	at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:607)
	at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:529)
	at hudson.model.Run.execute(Run.java:1738)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:98)
	at hudson.model.Executor.run(Executor.java:410)
Caused by: hudson.plugins.git.GitException: Command "git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*" returned status code 128:
stdout: 
stderr: fatal: read error: Connection reset by peer

	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1693)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandWithCredentials(CliGitAPIImpl.java:1441)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.access$300(CliGitAPIImpl.java:62)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl$1.execute(CliGitAPIImpl.java:313)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:152)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:145)
	at hudson.remoting.UserRequest.perform(UserRequest.java:120)
	at hudson.remoting.UserRequest.perform(UserRequest.java:48)
	at hudson.remoting.Request$2.run(Request.java:326)
	at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:68)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:745)
	at ......remote call to lucene(Native Method)
	at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1416)
	at hudson.remoting.UserResponse.retrieve(UserRequest.java:220)
	at hudson.remoting.Channel.call(Channel.java:781)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.execute(RemoteGitImpl.java:145)
	at sun.reflect.GeneratedMethodAccessor447.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.invoke(RemoteGitImpl.java:131)
	at com.sun.proxy.$Proxy116.execute(Unknown Source)
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:764)
	... 11 more
ERROR: null
Retrying after 10 seconds
 > git rev-parse --is-inside-work-tree # timeout=10
Fetching changes from the remote Git repository
 > git config remote.origin.url git://git.apache.org/lucene-solr.git # timeout=10
Cleaning workspace
 > git rev-parse --verify HEAD # timeout=10
Resetting working tree
 > git reset --hard # timeout=10
 > git clean -fdx # timeout=10
Fetching upstream changes from git://git.apache.org/lucene-solr.git
 > git --version # timeout=10
 > git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*
 > git rev-parse refs/remotes/origin/master^{commit} # timeout=10
 > git rev-parse refs/remotes/origin/origin/master^{commit} # timeout=10
Checking out Revision aafdc372d98ec9e170501ed2fef91db892c6368f (refs/remotes/origin/master)
 > git config core.sparsecheckout # timeout=10
 > git checkout -f aafdc372d98ec9e170501ed2fef91db892c6368f
 > git rev-list 727852fb7823e3147e38e7a87055129acfd60e39 # timeout=10
No emails were triggered.
[Lucene-Solr-Tests-master] $ /home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/bin/ant jenkins-hourly
Buildfile: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml

jenkins-hourly:

-print-java-info:
[java-info] java version "1.8.0_74"
[java-info] Java(TM) SE Runtime Environment (1.8.0_74-b02, Oracle Corporation)
[java-info] Java HotSpot(TM) 64-Bit Server VM (25.74-b02, Oracle Corporation)
[java-info] Test args: []

clean:

clean:

clean:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: Apache Ivy 2.3.0 - 20130110142753 :: http://ant.apache.org/ivy/ ::
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/ivy-settings.xml

resolve-groovy:
[ivy:cachepath] :: resolving dependencies :: org.codehaus.groovy#groovy-all-caller;working
[ivy:cachepath] 	confs: [default]
[ivy:cachepath] 	found org.codehaus.groovy#groovy-all;2.4.6 in public
[ivy:cachepath] :: resolution report :: resolve 359ms :: artifacts dl 14ms
	---------------------------------------------------------------------
	|                  |            modules            ||   artifacts   |
	|       conf       | number| search|dwnlded|evicted|| number|dwnlded|
	---------------------------------------------------------------------
	|      default     |   1   |   0   |   0   |   0   ||   1   |   0   |
	---------------------------------------------------------------------

-test-with-heapdumps-enabled:
     [echo] Java HotSpot(TM) 64-Bit Server VM: Enabling heap dumps on OutOfMemoryError to dir '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/heapdumps'.
    [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/heapdumps

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/ivy-settings.xml

resolve-groovy:

test:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/ivy-settings.xml

-clover.load:

resolve-groovy:

-init-totals:

test-core:

-clover.disable:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/ivy-settings.xml

-clover.load:

-clover.classpath:

-clover.setup:

clover:

-check-git-state:

-git-cleanroot:

-copy-git-state:
     [copy] Copying 1 file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build

git-autoclean:

resolve:

init:

compile-core:
    [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java
    [javac] Compiling 753 source files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/document/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/util/bkd/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/util/packed/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/util/mutable/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/codecs/compressing/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene60/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/codecs/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/codecs/perfield/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/util/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/analysis/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/index/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/store/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/codecs/blocktree/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/util/fst/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/search/spans/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/analysis/tokenattributes/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene54/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/search/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/search/similarities/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/util/automaton/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene53/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/codecs/lucene50/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java/org/apache/lucene/geo/package-info.class
     [copy] Copying 3 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/java

compile-test-framework:

-check-git-state:

-git-cleanroot:

-copy-git-state:

git-autoclean:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/ivy-settings.xml

resolve:

init:

compile-lucene-core:

-check-git-state:

-git-cleanroot:

-copy-git-state:

git-autoclean:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/ivy-settings.xml

resolve:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:

compile-codecs:

-check-git-state:

-git-cleanroot:

-copy-git-state:

git-autoclean:

ivy-availability-check:

ivy-fail:

ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/ivy-settings.xml

resolve:

common.init:

compile-lucene-core:

init:

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

compile-core:
    [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java
    [javac] Compiling 68 source files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java/org/apache/lucene/codecs/bloom/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java/org/apache/lucene/codecs/memory/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java/org/apache/lucene/codecs/simpletext/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java/org/apache/lucene/codecs/blockterms/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java/org/apache/lucene/codecs/blocktreeords/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java/org/apache/lucene/codecs/autoprefix/package-info.class
     [copy] Copying 3 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/codecs/classes/java

-clover.disable:

-clover.load:

-clover.classpath:

-clover.setup:

clover:

common.compile-core:
    [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java
    [javac] Compiling 181 source files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java/org/apache/lucene/codecs/asserting/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java/org/apache/lucene/codecs/ramonly/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java/org/apache/lucene/mockfile/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java/org/apache/lucene/codecs/cheapbastard/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java/org/apache/lucene/codecs/mockrandom/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java/org/apache/lucene/codecs/cranky/package-info.class
    [javac] Creating empty /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java/org/apache/lucene/codecs/compressing/dummy/package-info.class
     [copy] Copying 4 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/test-framework/classes/java

compile-core:

compile-test:
    [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/test
    [javac] Compiling 426 source files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/test
    [javac] Note: Some input files use or override a deprecated API.
    [javac] Note: Recompile with -Xlint:deprecation for details.
     [copy] Copying 3 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/classes/test

install-junit4-taskdef:

validate:

resolve-groovy:

-init-totals:

-test:
    [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/test
[loadresource] Do not set property tests.explicitclass as its length is 0.
    [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/build/core/test/temp
    [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/.caches/test-stats/core
   [junit4] <JUnit4> says aloha! Master seed: FD91BA62B886069F
   [junit4] Executing 419 suites with 3 JVMs.
   [junit4] 
   [junit4] Started J0 PID(18295@localhost).
   [junit4] Started J2 PID(18289@localhost).
   [junit4] Started J1 PID(18309@localhost).
   [junit4] Suite: org.apache.lucene.TestSearch
   [junit4] Completed [1/419] on J2 in 2.10s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCodecUtil
   [junit4] Completed [2/419] on J2 in 0.25s, 15 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterConfig
   [junit4] Completed [3/419] on J2 in 0.70s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDocBoost
   [junit4] Completed [4/419] on J2 in 0.48s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.LimitedFiniteStringsIteratorTest
   [junit4] Completed [5/419] on J2 in 0.82s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestFilterDirectory
   [junit4] IGNOR/A 0.03s J2 | TestFilterDirectory.testFsyncDoesntCreateNewFiles
   [junit4]    > Assumption #1: test only works for FSDirectory subclasses
   [junit4] IGNOR/A 0.02s J2 | TestFilterDirectory.testPendingDeletions
   [junit4]    > Assumption #1: we can only install VirusCheckingFS on an FSDirectory
   [junit4] Completed [6/419] on J2 in 2.69s, 47 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPhraseQuery
   [junit4] Completed [7/419] on J0 in 10.92s, 21 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimpleExplanations
   [junit4] Completed [8/419] on J1 in 11.06s, 68 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestByteArrayDataInput
   [junit4] Completed [9/419] on J1 in 0.16s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanCollection
   [junit4] Completed [10/419] on J0 in 0.80s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNGramPhraseQuery
   [junit4] Completed [11/419] on J0 in 0.12s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiValuedNumericRangeQuery
   [junit4] Completed [12/419] on J0 in 4.97s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDuelingCodecsAtNight
   [junit4] IGNOR/A 0.01s J0 | TestDuelingCodecsAtNight.testCrazyReaderEquals
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] IGNOR/A 0.01s J0 | TestDuelingCodecsAtNight.testEquals
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] IGNOR/A 0.00s J0 | TestDuelingCodecsAtNight.testBigEquals
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [13/419] on J0 in 0.08s, 3 tests, 3 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestLongPostings
   [junit4] Completed [14/419] on J2 in 11.44s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestMergedIterator
   [junit4] Completed [15/419] on J0 in 1.86s, 25 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCodecHoldsOpenFiles
   [junit4] Completed [16/419] on J2 in 0.42s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestScorerPerf
   [junit4] Completed [17/419] on J1 in 11.37s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestScoreCachingWrappingScorer
   [junit4] Completed [18/419] on J1 in 0.19s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTimeLimitingCollector
   [junit4] Completed [19/419] on J0 in 7.75s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFieldsReader
   [junit4] Completed [20/419] on J1 in 4.22s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestNamedSPILoader
   [junit4] Completed [21/419] on J1 in 0.05s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanOrQuery
   [junit4] Completed [22/419] on J1 in 0.04s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMaxPosition
   [junit4] Completed [23/419] on J1 in 0.20s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterMaxDocs
   [junit4] IGNOR/A 0.02s J0 | TestIndexWriterMaxDocs.testExactlyAtTrueLimit
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes over two hours))
   [junit4] Completed [24/419] on J0 in 9.54s, 21 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressIndexing
   [junit4] Completed [25/419] on J1 in 11.30s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestBlockPostingsFormat
   [junit4] Completed [26/419] on J2 in 20.20s, 26 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMultiLevelSkipList
   [junit4] Completed [27/419] on J2 in 0.12s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentReader
   [junit4] Completed [28/419] on J0 in 5.48s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestOmitNorms
   [junit4] Completed [29/419] on J1 in 5.84s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterWithThreads
   [junit4] IGNOR/A 0.23s J0 | TestIndexWriterWithThreads.testOpenTwoIndexWritersOnDifferentThreads
   [junit4]    > Assumption #1: aborting test: timeout obtaining lock
   [junit4] Completed [30/419] on J0 in 5.39s, 12 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocCount
   [junit4] Completed [31/419] on J0 in 0.15s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestUnicodeUtil
   [junit4] Completed [32/419] on J0 in 2.30s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanCoord
   [junit4] Completed [33/419] on J0 in 0.72s, 76 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestBinaryDocument
   [junit4] Completed [34/419] on J0 in 0.10s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNRTReaderCleanup
   [junit4] Completed [35/419] on J0 in 0.11s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNeverDelete
   [junit4] Completed [36/419] on J0 in 2.97s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiPhraseQuery
   [junit4] Completed [37/419] on J0 in 0.53s, 17 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCheckIndex
   [junit4] Completed [38/419] on J0 in 1.86s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestCloseableThreadLocal
   [junit4] Completed [39/419] on J0 in 0.05s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestUTF32ToUTF8
   [junit4] Completed [40/419] on J0 in 13.04s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDoc
   [junit4] Completed [41/419] on J0 in 0.56s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSynonymQuery
   [junit4] Completed [42/419] on J0 in 0.09s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPerSegmentDeletes
   [junit4] Completed [43/419] on J0 in 0.43s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestToken
   [junit4] Completed [44/419] on J0 in 0.06s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestCharFilter
   [junit4] Completed [45/419] on J0 in 0.07s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestRegexpRandom
   [junit4] Completed [46/419] on J0 in 0.36s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCodecs
   [junit4] Completed [47/419] on J0 in 1.12s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.tokenattributes.TestSimpleAttributeImpl
   [junit4] Completed [48/419] on J0 in 0.19s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestRateLimiter
   [junit4] IGNOR/A 0.49s J0 | TestRateLimiter.testThreads
   [junit4]    > Assumption #1: actualMBPerSec=23.019012484241188 targetMBPerSec=25.82969627526625
   [junit4] Completed [49/419] on J0 in 0.53s, 2 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTerm
   [junit4] Completed [50/419] on J0 in 0.04s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocValuesIndexing
   [junit4] Completed [51/419] on J0 in 1.17s, 34 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMultiDocValues
   [junit4] Completed [52/419] on J0 in 1.00s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestManyFields
   [junit4] Completed [53/419] on J0 in 2.82s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDuelingCodecs
   [junit4] Completed [54/419] on J1 in 40.60s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestStringHelper
   [junit4] Completed [55/419] on J1 in 0.07s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFieldCacheRewriteMethod
   [junit4] Completed [56/419] on J1 in 8.11s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.geo.TestGeoEncodingUtils
   [junit4] Completed [57/419] on J1 in 2.57s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPayloadsOnVectors
   [junit4] Completed [58/419] on J1 in 0.33s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPostingsOffsets
   [junit4] Completed [59/419] on J1 in 4.00s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestRegexpQuery
   [junit4] Completed [60/419] on J1 in 0.19s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNumericRangeQuery64
   [junit4] Completed [61/419] on J0 in 26.10s, 29 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestReaderClosed
   [junit4] Completed [62/419] on J0 in 0.08s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.geo.TestGeoUtils
   [junit4] Completed [63/419] on J2 in 65.21s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTransactions
   [junit4] Completed [64/419] on J2 in 1.51s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestDocIdSetBuilder
   [junit4] Completed [65/419] on J2 in 1.24s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestUpgradeIndexMergePolicy
   [junit4] Completed [66/419] on J2 in 0.22s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBinaryDocValuesUpdates
   [junit4] IGNOR/A 0.00s J1 | TestBinaryDocValuesUpdates.testTonsOfUpdates
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [67/419] on J1 in 12.76s, 28 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestCharsRefBuilder
   [junit4] Completed [68/419] on J1 in 0.03s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestRegexpRandom2
   [junit4] Completed [69/419] on J2 in 15.08s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexFileDeleter
   [junit4] Completed [70/419] on J2 in 3.56s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestMultiMMap
   [junit4] Completed [71/419] on J2 in 7.23s, 57 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.fst.TestFSTs
   [junit4] IGNOR/A 0.00s J1 | TestFSTs.testBigSet
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [72/419] on J1 in 21.78s, 20 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocumentsWriterStallControl
   [junit4] Completed [73/419] on J1 in 5.61s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanContainQuery
   [junit4] Completed [74/419] on J1 in 1.06s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentTermDocs
   [junit4] Completed [75/419] on J1 in 1.07s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.tokenattributes.TestBytesRefAttImpl
   [junit4] Completed [76/419] on J1 in 0.05s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestAssertions
   [junit4] Completed [77/419] on J1 in 0.06s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSortedSetSelector
   [junit4] Completed [78/419] on J1 in 0.88s, 15 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSearchWithThreads
   [junit4] Completed [79/419] on J2 in 11.65s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNorms
   [junit4] Completed [80/419] on J2 in 2.04s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BSortedDocValuesFixedSorted
   [junit4] IGNOR/A 0.00s J2 | Test2BSortedDocValuesFixedSorted.testFixedSorted
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=Takes ~ 6 hours if the heap is 5gb))
   [junit4] Completed [81/419] on J2 in 0.01s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSort
   [junit4] Completed [82/419] on J2 in 0.45s, 25 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSortedSetSortField
   [junit4] Completed [83/419] on J2 in 0.57s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestByteSlices
   [junit4] Completed [84/419] on J1 in 8.59s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAtomicUpdate
   [junit4] Completed [85/419] on J2 in 5.44s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCrashCausesCorruptIndex
   [junit4] Completed [86/419] on J2 in 0.11s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestParallelReaderEmptyIndex
   [junit4] Completed [87/419] on J2 in 0.07s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTopDocsMerge
   [junit4] Completed [88/419] on J2 in 3.99s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestFastCompressionMode
   [junit4] Completed [89/419] on J2 in 2.13s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressIndexing2
   [junit4] Completed [90/419] on J2 in 2.10s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestMergeSchedulerExternal
   [junit4] Completed [91/419] on J2 in 1.57s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPrefixCodedTerms
   [junit4] Completed [92/419] on J2 in 0.58s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIntroSorter
   [junit4] Completed [93/419] on J2 in 0.33s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFuzzyQuery
   [junit4] Completed [94/419] on J2 in 0.44s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestNearSpansOrdered
   [junit4] Completed [95/419] on J2 in 0.34s, 18 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRoaringDocIdSet
   [junit4] Completed [96/419] on J2 in 1.25s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestRollingUpdates
   [junit4] Completed [97/419] on J2 in 3.24s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocumentWriter
   [junit4] Completed [98/419] on J2 in 0.42s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestForceMergeForever
   [junit4] Completed [99/419] on J2 in 0.87s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestLogMergePolicy
   [junit4] Completed [100/419] on J2 in 0.07s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestNumericUtils
   [junit4] Completed [101/419] on J2 in 3.14s, 24 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAllFilesDetectTruncation
   [junit4] Completed [102/419] on J2 in 1.33s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestConcurrentMergeScheduler
   [junit4] Completed [103/419] on J2 in 8.61s, 16 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestComplexExplanationsOfNonMatches
   [junit4] Completed [104/419] on J2 in 0.24s, 21 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimpleSearchEquivalence
   [junit4] Completed [105/419] on J2 in 1.97s, 17 tests
   [junit4] 
   [junit4] HEARTBEAT J0 PID(18295@localhost): 2016-04-18T01:17:29, stalled for 67.3s at: TestTermsEnum.testVaryingTermsPerSegment
   [junit4] Suite: org.apache.lucene.index.TestConsistentFieldNumbers
   [junit4] Completed [106/419] on J2 in 5.81s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiThreadTermVectors
   [junit4] Completed [107/419] on J2 in 4.54s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestTrackingDirectoryWrapper
   [junit4] IGNOR/A 0.01s J2 | TestTrackingDirectoryWrapper.testFsyncDoesntCreateNewFiles
   [junit4]    > Assumption #1: test only works for FSDirectory subclasses
   [junit4] IGNOR/A 0.01s J2 | TestTrackingDirectoryWrapper.testPendingDeletions
   [junit4]    > Assumption #1: we can only install VirusCheckingFS on an FSDirectory
   [junit4] Completed [108/419] on J2 in 0.96s, 50 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestArrayUtil
   [junit4] Completed [109/419] on J2 in 5.48s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermsEnum
   [junit4] Completed [110/419] on J0 in 101.70s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestShardSearching
   [junit4] Completed [111/419] on J0 in 9.40s, 1 test
   [junit4] 
   [junit4] HEARTBEAT J1 PID(18309@localhost): 2016-04-18T01:17:53, stalled for 62.0s at: TestGrowableByteArrayDataOutput.testWriteLargeStrings
   [junit4] Suite: org.apache.lucene.search.TestMultiTermQueryRewrites
   [junit4] Completed [112/419] on J0 in 0.23s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNumericRangeQuery32
   [junit4] Completed [113/419] on J2 in 12.00s, 23 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestFastDecompressionMode
   [junit4] Completed [114/419] on J2 in 3.93s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpans
   [junit4] Completed [115/419] on J2 in 1.11s, 26 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBlendedTermQuery
   [junit4] Completed [116/419] on J2 in 0.04s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDocValuesRewriteMethod
   [junit4] Completed [117/419] on J2 in 4.02s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterFromReader
   [junit4] Completed [118/419] on J2 in 0.82s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermsEnum2
   [junit4] Completed [119/419] on J2 in 1.26s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDocValuesScoring
   [junit4] Completed [120/419] on J2 in 0.04s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanNearQuery
   [junit4] Completed [121/419] on J2 in 0.02s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestConjunctionDISI
   [junit4] Completed [122/419] on J0 in 13.26s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestConstantScoreQuery
   [junit4] Completed [123/419] on J0 in 0.10s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDateSort
   [junit4] Completed [124/419] on J0 in 0.22s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMixedCodecs
   [junit4] Completed [125/419] on J2 in 1.94s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTotalHitCountCollector
   [junit4] Completed [126/419] on J2 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNoMergeScheduler
   [junit4] Completed [127/419] on J2 in 0.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIOUtils
   [junit4] Completed [128/419] on J2 in 0.27s, 18 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexableField
   [junit4] Completed [129/419] on J2 in 1.14s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterOutOfFileDescriptors
   [junit4] Completed [130/419] on J2 in 6.90s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocValues
   [junit4] Completed [131/419] on J2 in 0.14s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestCachingCollector
   [junit4] Completed [132/419] on J2 in 0.08s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriter
   [junit4] Completed [133/419] on J0 in 11.43s, 71 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestLiveFieldValues
   [junit4] Completed [134/419] on J2 in 3.39s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestMathUtil
   [junit4] Completed [135/419] on J2 in 0.09s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSortRandom
   [junit4] Completed [136/419] on J0 in 1.13s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPersistentSnapshotDeletionPolicy
   [junit4] Completed [137/419] on J0 in 1.87s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.FuzzyTermOnShortTermsTest
   [junit4] Completed [138/419] on J0 in 0.25s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRecyclingByteBlockAllocator
   [junit4] Completed [139/419] on J0 in 0.12s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterLockRelease
   [junit4] Completed [140/419] on J0 in 0.35s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestEarlyTermination
   [junit4] Completed [141/419] on J0 in 0.10s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanQueryVisitSubscorers
   [junit4] Completed [142/419] on J0 in 0.35s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestSparseFixedBitDocIdSet
   [junit4] Completed [143/419] on J2 in 3.36s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiset
   [junit4] Completed [144/419] on J2 in 0.09s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestBytesRefHash
   [junit4] Completed [145/419] on J2 in 5.16s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterMergePolicy
   [junit4] Completed [146/419] on J0 in 6.19s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestExternalCodecs
   [junit4] Completed [147/419] on J2 in 0.89s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMergeRateLimiter
   [junit4] Completed [148/419] on J0 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestExitableDirectoryReader
   [junit4] Completed [149/419] on J2 in 0.52s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestMmapDirectory
   [junit4] Completed [150/419] on J0 in 3.55s, 45 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterDeleteByQuery
   [junit4] Completed [151/419] on J0 in 0.06s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BSortedDocValuesOrds
   [junit4] IGNOR/A 0.00s J0 | Test2BSortedDocValuesOrds.test2BOrds
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=Takes ~ 6 hours if the heap is 5gb))
   [junit4] Completed [152/419] on J0 in 0.03s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTermScorer
   [junit4] Completed [153/419] on J0 in 0.14s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.similarities.TestSimilarity2
   [junit4] Completed [154/419] on J0 in 0.68s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentInfos
   [junit4] Completed [155/419] on J0 in 0.14s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestHighCompressionMode
   [junit4] Completed [156/419] on J0 in 1.82s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestDeterminism
   [junit4] Completed [157/419] on J0 in 2.40s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiTermConstantScore
   [junit4] Completed [158/419] on J0 in 1.83s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test4GBStoredFields
   [junit4] IGNOR/A 0.00s J0 | Test4GBStoredFields.test
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [159/419] on J0 in 0.00s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestForTooMuchCloning
   [junit4] Completed [160/419] on J0 in 0.14s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestVirtualMethod
   [junit4] Completed [161/419] on J0 in 0.03s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTragicIndexWriterDeadlock
   [junit4] Completed [162/419] on J0 in 0.09s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSumDocFreq
   [junit4] Completed [163/419] on J0 in 0.38s, 1 test
   [junit4] 
   [junit4] HEARTBEAT J1 PID(18309@localhost): 2016-04-18T01:18:53, stalled for  122s at: TestGrowableByteArrayDataOutput.testWriteLargeStrings
   [junit4] Suite: org.apache.lucene.util.TestOfflineSorter
   [junit4] IGNOR/A 0.00s J0 | TestOfflineSorter.testLargerRandom
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [164/419] on J0 in 23.13s, 14 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.compressing.TestGrowableByteArrayDataOutput
   [junit4] Completed [165/419] on J1 in 135.00s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestMinimize
   [junit4] Completed [166/419] on J0 in 6.34s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestRAMDirectory
   [junit4] IGNOR/A 0.00s J1 | TestRAMDirectory.testPendingDeletions
   [junit4]    > Assumption #1: we can only install VirusCheckingFS on an FSDirectory
   [junit4] IGNOR/A 0.01s J1 | TestRAMDirectory.testFsyncDoesntCreateNewFiles
   [junit4]    > Assumption #1: test only works for FSDirectory subclasses
   [junit4] Completed [167/419] on J1 in 3.69s, 49 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTryDelete
   [junit4] Completed [168/419] on J1 in 0.04s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestExceedMaxTermLength
   [junit4] Completed [169/419] on J1 in 0.08s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestParallelTermEnum
   [junit4] Completed [170/419] on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestOmitTf
   [junit4] Completed [171/419] on J1 in 1.18s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimilarity
   [junit4] Completed [172/419] on J1 in 0.64s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSortedSetDocValues
   [junit4] Completed [173/419] on J1 in 0.08s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestApproximationSearchEquivalence
   [junit4] Completed [174/419] on J1 in 1.81s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestUsageTrackingFilterCachingPolicy
   [junit4] Completed [175/419] on J1 in 0.07s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSameScoresWithThreads
   [junit4] Completed [176/419] on J1 in 2.31s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMatchNoDocsQuery
   [junit4] Completed [177/419] on J1 in 0.09s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiPhraseEnum
   [junit4] Completed [178/419] on J1 in 0.10s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestFixedBitSet
   [junit4] Completed [179/419] on J0 in 9.13s, 19 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSubScorerFreqs
   [junit4] Completed [180/419] on J0 in 0.12s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.bkd.Test2BBKDPoints
   [junit4] IGNOR/A 0.00s J0 | Test2BBKDPoints.test1D
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes at least 4 hours and consumes many GB of temp disk space))
   [junit4] IGNOR/A 0.00s J0 | Test2BBKDPoints.test2D
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes at least 4 hours and consumes many GB of temp disk space))
   [junit4] Completed [181/419] on J0 in 0.02s, 2 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPointQueries
   [junit4] IGNOR/A 0.00s J1 | TestPointQueries.testRandomBinaryBig
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] IGNOR/A 0.00s J1 | TestPointQueries.testRandomLongsBig
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [182/419] on J1 in 23.98s, 45 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterReader
   [junit4] IGNOR/A 0.00s J0 | TestIndexWriterReader.testDuringAddIndexes
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [183/419] on J0 in 22.34s, 23 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.perfield.TestPerFieldDocValuesFormat
   [junit4] Completed [184/419] on J2 in 76.09s, 96 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.fst.TestBytesStore
   [junit4] Completed [185/419] on J2 in 4.18s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterMerging
   [junit4] Completed [186/419] on J0 in 16.54s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAddIndexes
   [junit4] Completed [187/419] on J0 in 6.66s, 23 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterExceptions
   [junit4] IGNOR/A 0.00s J1 | TestIndexWriterExceptions.testTooManyTokens
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [188/419] on J1 in 26.66s, 36 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSearcherManager
   [junit4] Completed [189/419] on J0 in 4.91s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestBasics
   [junit4] Completed [190/419] on J1 in 6.94s, 25 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentTermEnum
   [junit4] Completed [191/419] on J1 in 0.17s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDeletionPolicy
   [junit4] Completed [192/419] on J0 in 4.20s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.packed.TestPackedInts
   [junit4] IGNOR/A 0.00s J2 | TestPackedInts.testBlockReaderOverflow
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [193/419] on J2 in 26.04s, 28 tests, 3 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSloppyPhraseQuery
   [junit4] Completed [194/419] on J2 in 2.51s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanScorer
   [junit4] Completed [195/419] on J1 in 5.68s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanOr
   [junit4] Completed [196/419] on J0 in 4.38s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRecyclingIntBlockAllocator
   [junit4] Completed [197/419] on J1 in 0.15s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestInfoStream
   [junit4] Completed [198/419] on J1 in 0.06s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPositiveScoresOnlyCollector
   [junit4] Completed [199/419] on J1 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMatchAllDocsQuery
   [junit4] Completed [200/419] on J1 in 0.36s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNRTThreads
   [junit4] Completed [201/419] on J0 in 5.82s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterCommit
   [junit4] Completed [202/419] on J0 in 3.06s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMixedDocValuesUpdates
   [junit4] IGNOR/A 0.00s J1 | TestMixedDocValuesUpdates.testTonsOfUpdates
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [203/419] on J1 in 9.96s, 4 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestParallelLeafReader
   [junit4] Completed [204/419] on J1 in 0.41s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDirectoryReaderReopen
   [junit4] Completed [205/419] on J0 in 3.38s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSearchAfter
   [junit4] Completed [206/419] on J0 in 2.46s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestNRTCachingDirectory
   [junit4] IGNOR/A 0.00s J1 | TestNRTCachingDirectory.testFsyncDoesntCreateNewFiles
   [junit4]    > Assumption #1: test only works for FSDirectory subclasses
   [junit4] IGNOR/A 0.00s J1 | TestNRTCachingDirectory.testPendingDeletions
   [junit4]    > Assumption #1: we can only install VirusCheckingFS on an FSDirectory
   [junit4] Completed [207/419] on J1 in 5.40s, 47 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterOnJRECrash
   [junit4] IGNOR/A 0.00s J1 | TestIndexWriterOnJRECrash.testNRTThreads
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [208/419] on J1 in 0.02s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BPostingsBytes
   [junit4] IGNOR/A 0.00s J1 | Test2BPostingsBytes.test
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes ~20GB-30GB of space and 10 minutes))
   [junit4] Completed [209/419] on J1 in 0.02s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanMultiTermQueryWrapper
   [junit4] Completed [210/419] on J1 in 0.31s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestBufferedChecksum
   [junit4] Completed [211/419] on J1 in 0.44s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSnapshotDeletionPolicy
   [junit4] Completed [212/419] on J0 in 2.38s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterDelete
   [junit4] IGNOR/A 0.00s J2 | TestIndexWriterDelete.testApplyDeletesOnFlush
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [213/419] on J2 in 19.27s, 27 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNRTReaderWithThreads
   [junit4] Completed [214/419] on J2 in 2.33s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressAdvance
   [junit4] Completed [215/419] on J1 in 5.40s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestLucene50FieldInfoFormat
   [junit4] Completed [216/419] on J1 in 1.53s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterUnicode
   [junit4] Completed [217/419] on J0 in 9.38s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTieredMergePolicy
   [junit4] Completed [218/419] on J2 in 8.56s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestLevenshteinAutomata
   [junit4] Completed [219/419] on J1 in 6.50s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestReqExclBulkScorer
   [junit4] Completed [220/419] on J1 in 0.05s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterForceMerge
   [junit4] Completed [221/419] on J0 in 3.99s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAllFilesCheckIndexHeader
   [junit4] Completed [222/419] on J1 in 1.60s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestBufferedIndexInput
   [junit4] Completed [223/419] on J0 in 1.82s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFlushByRamOrCountsPolicy
   [junit4] Completed [224/419] on J1 in 6.21s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestVersion
   [junit4] Completed [225/419] on J1 in 0.07s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBoolean2
   [junit4] Completed [226/419] on J1 in 9.92s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestWeakIdentityMap
   [junit4] Completed [227/419] on J0 in 15.33s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermVectors
   [junit4] Completed [228/419] on J1 in 0.75s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDirectoryReader
   [junit4] Completed [229/419] on J0 in 3.89s, 24 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestLockFactory
   [junit4] Completed [230/419] on J0 in 0.05s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSegmentMerger
   [junit4] Completed [231/419] on J0 in 3.02s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.perfield.TestPerFieldPostingsFormat
   [junit4] IGNOR/A 0.01s J2 | TestPerFieldPostingsFormat.testMergeStability
   [junit4]    > Assumption #1: The MockRandom PF randomizes content on the fly, so we can't check it
   [junit4] IGNOR/A 0.00s J2 | TestPerFieldPostingsFormat.testPostingsEnumReuse
   [junit4]    > Assumption #1: The MockRandom PF randomizes content on the fly, so we can't check it
   [junit4] Completed [232/419] on J2 in 27.01s, 24 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestNotDocIdSet
   [junit4] Completed [233/419] on J1 in 7.66s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBagOfPositions
   [junit4] Completed [234/419] on J2 in 9.60s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestComplexExplanations
   [junit4] Completed [235/419] on J2 in 1.96s, 21 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestParallelCompositeReader
   [junit4] Completed [236/419] on J2 in 0.56s, 15 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.bkd.TestBKD
   [junit4] IGNOR/A 0.00s J1 | TestBKD.testRandomBinaryBig
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [237/419] on J1 in 17.91s, 15 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIntArrayDocIdSet
   [junit4] Completed [238/419] on J1 in 1.23s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestFilterSpans
   [junit4] Completed [239/419] on J1 in 0.28s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestCollectionUtil
   [junit4] Completed [240/419] on J0 in 21.07s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.packed.TestDirectPacked
   [junit4] Completed [241/419] on J1 in 3.14s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCrash
   [junit4] Completed [242/419] on J1 in 0.96s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestPagedBytes
   [junit4] Completed [243/419] on J0 in 5.94s, 4 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestCustomSearcherSort
   [junit4] Completed [244/419] on J0 in 2.73s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.perfield.TestPerFieldPostingsFormat2
   [junit4] Completed [245/419] on J1 in 6.75s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.similarities.TestSimilarityBase
   [junit4] Completed [246/419] on J0 in 3.81s, 32 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestHugeRamFile
   [junit4] Completed [247/419] on J1 in 5.16s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterNRTIsCurrent
   [junit4] Completed [248/419] on J2 in 23.62s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestLegacyNumericUtils
   [junit4] Completed [249/419] on J1 in 2.20s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanMinShouldMatch
   [junit4] Completed [250/419] on J0 in 4.88s, 17 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterOnDiskFull
   [junit4] Completed [251/419] on J1 in 1.52s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTransactionRollback
   [junit4] Completed [252/419] on J1 in 0.33s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestDeterminizeLexicon
   [junit4] Completed [253/419] on J2 in 4.56s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestCustomNorms
   [junit4] Completed [254/419] on J0 in 2.33s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFlex
   [junit4] Completed [255/419] on J1 in 0.23s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestLazyProxSkipping
   [junit4] Completed [256/419] on J0 in 1.00s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanExplanations
   [junit4] Completed [257/419] on J2 in 1.28s, 30 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocsAndPositions
   [junit4] Completed [258/419] on J1 in 1.93s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermVectorsWriter
   [junit4] Completed [259/419] on J2 in 0.63s, 15 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.tokenattributes.TestCharTermAttributeImpl
   [junit4] Completed [260/419] on J1 in 1.49s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestOmitPositions
   [junit4] Completed [261/419] on J2 in 1.10s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestThreadedForceMerge
   [junit4] Completed [262/419] on J1 in 1.77s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressNRT
   [junit4] Completed [263/419] on J2 in 3.20s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBagOfPostings
   [junit4] Completed [264/419] on J0 in 6.31s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexInput
   [junit4] Completed [265/419] on J1 in 2.75s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestDisjunctionMaxQuery
   [junit4] Completed [266/419] on J0 in 1.23s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSloppyPhraseQuery2
   [junit4] Completed [267/419] on J2 in 1.90s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTermRangeQuery
   [junit4] Completed [268/419] on J0 in 0.45s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocumentsWriterDeleteQueue
   [junit4] Completed [269/419] on J2 in 0.78s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMultiFields
   [junit4] Completed [270/419] on J1 in 1.40s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPayloads
   [junit4] Completed [271/419] on J2 in 0.40s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestWildcard
   [junit4] Completed [272/419] on J1 in 0.36s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNoDeletionPolicy
   [junit4] Completed [273/419] on J1 in 0.31s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestFieldMaskingSpanQuery
   [junit4] IGNOR/A 0.00s J2 | TestFieldMaskingSpanQuery.testSpans2
   [junit4]    > Assumption #1: Broken scoring: LUCENE-3723
   [junit4] IGNOR/A 0.01s J2 | TestFieldMaskingSpanQuery.testSimple2
   [junit4]    > Assumption #1: Broken scoring: LUCENE-3723
   [junit4] Completed [274/419] on J2 in 0.77s, 11 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimpleExplanationsOfNonMatches
   [junit4] Completed [275/419] on J1 in 0.32s, 68 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermVectorsReader
   [junit4] Completed [276/419] on J2 in 0.70s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIntBlockPool
   [junit4] Completed [277/419] on J1 in 1.11s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTopDocsCollector
   [junit4] Completed [278/419] on J1 in 0.28s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestUniqueTermCount
   [junit4] Completed [279/419] on J1 in 0.20s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPrefixInBooleanQuery
   [junit4] Completed [280/419] on J2 in 1.52s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanQuery
   [junit4] Completed [281/419] on J1 in 0.70s, 22 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanSearchEquivalence
   [junit4] Completed [282/419] on J0 in 6.26s, 33 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAllFilesHaveCodecHeader
   [junit4] Completed [283/419] on J2 in 1.50s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestDocument
   [junit4] Completed [284/419] on J0 in 0.46s, 12 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestTopFieldCollector
   [junit4] Completed [285/419] on J0 in 0.37s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMaxTermFrequency
   [junit4] Completed [286/419] on J2 in 1.88s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestSentinelIntSet
   [junit4] Completed [287/419] on J2 in 0.39s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestWildcardRandom
   [junit4] Completed [288/419] on J2 in 0.34s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestAutomatonQuery
   [junit4] Completed [289/419] on J1 in 4.89s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPrefixRandom
   [junit4] Completed [290/419] on J2 in 0.93s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestDirectory
   [junit4] Completed [291/419] on J1 in 0.14s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestFileSwitchDirectory
   [junit4] IGNOR/A 0.00s J0 | TestFileSwitchDirectory.testFsyncDoesntCreateNewFiles
   [junit4]    > Assumption #1: test only works for FSDirectory subclasses
   [junit4] IGNOR/A 0.02s J0 | TestFileSwitchDirectory.testPendingDeletions
   [junit4]    > Assumption #1: we can only install VirusCheckingFS on an FSDirectory
   [junit4] Completed [292/419] on J0 in 3.88s, 46 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestSearchForDuplicates
   [junit4] Completed [293/419] on J2 in 0.44s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSizeBoundedForceMerge
   [junit4] Completed [294/419] on J1 in 0.97s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.automaton.TestCompiledAutomaton
   [junit4] Completed [295/419] on J0 in 0.46s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestElevationComparator
   [junit4] Completed [296/419] on J1 in 0.27s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestBinaryTerms
   [junit4] Completed [297/419] on J0 in 0.41s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestConjunctions
   [junit4] Completed [298/419] on J1 in 0.06s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPositionIncrement
   [junit4] Completed [299/419] on J0 in 0.10s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestField
   [junit4] Completed [300/419] on J1 in 0.22s, 27 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanExplanationsOfNonMatches
   [junit4] Completed [301/419] on J0 in 0.24s, 30 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRollingBuffer
   [junit4] Completed [302/419] on J1 in 0.61s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestSmallFloat
   [junit4] Completed [303/419] on J0 in 0.74s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSimilarityProvider
   [junit4] Completed [304/419] on J1 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestNumericTokenStream
   [junit4] Completed [305/419] on J0 in 0.07s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestSetOnce
   [junit4] Completed [306/419] on J1 in 0.35s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFilterLeafReader
   [junit4] Completed [307/419] on J0 in 0.11s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestCachingTokenFilter
   [junit4] Completed [308/419] on J1 in 0.05s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestFilterIterator
   [junit4] Completed [309/419] on J0 in 0.03s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestDateTools
   [junit4] Completed [310/419] on J1 in 0.09s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestCharsRef
   [junit4] Completed [311/419] on J0 in 0.05s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BPostings
   [junit4] IGNOR/A 0.00s J0 | Test2BPostings.test
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [312/419] on J0 in 0.01s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSameTokenSamePosition
   [junit4] Completed [313/419] on J0 in 0.11s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestPriorityQueue
   [junit4] Completed [314/419] on J1 in 0.64s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestAutomatonQueryUnicode
   [junit4] Completed [315/419] on J0 in 0.04s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestAttributeSource
   [junit4] Completed [316/419] on J1 in 0.19s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestRamUsageEstimator
   [junit4] IGNOR/A 0.00s J0 | TestRamUsageEstimator.testPrintValues
   [junit4]    > Assumption #1: Specify -Dtests.verbose=true to print constants of RamUsageEstimator.
   [junit4] Completed [317/419] on J0 in 0.09s, 5 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanFirstQuery
   [junit4] Completed [318/419] on J1 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNoMergePolicy
   [junit4] Completed [319/419] on J1 in 0.24s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIsCurrent
   [junit4] Completed [320/419] on J0 in 0.17s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPhrasePrefixQuery
   [junit4] Completed [321/419] on J1 in 0.05s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestByteBlockPool
   [junit4] Completed [322/419] on J0 in 0.08s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestBytesRef
   [junit4] Completed [323/419] on J1 in 0.03s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.TestDemo
   [junit4] Completed [324/419] on J0 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestPrefixQuery
   [junit4] Completed [325/419] on J2 in 5.96s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestRollback
   [junit4] Completed [326/419] on J1 in 0.05s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTwoPhaseCommitTool
   [junit4] Completed [327/419] on J0 in 0.05s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNot
   [junit4] Completed [328/419] on J2 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.MultiCollectorTest
   [junit4] Completed [329/419] on J1 in 0.04s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestIntsRef
   [junit4] Completed [330/419] on J0 in 0.08s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTermdocPerf
   [junit4] Completed [331/419] on J2 in 0.12s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BPositions
   [junit4] IGNOR/A 0.00s J1 | Test2BPositions.test
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=uses lots of space and takes a few minutes))
   [junit4] Completed [332/419] on J1 in 0.10s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexCommit
   [junit4] Completed [333/419] on J0 in 0.02s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BTerms
   [junit4] IGNOR/A 0.00s J2 | Test2BTerms.test2BTerms
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=very slow, use 5g minimum heap))
   [junit4] Completed [334/419] on J2 in 0.00s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNewestSegment
   [junit4] Completed [335/419] on J1 in 0.01s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BNumericDocValues
   [junit4] IGNOR/A 0.00s J0 | Test2BNumericDocValues.testNumerics
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes ~ 2 hours if the heap is 5gb))
   [junit4] Completed [336/419] on J0 in 0.01s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BBinaryDocValues
   [junit4] IGNOR/A 0.00s J2 | Test2BBinaryDocValues.testFixedBinary
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes ~ 6 hours if the heap is 5gb))
   [junit4] IGNOR/A 0.00s J2 | Test2BBinaryDocValues.testVariableBinary
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes ~ 6 hours if the heap is 5gb))
   [junit4] Completed [337/419] on J2 in 0.00s, 2 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.Test2BPagedBytes
   [junit4] IGNOR/A 0.00s J1 | Test2BPagedBytes.test
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=You must increase heap to > 2 G to run this))
   [junit4] Completed [338/419] on J1 in 0.00s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.TestReusableStringReader
   [junit4] Completed [340/419] on J2 in 0.05s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.analysis.tokenattributes.TestPackedTokenAttributeImpl
   [junit4] Completed [341/419] on J1 in 0.02s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.TestCodecLoadingDeadlock
   [junit4] Completed [342/419] on J0 in 1.35s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestForUtil
   [junit4] Completed [343/419] on J0 in 0.07s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestBlockPostingsFormat3
   [junit4] Completed [344/419] on J1 in 3.93s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestLucene50SegmentInfoFormat
   [junit4] Completed [345/419] on J1 in 1.71s, 15 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestBlockPostingsFormat2
   [junit4] Completed [346/419] on J2 in 9.09s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestLucene50StoredFieldsFormat
   [junit4] IGNOR/A 0.00s J1 | TestLucene50StoredFieldsFormat.testBigDocuments
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [347/419] on J1 in 4.80s, 17 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestLucene50CompoundFormat
   [junit4] Completed [348/419] on J0 in 11.29s, 24 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestLucene50StoredFieldsFormatHighCompression
   [junit4] IGNOR/A 0.00s J2 | TestLucene50StoredFieldsFormatHighCompression.testBigDocuments
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [349/419] on J2 in 16.49s, 19 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene53.TestLucene53NormsFormat
   [junit4] IGNOR/A 0.00s J0 | TestLucene53NormsFormat.testNCommonBig
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] IGNOR/A 0.00s J0 | TestLucene53NormsFormat.testMergeStability
   [junit4]    > Assumption #1: The MockRandom PF randomizes content on the fly, so we can't check it
   [junit4] Completed [350/419] on J0 in 17.20s, 17 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene60.TestLucene60PointsFormat
   [junit4] IGNOR/A 0.00s J0 | TestLucene60PointsFormat.testMergeStability
   [junit4]    > Assumption #1: TODO: mess with the parameters and test gets angry!
   [junit4] IGNOR/A 0.00s J0 | TestLucene60PointsFormat.testRandomBinaryBig
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [351/419] on J0 in 12.70s, 16 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.document.TestFieldType
   [junit4] Completed [352/419] on J0 in 0.04s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.codecs.lucene50.TestLucene50TermVectorsFormat
   [junit4] Completed [353/419] on J1 in 44.69s, 17 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.Test2BPoints
   [junit4] IGNOR/A 0.00s J1 | Test2BPoints.test1D
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes at least 4 hours and consumes many GB of temp disk space))
   [junit4] IGNOR/A 0.00s J1 | Test2BPoints.test2D
   [junit4]    > Assumption #1: 'monster' test group is disabled (@Monster(value=takes at least 4 hours and consumes many GB of temp disk space))
   [junit4] Completed [354/419] on J1 in 0.01s, 2 tests, 2 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestAllFilesHaveChecksumFooter
   [junit4] Completed [355/419] on J1 in 1.21s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDemoParallelLeafReader
   [junit4] Completed [356/419] on J1 in 11.35s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestDocInverterPerFieldErrorInfo
   [junit4] Completed [357/419] on J1 in 0.10s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFieldReuse
   [junit4] Completed [358/419] on J1 in 0.04s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestFilterDirectoryReader
   [junit4] Completed [359/419] on J1 in 0.03s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexReaderClose
   [junit4] Completed [360/419] on J1 in 0.52s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterExceptions2
   [junit4] Completed [361/419] on J1 in 11.21s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.geo.TestPolygon
   [junit4] Completed [362/419] on J0 in 39.20s, 16 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterOnVMError
   [junit4] IGNOR/A 0.00s J1 | TestIndexWriterOnVMError.testCheckpoint
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [363/419] on J1 in 0.86s, 3 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMergePolicyWrapper
   [junit4] Completed [364/419] on J0 in 0.08s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestMultiTermsEnum
   [junit4] Completed [365/419] on J0 in 0.54s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestIndexWriterThreadsToSegments
   [junit4] Completed [366/419] on J1 in 3.61s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestOrdinalMap
   [junit4] Completed [367/419] on J1 in 0.20s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestNumericDocValuesUpdates
   [junit4] IGNOR/A 0.00s J0 | TestNumericDocValuesUpdates.testTonsOfUpdates
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [368/419] on J0 in 8.93s, 29 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestReadOnlyIndex
   [junit4] Completed [369/419] on J0 in 0.15s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestReaderWrapperDVTypeCheck
   [junit4] Completed [370/419] on J0 in 0.06s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestStressDeletes
   [junit4] Completed [371/419] on J0 in 0.61s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestSwappedIndexFiles
   [junit4] Completed [372/419] on J0 in 0.34s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestTerms
   [junit4] Completed [373/419] on J0 in 0.20s, 8 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBooleanRewrites
   [junit4] Completed [374/419] on J0 in 0.56s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestBoostQuery
   [junit4] Completed [375/419] on J0 in 0.04s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestControlledRealTimeReopenThread
   [junit4] IGNOR/A 0.00s J0 | TestControlledRealTimeReopenThread.testCRTReopen
   [junit4]    > Assumption #1: 'awaitsfix' test group is disabled (@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/LUCENE-5737))
   [junit4] Completed [376/419] on J0 in 4.01s, 5 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.lucene.index.TestPointValues
   [junit4] Completed [377/419] on J1 in 17.89s, 29 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestIndexSearcher
   [junit4] Completed [378/419] on J1 in 0.17s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestFieldValueQuery
   [junit4] Completed [379/419] on J0 in 6.53s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMinShouldMatch2
   [junit4] Completed [380/419] on J0 in 10.28s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestMultiCollector
   [junit4] Completed [381/419] on J0 in 0.93s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestLRUQueryCache
   [junit4] Completed [382/419] on J1 in 13.36s, 17 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestNeedsScores
   [junit4] Completed [383/419] on J0 in 0.06s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestQueryCachingPolicy
   [junit4] Completed [384/419] on J1 in 0.21s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestQueryRescorer
   [junit4] Completed [385/419] on J0 in 1.30s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSortRescorer
   [junit4] Completed [386/419] on J1 in 1.14s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.TestSortedNumericSortField
   [junit4] Completed [387/419] on J0 in 0.04s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.similarities.TestBM25Similarity
   [junit4] Completed [388/419] on J1 in 0.10s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.similarities.TestClassicSimilarity
   [junit4] Completed [389/419] on J0 in 0.17s, 11 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanBoostQuery
   [junit4] Completed [390/419] on J1 in 0.04s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanNotQuery
   [junit4] Completed [391/419] on J0 in 0.04s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpanTermQuery
   [junit4] Completed [392/419] on J1 in 0.02s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.search.spans.TestSpansEnum
   [junit4] Completed [393/419] on J0 in 0.50s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestNIOFSDirectory
   [junit4] Completed [394/419] on J1 in 2.93s, 45 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestSimpleFSDirectory
   [junit4] Completed [395/419] on J1 in 2.75s, 45 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestNativeFSLockFactory
   [junit4] Completed [396/419] on J0 in 11.84s, 10 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestSingleInstanceLockFactory
   [junit4] Completed [397/419] on J0 in 2.65s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.store.TestSimpleFSLockFactory
   [junit4] Completed [398/419] on J1 in 11.28s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestBytesRefArray
   [junit4] Completed [399/419] on J1 in 0.36s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestFixedBitDocIdSet
   [junit4] Completed [400/419] on J1 in 2.13s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestFixedLengthBytesRefArray
   [junit4] Completed [401/419] on J1 in 0.09s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestFrequencyTrackingRingBuffer
   [junit4] Completed [402/419] on J1 in 0.45s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestInPlaceMergeSorter
   [junit4] Completed [403/419] on J1 in 0.12s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestLSBRadixSorter
   [junit4] Completed [404/419] on J1 in 0.30s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.lucene.util.TestLongBitSet
   [junit4] IGNOR/A 0.00s J1 | TestLongBitSet.testHugeCapacity
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [405/419] on J1 in 0.58s, 9 tests, 1 skipped
   [j

[...truncated too long message...]

junit4] 
   [junit4] Suite: org.apache.solr.search.RankQueryTest
   [junit4] Completed [532/587 (1!)] on J1 in 1.50s, 1 test
   [junit4] 
   [junit4] HEARTBEAT J0 PID(509@lucene1-us-west): 2016-04-18T02:42:39, stalled for 62.2s at: TestCloudSchemaless.test
   [junit4] Suite: org.apache.solr.search.TestCollapseQParserPlugin
   [junit4] Completed [533/587 (1!)] on J1 in 9.35s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestComplexPhraseQParserPlugin
   [junit4] Completed [534/587 (1!)] on J1 in 1.45s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestFilteredDocIdSet
   [junit4] Completed [535/587 (1!)] on J1 in 0.28s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestNoOpRegenerator
   [junit4] Completed [536/587 (1!)] on J1 in 0.29s, 1 test
   [junit4] 
   [junit4] HEARTBEAT J2 PID(515@lucene1-us-west): 2016-04-18T02:42:51, stalled for  365s at: TestStressLiveNodes.testStress
   [junit4] Suite: org.apache.solr.search.TestOverriddenPrefixQueryForCustomFieldType
   [junit4] Completed [537/587 (1!)] on J1 in 0.95s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.cloud.TestStressLiveNodes
   [junit4] Completed [538/587 (1!)] on J2 in 382.20s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestReRankQParserPlugin
   [junit4] Completed [540/587 (1!)] on J2 in 1.80s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestReloadDeadlock
   [junit4] IGNOR/A 0.00s J2 | TestReloadDeadlock.testReloadDeadlock
   [junit4]    > Assumption #1: 'nightly' test group is disabled (@Nightly())
   [junit4] Completed [541/587 (1!)] on J2 in 0.03s, 1 test, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestSimpleQParserPlugin
   [junit4] Completed [542/587 (1!)] on J2 in 0.49s, 17 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestSolr4Spatial2
   [junit4] Completed [543/587 (1!)] on J2 in 0.67s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestStandardQParsers
   [junit4] Completed [544/587 (1!)] on J2 in 0.04s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.schema.TestCloudSchemaless
   [junit4] Completed [545/587 (1!)] on J0 in 99.78s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestStressUserVersions
   [junit4] Completed [546/587 (1!)] on J2 in 5.18s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestXmlQParser
   [junit4] Completed [547/587 (1!)] on J0 in 2.83s, 14 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.function.TestOrdValues
   [junit4] Completed [548/587 (1!)] on J2 in 0.62s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.join.BJQParserTest
   [junit4] Completed [549/587 (1!)] on J2 in 1.79s, 13 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.function.TestSortByMinMaxFunction
   [junit4] Completed [550/587 (1!)] on J0 in 2.45s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.join.BlockJoinFacetSimpleTest
   [junit4] Completed [551/587 (1!)] on J0 in 0.62s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.search.join.GraphQueryTest
   [junit4] Completed [552/587 (1!)] on J0 in 1.16s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.search.join.BlockJoinFacetDistribTest
   [junit4] Completed [553/587 (1!)] on J2 in 9.86s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.search.join.TestScoreJoinQPScore
   [junit4] Completed [554/587 (1!)] on J2 in 1.83s, 5 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.solr.search.similarities.TestClassicSimilarityFactory
   [junit4] Completed [555/587 (1!)] on J2 in 1.35s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.similarities.TestNonDefinedSimilarityFactory
   [junit4] Completed [556/587 (1!)] on J2 in 1.06s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.similarities.TestPerFieldSimilarityWithDefaultOverride
   [junit4] Completed [557/587 (1!)] on J2 in 0.37s, 7 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.join.TestScoreJoinQPNoScore
   [junit4] Completed [559/587 (1!)] on J0 in 20.90s, 3 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.stats.TestDefaultStatsCache
   [junit4] Completed [560/587 (1!)] on J2 in 10.96s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.search.stats.TestExactSharedStatsCache
   [junit4] Completed [561/587 (1!)] on J2 in 11.28s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.search.TestRandomCollapseQParserPlugin
   [junit4] Completed [562/587 (1!)] on J1 in 68.76s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.security.TestRuleBasedAuthorizationPlugin
   [junit4] Completed [563/587 (1!)] on J1 in 0.13s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.servlet.ResponseHeaderTest
   [junit4] Completed [564/587 (1!)] on J1 in 0.71s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.spelling.suggest.TestAnalyzeInfixSuggestions
   [junit4] Completed [565/587 (1!)] on J1 in 2.01s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.spelling.suggest.TestBlendedInfixSuggestions
   [junit4] Completed [566/587 (1!)] on J1 in 0.77s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.spelling.suggest.TestFileDictionaryLookup
   [junit4] Completed [567/587 (1!)] on J1 in 1.11s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.spelling.suggest.TestHighFrequencyDictionaryFactory
   [junit4] Completed [568/587 (1!)] on J1 in 0.93s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.store.blockcache.BlockDirectoryTest
   [junit4] Completed [569/587 (1!)] on J1 in 10.52s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.store.blockcache.BufferStoreTest
   [junit4] Completed [570/587 (1!)] on J1 in 0.10s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.update.AddBlockUpdateTest
   [junit4] Completed [571/587 (1!)] on J1 in 1.09s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.update.AnalysisErrorHandlingTest
   [junit4] Completed [572/587 (1!)] on J1 in 0.44s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.update.TestExceedMaxTermLength
   [junit4] Completed [573/587 (1!)] on J1 in 1.28s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.search.stats.TestDistribIDF
   [junit4] Completed [574/587 (1!)] on J0 in 35.76s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.update.VersionInfoTest
   [junit4] Completed [575/587 (1!)] on J0 in 1.38s, 2 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.update.processor.AtomicUpdatesTest
   [junit4] Completed [576/587 (1!)] on J0 in 4.46s, 18 tests, 1 skipped
   [junit4] 
   [junit4] Suite: org.apache.solr.update.processor.CloneFieldUpdateProcessorFactoryTest
   [junit4] Completed [577/587 (1!)] on J0 in 0.89s, 9 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.security.BasicAuthIntegrationTest
   [junit4] Completed [578/587 (1!)] on J2 in 34.86s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.update.processor.IgnoreCommitOptimizeUpdateProcessorFactoryTest
   [junit4] Completed [579/587 (1!)] on J2 in 0.81s, 1 test
   [junit4] 
   [junit4] Suite: org.apache.solr.update.processor.ParsingFieldUpdateProcessorsTest
   [junit4] Completed [580/587 (1!)] on J2 in 1.69s, 33 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.util.hll.BigEndianAscendingWordDeserializerTest
   [junit4] Completed [581/587 (1!)] on J2 in 1.52s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.util.hll.BigEndianAscendingWordSerializerTest
   [junit4] Completed [582/587 (1!)] on J2 in 0.05s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.util.hll.BitVectorTest
   [junit4] Completed [583/587 (1!)] on J2 in 0.06s, 4 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.update.processor.DocExpirationUpdateProcessorFactoryTest
   [junit4] Completed [584/587 (1!)] on J0 in 10.21s, 5 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.util.hll.ExplicitHLLTest
   [junit4] Completed [585/587 (1!)] on J2 in 0.20s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.util.hll.FullHLLTest
   [junit4] Completed [586/587 (1!)] on J0 in 0.22s, 6 tests
   [junit4] 
   [junit4] Suite: org.apache.solr.update.TestHdfsUpdateLog
   [junit4] Completed [587/587 (1!)] on J1 in 27.61s, 1 test
   [junit4] 
   [junit4] 
   [junit4] Tests with failures [seed: 72BD83A95AE7C852]:
   [junit4]   - org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test
   [junit4] 
   [junit4] 
   [junit4] JVM J0:     0.92 ..  2947.13 =  2946.21s
   [junit4] JVM J1:     0.90 ..  2955.64 =  2954.74s
   [junit4] JVM J2:     1.15 ..  2946.90 =  2945.75s
   [junit4] Execution time total: 49 minutes 15 seconds
   [junit4] Tests summary: 587 suites (10 ignored), 2360 tests, 1 failure, 85 ignored (70 assumptions)

BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:740: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:684: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/build.xml:59: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build.xml:233: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/common-build.xml:529: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1457: The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/lucene/common-build.xml:1014: There were test failures: 587 suites (10 ignored), 2360 tests, 1 failure, 85 ignored (70 assumptions) [seed: 72BD83A95AE7C852]

Total time: 91 minutes 7 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any




[JENKINS] Lucene-Solr-Tests-master - Build # 1086 - Still Failing

Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/1086/

No tests ran.

Build Log:
[...truncated 17 lines...]
ERROR: Error fetching remote repo 'origin'
hudson.plugins.git.GitException: Failed to fetch from git://git.apache.org/lucene-solr.git
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:766)
	at hudson.plugins.git.GitSCM.retrieveChanges(GitSCM.java:1022)
	at hudson.plugins.git.GitSCM.checkout(GitSCM.java:1053)
	at hudson.scm.SCM.checkout(SCM.java:485)
	at hudson.model.AbstractProject.checkout(AbstractProject.java:1276)
	at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:607)
	at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:529)
	at hudson.model.Run.execute(Run.java:1738)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:98)
	at hudson.model.Executor.run(Executor.java:410)
Caused by: hudson.plugins.git.GitException: Command "git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*" returned status code 128:
stdout: 
stderr: fatal: read error: Connection reset by peer

	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1693)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandWithCredentials(CliGitAPIImpl.java:1441)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.access$300(CliGitAPIImpl.java:62)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl$1.execute(CliGitAPIImpl.java:313)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:152)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:145)
	at hudson.remoting.UserRequest.perform(UserRequest.java:120)
	at hudson.remoting.UserRequest.perform(UserRequest.java:48)
	at hudson.remoting.Request$2.run(Request.java:326)
	at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:68)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:745)
	at ......remote call to lucene(Native Method)
	at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1416)
	at hudson.remoting.UserResponse.retrieve(UserRequest.java:220)
	at hudson.remoting.Channel.call(Channel.java:781)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.execute(RemoteGitImpl.java:145)
	at sun.reflect.GeneratedMethodAccessor447.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.invoke(RemoteGitImpl.java:131)
	at com.sun.proxy.$Proxy116.execute(Unknown Source)
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:764)
	... 11 more
ERROR: null
Retrying after 10 seconds
 > git rev-parse --is-inside-work-tree # timeout=10
Fetching changes from the remote Git repository
 > git config remote.origin.url git://git.apache.org/lucene-solr.git # timeout=10
Cleaning workspace
 > git rev-parse --verify HEAD # timeout=10
Resetting working tree
 > git reset --hard # timeout=10
 > git clean -fdx # timeout=10
Fetching upstream changes from git://git.apache.org/lucene-solr.git
 > git --version # timeout=10
 > git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*
ERROR: Error fetching remote repo 'origin'
hudson.plugins.git.GitException: Failed to fetch from git://git.apache.org/lucene-solr.git
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:766)
	at hudson.plugins.git.GitSCM.retrieveChanges(GitSCM.java:1022)
	at hudson.plugins.git.GitSCM.checkout(GitSCM.java:1053)
	at hudson.scm.SCM.checkout(SCM.java:485)
	at hudson.model.AbstractProject.checkout(AbstractProject.java:1276)
	at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:607)
	at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:529)
	at hudson.model.Run.execute(Run.java:1738)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:98)
	at hudson.model.Executor.run(Executor.java:410)
Caused by: hudson.plugins.git.GitException: Command "git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*" returned status code 128:
stdout: 
stderr: fatal: read error: Connection reset by peer

	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1693)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandWithCredentials(CliGitAPIImpl.java:1441)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.access$300(CliGitAPIImpl.java:62)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl$1.execute(CliGitAPIImpl.java:313)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:152)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:145)
	at hudson.remoting.UserRequest.perform(UserRequest.java:120)
	at hudson.remoting.UserRequest.perform(UserRequest.java:48)
	at hudson.remoting.Request$2.run(Request.java:326)
	at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:68)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:745)
	at ......remote call to lucene(Native Method)
	at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1416)
	at hudson.remoting.UserResponse.retrieve(UserRequest.java:220)
	at hudson.remoting.Channel.call(Channel.java:781)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.execute(RemoteGitImpl.java:145)
	at sun.reflect.GeneratedMethodAccessor447.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.invoke(RemoteGitImpl.java:131)
	at com.sun.proxy.$Proxy116.execute(Unknown Source)
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:764)
	... 11 more
ERROR: null
Retrying after 10 seconds
 > git rev-parse --is-inside-work-tree # timeout=10
Fetching changes from the remote Git repository
 > git config remote.origin.url git://git.apache.org/lucene-solr.git # timeout=10
Cleaning workspace
 > git rev-parse --verify HEAD # timeout=10
Resetting working tree
 > git reset --hard # timeout=10
 > git clean -fdx # timeout=10
Fetching upstream changes from git://git.apache.org/lucene-solr.git
 > git --version # timeout=10
 > git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*
ERROR: Error fetching remote repo 'origin'
hudson.plugins.git.GitException: Failed to fetch from git://git.apache.org/lucene-solr.git
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:766)
	at hudson.plugins.git.GitSCM.retrieveChanges(GitSCM.java:1022)
	at hudson.plugins.git.GitSCM.checkout(GitSCM.java:1053)
	at hudson.scm.SCM.checkout(SCM.java:485)
	at hudson.model.AbstractProject.checkout(AbstractProject.java:1276)
	at hudson.model.AbstractBuild$AbstractBuildExecution.defaultCheckout(AbstractBuild.java:607)
	at jenkins.scm.SCMCheckoutStrategy.checkout(SCMCheckoutStrategy.java:86)
	at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:529)
	at hudson.model.Run.execute(Run.java:1738)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:98)
	at hudson.model.Executor.run(Executor.java:410)
Caused by: hudson.plugins.git.GitException: Command "git -c core.askpass=true fetch --tags --progress git://git.apache.org/lucene-solr.git +refs/heads/*:refs/remotes/origin/*" returned status code 128:
stdout: 
stderr: fatal: read error: Connection reset by peer

	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandIn(CliGitAPIImpl.java:1693)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.launchCommandWithCredentials(CliGitAPIImpl.java:1441)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl.access$300(CliGitAPIImpl.java:62)
	at org.jenkinsci.plugins.gitclient.CliGitAPIImpl$1.execute(CliGitAPIImpl.java:313)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:152)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler$1.call(RemoteGitImpl.java:145)
	at hudson.remoting.UserRequest.perform(UserRequest.java:120)
	at hudson.remoting.UserRequest.perform(UserRequest.java:48)
	at hudson.remoting.Request$2.run(Request.java:326)
	at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:68)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
	at java.lang.Thread.run(Thread.java:745)
	at ......remote call to lucene(Native Method)
	at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1416)
	at hudson.remoting.UserResponse.retrieve(UserRequest.java:220)
	at hudson.remoting.Channel.call(Channel.java:781)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.execute(RemoteGitImpl.java:145)
	at sun.reflect.GeneratedMethodAccessor447.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at org.jenkinsci.plugins.gitclient.RemoteGitImpl$CommandInvocationHandler.invoke(RemoteGitImpl.java:131)
	at com.sun.proxy.$Proxy116.execute(Unknown Source)
	at hudson.plugins.git.GitSCM.fetchFrom(GitSCM.java:764)
	... 11 more
ERROR: null
Archiving artifacts
Recording test results
ERROR: Step ‘Publish JUnit test result report’ failed: No test report files were found. Configuration error?
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any