Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-7.x/85/
7 tests failed. FAILED: org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test Error Message: Expected numSlices=5 numReplicas=1 but found DocCollection(solrj_collection4//collections/solrj_collection4/state.json/26)={ "pullReplicas":"0", "replicationFactor":"1", "shards":{ "shard1":{ "range":"80000000-b332ffff", "state":"active", "replicas":{"core_node4":{ "dataDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node4/data/", "base_url":"http://127.0.0.1:38995", "node_name":"127.0.0.1:38995_", "type":"NRT", "ulogDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node4/data/tlog", "core":"solrj_collection4_shard1_replica_n1", "state":"active", "leader":"true"}}}, "shard2":{ "range":"b3330000-e665ffff", "state":"active", "replicas":{"core_node9":{ "dataDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node9/data/", "base_url":"http://127.0.0.1:38995", "node_name":"127.0.0.1:38995_", "type":"NRT", "ulogDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node9/data/tlog", "core":"solrj_collection4_shard2_replica_n2", "state":"active", "leader":"true"}}}, "shard3":{ "range":"e6660000-1998ffff", "state":"active", "replicas":{"core_node10":{ "dataDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node10/data/", "base_url":"http://127.0.0.1:38995", "node_name":"127.0.0.1:38995_", "type":"NRT", "ulogDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node10/data/tlog", "core":"solrj_collection4_shard3_replica_n3", "state":"active", "leader":"true"}}}, "shard4":{ "range":"19990000-4ccbffff", "state":"active", "replicas":{"core_node7":{ "core":"solrj_collection4_shard4_replica_n5", "base_url":"http://127.0.0.1:38995", "node_name":"127.0.0.1:38995_", "state":"down", "type":"NRT"}}}, "shard5":{ "range":"4ccc0000-7fffffff", "state":"active", "replicas":{"core_node8":{ "dataDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node8/data/", "base_url":"http://127.0.0.1:38141", "node_name":"127.0.0.1:38141_", "type":"NRT", "ulogDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node8/data/tlog", "core":"solrj_collection4_shard5_replica_n6", "state":"active", "leader":"true"}}}}, "router":{ "field":"text", "name":"compositeId"}, "maxShardsPerNode":"5", "autoAddReplicas":"true", "nrtReplicas":"1", "tlogReplicas":"0"} with /live_nodes: [127.0.0.1:38141_, 127.0.0.1:38995_, 127.0.0.1:40703_, 127.0.0.1:43146_, 127.0.0.1:45077_] Stack Trace: java.lang.AssertionError: Expected numSlices=5 numReplicas=1 but found DocCollection(solrj_collection4//collections/solrj_collection4/state.json/26)={ "pullReplicas":"0", "replicationFactor":"1", "shards":{ "shard1":{ "range":"80000000-b332ffff", "state":"active", "replicas":{"core_node4":{ "dataDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node4/data/", "base_url":"http://127.0.0.1:38995", "node_name":"127.0.0.1:38995_", "type":"NRT", "ulogDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node4/data/tlog", "core":"solrj_collection4_shard1_replica_n1", "state":"active", "leader":"true"}}}, "shard2":{ "range":"b3330000-e665ffff", "state":"active", "replicas":{"core_node9":{ "dataDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node9/data/", "base_url":"http://127.0.0.1:38995", "node_name":"127.0.0.1:38995_", "type":"NRT", "ulogDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node9/data/tlog", "core":"solrj_collection4_shard2_replica_n2", "state":"active", "leader":"true"}}}, "shard3":{ "range":"e6660000-1998ffff", "state":"active", "replicas":{"core_node10":{ "dataDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node10/data/", "base_url":"http://127.0.0.1:38995", "node_name":"127.0.0.1:38995_", "type":"NRT", "ulogDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node10/data/tlog", "core":"solrj_collection4_shard3_replica_n3", "state":"active", "leader":"true"}}}, "shard4":{ "range":"19990000-4ccbffff", "state":"active", "replicas":{"core_node7":{ "core":"solrj_collection4_shard4_replica_n5", "base_url":"http://127.0.0.1:38995", "node_name":"127.0.0.1:38995_", "state":"down", "type":"NRT"}}}, "shard5":{ "range":"4ccc0000-7fffffff", "state":"active", "replicas":{"core_node8":{ "dataDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node8/data/", "base_url":"http://127.0.0.1:38141", "node_name":"127.0.0.1:38141_", "type":"NRT", "ulogDir":"hdfs://lucene2-us-west.apache.org:46030/solr_hdfs_home/solrj_collection4/core_node8/data/tlog", "core":"solrj_collection4_shard5_replica_n6", "state":"active", "leader":"true"}}}}, "router":{ "field":"text", "name":"compositeId"}, "maxShardsPerNode":"5", "autoAddReplicas":"true", "nrtReplicas":"1", "tlogReplicas":"0"} with /live_nodes: [127.0.0.1:38141_, 127.0.0.1:38995_, 127.0.0.1:40703_, 127.0.0.1:43146_, 127.0.0.1:45077_] at __randomizedtesting.SeedInfo.seed([A0F64552C6F2A59B:28A27A88680EC863]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.assertSliceAndReplicaCount(SharedFSAutoReplicaFailoverTest.java:413) at org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.testBasics(SharedFSAutoReplicaFailoverTest.java:258) at org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test(SharedFSAutoReplicaFailoverTest.java:143) 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:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) 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:368) at java.lang.Thread.run(Thread.java:748) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsBasicDistributedZkTest Error Message: ObjectTracker found 1 object(s) that were not released!!! [NRTCachingDirectory] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NRTCachingDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:350) at org.apache.solr.core.SolrCore.cleanupOldIndexDirectories(SolrCore.java:3012) at org.apache.solr.core.SolrCore.close(SolrCore.java:1585) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:981) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1037) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:642) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) Stack Trace: java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [NRTCachingDirectory] org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: org.apache.lucene.store.NRTCachingDirectory at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42) at org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:348) at org.apache.solr.core.SolrCore.getNewIndexDir(SolrCore.java:350) at org.apache.solr.core.SolrCore.cleanupOldIndexDirectories(SolrCore.java:3012) at org.apache.solr.core.SolrCore.close(SolrCore.java:1585) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:981) at org.apache.solr.core.SolrCore.<init>(SolrCore.java:844) at org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1037) at org.apache.solr.core.CoreContainer.lambda$load$13(CoreContainer.java:642) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) at __randomizedtesting.SeedInfo.seed([A0F64552C6F2A59B]: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.teardownTestCases(SolrTestCaseJ4.java:298) at sun.reflect.GeneratedMethodAccessor183.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:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:897) 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:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.uninverting.TestDocTermOrds.testTriggerUnInvertLimit Error Message: Java heap space Stack Trace: java.lang.OutOfMemoryError: Java heap space at __randomizedtesting.SeedInfo.seed([A0F64552C6F2A59B:93446D96CB457F2C]:0) at org.apache.lucene.store.RAMFile.newBuffer(RAMFile.java:78) at org.apache.lucene.store.RAMFile.addBuffer(RAMFile.java:51) at org.apache.lucene.store.RAMOutputStream.switchCurrentBuffer(RAMOutputStream.java:164) at org.apache.lucene.store.RAMOutputStream.writeBytes(RAMOutputStream.java:150) at org.apache.lucene.store.DataOutput.copyBytes(DataOutput.java:278) at org.apache.lucene.store.MockIndexOutputWrapper.copyBytes(MockIndexOutputWrapper.java:165) at org.apache.lucene.codecs.lucene50.Lucene50CompoundFormat.write(Lucene50CompoundFormat.java:100) at org.apache.lucene.index.IndexWriter.createCompoundFile(IndexWriter.java:4959) at org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4456) at org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4032) at org.apache.lucene.index.SerialMergeScheduler.merge(SerialMergeScheduler.java:40) at org.apache.lucene.index.IndexWriter.maybeMerge(IndexWriter.java:2235) at org.apache.lucene.index.IndexWriter.processEvents(IndexWriter.java:5047) at org.apache.lucene.index.IndexWriter.updateDocuments(IndexWriter.java:1533) at org.apache.lucene.index.IndexWriter.addDocuments(IndexWriter.java:1506) at org.apache.lucene.index.RandomIndexWriter.addDocument(RandomIndexWriter.java:141) at org.apache.solr.uninverting.TestDocTermOrds.testTriggerUnInvertLimit(TestDocTermOrds.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:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) 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:368) FAILED: org.apache.lucene.spatial3d.TestGeo3DPoint.testRandomBig Error Message: Test abandoned because suite timeout was reached. Stack Trace: java.lang.Exception: Test abandoned because suite timeout was reached. at __randomizedtesting.SeedInfo.seed([62005F2114B529FB]:0) FAILED: junit.framework.TestSuite.org.apache.lucene.spatial3d.TestGeo3DPoint Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([62005F2114B529FB]:0) FAILED: org.apache.solr.TestDistributedSearch.test Error Message: Captured an uncaught exception in thread: Thread[id=52759, name=Thread-39619, state=RUNNABLE, group=TGRP-TestDistributedSearch] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=52759, name=Thread-39619, state=RUNNABLE, group=TGRP-TestDistributedSearch] at __randomizedtesting.SeedInfo.seed([A0F64552C6F2A59B:28A27A88680EC863]:0) Caused by: java.lang.AssertionError: Expected to find shardAddress in the up shard info: {error=org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded,trace=org.apache.solr.client.solrj.SolrServerException: Time allowed to handle this request exceeded at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:460) at org.apache.solr.handler.component.HttpShardHandlerFactory.makeLoadBalancedRequest(HttpShardHandlerFactory.java:273) at org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:175) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) ,time=14} at __randomizedtesting.SeedInfo.seed([A0F64552C6F2A59B]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.TestDistributedSearch.comparePartialResponses(TestDistributedSearch.java:1191) at org.apache.solr.TestDistributedSearch$1.run(TestDistributedSearch.java:1147) FAILED: org.apache.solr.update.CdcrUpdateLogTest.testSubReader Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([A0F64552C6F2A59B:ED2ECF31B6257449]:0) at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.update.CdcrUpdateLogTest.testSubReader(CdcrUpdateLogTest.java:583) 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:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) 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:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) 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:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 10905 lines...] [junit4] Suite: org.apache.lucene.spatial3d.TestGeo3DPoint [junit4] 2> ??? 19, 2017 2:25:35 ?? com.carrotsearch.randomizedtesting.ThreadLeakControl$2 evaluate [junit4] 2> WARNING: Suite execution timed out: org.apache.lucene.spatial3d.TestGeo3DPoint [junit4] 2> 1) Thread[id=17, name=SUITE-TestGeo3DPoint-seed#[62005F2114B529FB], state=RUNNABLE, group=TGRP-TestGeo3DPoint] [junit4] 2> at java.lang.Thread.getStackTrace(Thread.java:1559) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:696) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:693) [junit4] 2> at java.security.AccessController.doPrivileged(Native Method) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.getStackTrace(ThreadLeakControl.java:693) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.getThreadsWithTraces(ThreadLeakControl.java:709) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.formatThreadStacksFull(ThreadLeakControl.java:689) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.access$1000(ThreadLeakControl.java:65) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$2.evaluate(ThreadLeakControl.java:415) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:705) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$200(RandomizedRunner.java:139) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:626) [junit4] 2> 2) Thread[id=1, name=main, state=WAITING, group=main] [junit4] 2> at java.lang.Object.wait(Native Method) [junit4] 2> at java.lang.Thread.join(Thread.java:1252) [junit4] 2> at java.lang.Thread.join(Thread.java:1326) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:636) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:493) [junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:251) [junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:368) [junit4] 2> at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:13) [junit4] 2> 3) Thread[id=9, name=JUnit4-serializer-daemon, state=TIMED_WAITING, group=main] [junit4] 2> at java.lang.Thread.sleep(Native Method) [junit4] 2> at com.carrotsearch.ant.tasks.junit4.events.Serializer$1.run(Serializer.java:50) [junit4] 2> 4) Thread[id=18, name=TEST-TestGeo3DPoint.testRandomBig-seed#[62005F2114B529FB], state=RUNNABLE, group=TGRP-TestGeo3DPoint] [junit4] 2> at org.apache.lucene.spatial3d.geom.Plane.findIntersectionBounds(Plane.java:1097) [junit4] 2> at org.apache.lucene.spatial3d.geom.Plane.recordBounds(Plane.java:1214) [junit4] 2> at org.apache.lucene.spatial3d.geom.XYZBounds.addIntersection(XYZBounds.java:262) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoStandardPath$PathSegment.getBounds(GeoStandardPath.java:1147) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoStandardPath.getBounds(GeoStandardPath.java:427) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.verify(TestGeo3DPoint.java:846) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.doTestRandom(TestGeo3DPoint.java:548) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.testRandomBig(TestGeo3DPoint.java:480) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestGeo3DPoint -Dtests.method=testRandomBig -Dtests.seed=62005F2114B529FB -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt -Dtests.locale=zh-SG -Dtests.timezone=Indian/Reunion -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 7178s J2 | TestGeo3DPoint.testRandomBig <<< [junit4] > Throwable #1: java.lang.Exception: Test abandoned because suite timeout was reached. [junit4] > at __randomizedtesting.SeedInfo.seed([62005F2114B529FB]:0) [junit4] 2> ??? 19, 2017 2:25:35 ?? com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> ??? 19, 2017 2:25:56 ?? com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> SEVERE: 1 thread leaked from SUITE scope at org.apache.lucene.spatial3d.TestGeo3DPoint: [junit4] 2> 1) Thread[id=18, name=TEST-TestGeo3DPoint.testRandomBig-seed#[62005F2114B529FB], state=RUNNABLE, group=TGRP-TestGeo3DPoint] [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:366) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:46) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:441) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.verify(TestGeo3DPoint.java:846) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.doTestRandom(TestGeo3DPoint.java:548) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.testRandomBig(TestGeo3DPoint.java:480) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> ??? 19, 2017 2:25:56 ?? com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll [junit4] 2> INFO: Starting to interrupt leaked threads: [junit4] 2> 1) Thread[id=18, name=TEST-TestGeo3DPoint.testRandomBig-seed#[62005F2114B529FB], state=RUNNABLE, group=TGRP-TestGeo3DPoint] [junit4] 2> ??? 19, 2017 2:25:59 ?? com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll [junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated: [junit4] 2> 1) Thread[id=18, name=TEST-TestGeo3DPoint.testRandomBig-seed#[62005F2114B529FB], state=RUNNABLE, group=TGRP-TestGeo3DPoint] [junit4] 2> at org.apache.lucene.spatial3d.geom.Plane.findCrossings(Plane.java:990) [junit4] 2> at org.apache.lucene.spatial3d.geom.Plane.findCrossings(Plane.java:667) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$DualCrossingEdgeIterator.matches(GeoComplexPolygon.java:1077) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:553) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Node.traverse(GeoComplexPolygon.java:558) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:649) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon$Tree.traverse(GeoComplexPolygon.java:635) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.isWithin(GeoComplexPolygon.java:371) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoBaseMembershipShape.isWithin(GeoBaseMembershipShape.java:36) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoBaseShape.getBounds(GeoBaseShape.java:35) [junit4] 2> at org.apache.lucene.spatial3d.geom.GeoComplexPolygon.getBounds(GeoComplexPolygon.java:441) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.verify(TestGeo3DPoint.java:846) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.doTestRandom(TestGeo3DPoint.java:548) [junit4] 2> at org.apache.lucene.spatial3d.TestGeo3DPoint.testRandomBig(TestGeo3DPoint.java:480) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))}, docValues:{id=DocValuesFormat(name=Memory), point=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=2031, maxMBSortInHeap=5.940734755771191, sim=RandomSimilarity(queryNorm=false): {}, locale=zh-SG, timezone=Indian/Reunion [junit4] 2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=4,threads=2,free=125888688,total=491782144 [junit4] 2> NOTE: All tests run in this JVM: [XYZSolidTest, RandomBinaryCodecTest, TestGeo3DDocValues, TestGeo3DPoint] [junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestGeo3DPoint -Dtests.seed=62005F2114B529FB -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt -Dtests.locale=zh-SG -Dtests.timezone=Indian/Reunion -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 0.00s J2 | TestGeo3DPoint (suite) <<< [junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). [junit4] > at __randomizedtesting.SeedInfo.seed([62005F2114B529FB]:0) [junit4] Completed [15/15 (1!)] on J2 in 7223.70s, 6 tests, 2 errors <<< FAILURES! [...truncated 3763 lines...] [junit4] Suite: org.apache.solr.TestDistributedSearch [junit4] 2> 9272310 INFO (SUITE-TestDistributedSearch-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/init-core-data-001 [junit4] 2> 9272310 WARN (SUITE-TestDistributedSearch-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 9272311 INFO (SUITE-TestDistributedSearch-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 9272321 INFO (SUITE-TestDistributedSearch-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-9061) [junit4] 2> 9272321 INFO (SUITE-TestDistributedSearch-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 9272789 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/control/cores/collection1 [junit4] 2> 9272790 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 9272828 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2c1e6261{/,null,AVAILABLE} [junit4] 2> 9272844 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@71f6d6ff{HTTP/1.1,[http/1.1]}{127.0.0.1:40264} [junit4] 2> 9272845 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.e.j.s.Server Started @9291756ms [junit4] 2> 9272845 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=40264, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/control/cores} [junit4] 2> 9272845 ERROR (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 9272845 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0 [junit4] 2> 9272845 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 9272845 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 9272845 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-19T13:09:03.813Z [junit4] 2> 9272845 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/control/solr.xml [junit4] 2> 9272861 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 9272861 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 9272862 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 9273042 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e [junit4] 2> 9273079 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e [junit4] 2> 9273079 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e [junit4] 2> 9273093 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/control/cores [junit4] 2> 9273093 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 9273093 INFO (coreLoadExecutor-3821-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 9273144 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 9273290 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 9273395 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 9274150 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 9274172 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 9274173 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e [junit4] 2> 9274173 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 9274185 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 9274187 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.17404711810378054] [junit4] 2> 9274478 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 9274478 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 9274479 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 9274479 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 9274479 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=30, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=24.1962890625, floorSegmentMB=0.275390625, forceMergeDeletesPctAllowed=23.967881278800096, segmentsPerTier=31.0, maxCFSSegmentSizeMB=0.376953125, noCFSRatio=0.0 [junit4] 2> 9274480 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@26a1f0fc[collection1] main] [junit4] 2> 9274480 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 9274540 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 9274644 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 9274644 INFO (coreLoadExecutor-3821-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1584499990842048512 [junit4] 2> 9274646 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 9274646 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 9274646 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 9274646 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 9274646 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 9274646 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 9274647 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 9274647 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 9274647 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 9274666 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@26a1f0fc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 9275438 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 9275439 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531 [junit4] 2> 9275439 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@617f8ef0{/,null,AVAILABLE} [junit4] 2> 9275474 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@13c0606c{HTTP/1.1,[http/1.1]}{127.0.0.1:40361} [junit4] 2> 9275474 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.e.j.s.Server Started @9294386ms [junit4] 2> 9275474 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=40361, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/shard0/cores} [junit4] 2> 9275475 ERROR (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 9275475 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.2.0 [junit4] 2> 9275475 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 9275475 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 9275475 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-19T13:09:06.443Z [junit4] 2> 9275475 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/shard0/solr.xml [junit4] 2> 9275478 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 9275478 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 9275479 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 9275592 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e [junit4] 2> 9275621 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e [junit4] 2> 9275622 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e [junit4] 2> 9275623 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/shard0/cores [junit4] 2> 9275623 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 9275624 INFO (coreLoadExecutor-3832-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 9275625 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 9275732 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.2.0 [junit4] 2> 9275814 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 9276159 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 9276194 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 9276194 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3036c39e [junit4] 2> 9276194 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 9276194 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch_A0F64552C6F2A59B-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 9276208 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=41, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.17404711810378054] [junit4] 2> 9276391 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 9276391 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 9276392 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 9276392 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 9276393 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=30, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=24.1962890625, floorSegmentMB=0.275390625, forceMergeDeletesPctAllowed=23.967881278800096, segmentsPerTier=31.0, maxCFSSegmentSizeMB=0.376953125, noCFSRatio=0.0 [junit4] 2> 9276393 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@338ef339[collection1] main] [junit4] 2> 9276394 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 9276420 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 9276493 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 9276493 INFO (coreLoadExecutor-3832-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1584499992780865536 [junit4] 2> 9276508 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 9276508 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 9276508 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 9276508 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 9276509 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 9276509 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 9276509 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 9276509 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 9276509 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 9276511 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@338ef339[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 9276996 INFO (TEST-TestDistributedSearch.test-seed#[A0F64552C6F2A59B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 9277023 INFO (qtp1204685122-21000) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1584499993309347840)} 0 26 [junit4] 2> 9277037 INFO (qtp1802207947-21017) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1584499993337659392)} 0 13 [junit4] 2> 9277039 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1 (1584499993352339456)]} 0 1 [junit4] 2> 9277040 INFO (qtp1802207947-21018) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1 (1584499993353388032)]} 0 1 [junit4] 2> 9277041 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[2 (1584499993355485184)]} 0 0 [junit4] 2> 9277042 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[2 (1584499993355485184)]} 0 0 [junit4] 2> 9277042 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[3 (1584499993356533760)]} 0 0 [junit4] 2> 9277042 INFO (qtp1802207947-21020) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[3 (1584499993356533760)]} 0 0 [junit4] 2> 9277043 INFO (qtp1204685122-21004) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[4 (1584499993357582336)]} 0 0 [junit4] 2> 9277043 INFO (qtp1802207947-21021) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[4 (1584499993357582336)]} 0 0 [junit4] 2> 9277044 INFO (qtp1204685122-20997) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[5 (1584499993358630912)]} 0 0 [junit4] 2> 9277044 INFO (qtp1802207947-21014) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[5 (1584499993358630912)]} 0 0 [junit4] 2> 9277045 INFO (qtp1204685122-21000) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[6 (1584499993359679488)]} 0 0 [junit4] 2> 9277061 INFO (qtp1802207947-21017) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[6 (1584499993376456704)]} 0 0 [junit4] 2> 9277062 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[7 (1584499993377505280)]} 0 0 [junit4] 2> 9277062 INFO (qtp1802207947-21017) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[7 (1584499993377505280)]} 0 0 [junit4] 2> 9277063 INFO (qtp1204685122-21003) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[8 (1584499993378553856)]} 0 0 [junit4] 2> 9277063 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[8 (1584499993378553856)]} 0 0 [junit4] 2> 9277064 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[9 (1584499993378553857)]} 0 0 [junit4] 2> 9277064 INFO (qtp1802207947-21020) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[9 (1584499993379602432)]} 0 0 [junit4] 2> 9277064 INFO (qtp1204685122-21004) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1584499993379602432,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 9277064 INFO (qtp1204685122-21004) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5fb7ea54 commitCommandVersion:1584499993379602432 [junit4] 2> 9277212 INFO (qtp1204685122-21004) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@865a76a[collection1] main] [junit4] 2> 9277212 INFO (qtp1204685122-21004) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 9277214 INFO (searcherExecutor-3822-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@865a76a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C9)))} [junit4] 2> 9277214 INFO (qtp1204685122-21004) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 149 [junit4] 2> 9277214 INFO (qtp1802207947-21021) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1584499993536888832,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 9277214 INFO (qtp1802207947-21021) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1b59c8ba commitCommandVersion:1584499993536888832 [junit4] 2> 9277236 INFO (qtp1802207947-21021) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5bcd2cb[collection1] main] [junit4] 2> 9277237 INFO (qtp1802207947-21021) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 9277238 INFO (searcherExecutor-3833-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5bcd2cb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.2.0):C9)))} [junit4] 2> 9277238 INFO (qtp1802207947-21021) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 23 [junit4] 2> 9277241 INFO (qtp1204685122-20997) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[10 (1584499993563103232)]} 0 1 [junit4] 2> 9277263 INFO (qtp1802207947-21014) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[10 (1584499993565200384)]} 0 22 [junit4] 2> 9277277 INFO (qtp1204685122-21000) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[11 (1584499993602949120)]} 0 0 [junit4] 2> 9277278 INFO (qtp1802207947-21018) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[11 (1584499993602949120)]} 0 0 [junit4] 2> 9277278 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[12 (1584499993603997696)]} 0 0 [junit4] 2> 9277278 INFO (qtp1802207947-21017) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[12 (1584499993603997696)]} 0 0 [junit4] 2> 9277279 INFO (qtp1204685122-21003) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[13 (1584499993605046272)]} 0 0 [junit4] 2> 9277279 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[13 (1584499993605046272)]} 0 0 [junit4] 2> 9277280 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1001 (1584499993605046273)]} 0 0 [junit4] 2> 9277280 INFO (qtp1802207947-21020) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1001 (1584499993606094848)]} 0 0 [junit4] 2> 9277293 INFO (qtp1204685122-21004) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[14 (1584499993619726336)]} 0 0 [junit4] 2> 9277294 INFO (qtp1802207947-21021) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[14 (1584499993619726336)]} 0 0 [junit4] 2> 9277294 INFO (qtp1204685122-20997) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[15 (1584499993620774912)]} 0 0 [junit4] 2> 9277294 INFO (qtp1802207947-21014) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[15 (1584499993620774912)]} 0 0 [junit4] 2> 9277295 INFO (qtp1204685122-21000) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[16 (1584499993621823488)]} 0 0 [junit4] 2> 9277295 INFO (qtp1802207947-21018) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[16 (1584499993621823488)]} 0 0 [junit4] 2> 9277296 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[17 (1584499993622872064)]} 0 0 [junit4] 2> 9277296 INFO (qtp1802207947-21018) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[17 (1584499993622872064)]} 0 0 [junit4] 2> 9277297 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[100 (1584499993623920640)]} 0 0 [junit4] 2> 9277309 INFO (qtp1802207947-21018) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[100 (1584499993636503552)]} 0 0 [junit4] 2> 9277310 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[101 (1584499993637552128)]} 0 0 [junit4] 2> 9277310 INFO (qtp1802207947-21020) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[101 (1584499993637552128)]} 0 0 [junit4] 2> 9277311 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[102 (1584499993638600704)]} 0 0 [junit4] 2> 9277311 INFO (qtp1802207947-21020) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[102 (1584499993638600704)]} 0 0 [junit4] 2> 9277311 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[103 (1584499993638600705)]} 0 0 [junit4] 2> 9277312 INFO (qtp1802207947-21020) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[103 (1584499993639649280)]} 0 0 [junit4] 2> 9277312 INFO (qtp1204685122-21001) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[104 (1584499993639649280)]} 0 0 [junit4] 2> 9277313 INFO (qtp1802207947-21017) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[104 (1584499993639649281)]} 0 0 [junit4] 2> 9277313 INFO (qtp1204685122-21003) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[105 (1584499993640697856)]} 0 0 [junit4] 2> 9277321 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[105 (1584499993649086464)]} 0 0 [junit4] 2> 9277322 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[106 (1584499993650135040)]} 0 0 [junit4] 2> 9277322 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[106 (1584499993650135040)]} 0 0 [junit4] 2> 9277322 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[107 (1584499993650135041)]} 0 0 [junit4] 2> 9277323 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[107 (1584499993651183616)]} 0 0 [junit4] 2> 9277323 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[108 (1584499993651183616)]} 0 0 [junit4] 2> 9277324 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[108 (1584499993651183617)]} 0 0 [junit4] 2> 9277324 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[109 (1584499993652232192)]} 0 0 [junit4] 2> 9277331 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[109 (1584499993659572224)]} 0 0 [junit4] 2> 9277332 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[110 (1584499993660620800)]} 0 0 [junit4] 2> 9277332 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[110 (1584499993660620800)]} 0 0 [junit4] 2> 9277332 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[111 (1584499993660620801)]} 0 0 [junit4] 2> 9277346 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[111 (1584499993675300864)]} 0 0 [junit4] 2> 9277346 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[112 (1584499993675300864)]} 0 0 [junit4] 2> 9277347 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[112 (1584499993676349440)]} 0 0 [junit4] 2> 9277347 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[113 (1584499993676349440)]} 0 0 [junit4] 2> 9277348 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[113 (1584499993676349441)]} 0 0 [junit4] 2> 9277348 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[114 (1584499993677398016)]} 0 0 [junit4] 2> 9277348 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[114 (1584499993677398016)]} 0 0 [junit4] 2> 9277349 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[115 (1584499993677398017)]} 0 0 [junit4] 2> 9277349 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[115 (1584499993678446592)]} 0 0 [junit4] 2> 9277349 INFO (qtp1204685122-21002) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[116 (1584499993678446592)]} 0 0 [junit4] 2> 9277366 INFO (qtp1802207947-21019) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[116 (1584499993696272384)]} 0 16 [junit4] 2> 9277399 INFO (qtp1204685122-20997) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[117 (1584499993730875392)]} 0 0 [junit4] 2> 9277399 INFO (qtp1802207947-21021) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[117 (1584499993730875392)]} 0 0 [junit4] 2> 9277400 INFO (qtp1204685122-20997) [ x [...truncated too long message...] FO (TEST-CdcrUpdateLogTest.testRemoveOldLogs-seed#[A0F64552C6F2A59B]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1584504894448992258,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 13951088 INFO (TEST-CdcrUpdateLogTest.testRemoveOldLogs-seed#[A0F64552C6F2A59B]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2e5a50d commitCommandVersion:1584504894448992258 [junit4] 2> 13951364 INFO (TEST-CdcrUpdateLogTest.testRemoveOldLogs-seed#[A0F64552C6F2A59B]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c28b396[collection1] main] [junit4] 2> 13951364 INFO (TEST-CdcrUpdateLogTest.testRemoveOldLogs-seed#[A0F64552C6F2A59B]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 13951366 INFO (searcherExecutor-8241-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c28b396[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1d(7.2.0):C125) Uninverting(_1e(7.2.0):c10) Uninverting(_1f(7.2.0):c105)))} [junit4] 2> 13951367 INFO (TEST-CdcrUpdateLogTest.testRemoveOldLogs-seed#[A0F64552C6F2A59B]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 278 [junit4] 2> 13951367 INFO (TEST-CdcrUpdateLogTest.testRemoveOldLogs-seed#[A0F64552C6F2A59B]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={qt=/get&getVersions=50&wt=xml} status=0 QTime=0 [junit4] 2> 13951367 INFO (TEST-CdcrUpdateLogTest.testRemoveOldLogs-seed#[A0F64552C6F2A59B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRemoveOldLogs [junit4] 2> 13951368 INFO (SUITE-CdcrUpdateLogTest-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 13951368 INFO (SUITE-CdcrUpdateLogTest-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1471956145 [junit4] 2> 13951368 INFO (SUITE-CdcrUpdateLogTest-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 13951368 INFO (SUITE-CdcrUpdateLogTest-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@35b88ac9: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@5bc2f5c3 [junit4] 2> 13951404 INFO (SUITE-CdcrUpdateLogTest-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 13951405 INFO (SUITE-CdcrUpdateLogTest-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@65ead4db: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@59ef9e7f [junit4] 2> 13951440 INFO (SUITE-CdcrUpdateLogTest-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 13951440 INFO (SUITE-CdcrUpdateLogTest-seed#[A0F64552C6F2A59B]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@56c4bb4b: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@5dd0019a [junit4] 2> 13951492 INFO (coreCloseExecutor-8246-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6e8bcbd9 [junit4] 2> 13951492 INFO (coreCloseExecutor-8246-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1854655449 [junit4] 2> 13951492 INFO (coreCloseExecutor-8246-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@54279d28: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@70dfd540 [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J0/temp/solr.update.CdcrUpdateLogTest_A0F64552C6F2A59B-001 [junit4] 2> Nov 19, 2017 2:27:02 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=false): {}, locale=de-LU, timezone=Europe/Rome [junit4] 2> NOTE: Linux 4.4.0-83-generic amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=4,threads=1,free=161211184,total=523763712 [junit4] 2> NOTE: All tests run in this JVM: [DistributedDebugComponentTest, TestCollectionAPIs, TestIBSimilarityFactory, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestCloudInspectUtil, TestLocalFSCloudBackupRestore, TestFoldingMultitermQuery, SoftAutoCommitTest, LeaderElectionIntegrationTest, TestJavabinTupleStreamParser, TestPullReplicaErrorHandling, DistributedQueueTest, DistanceUnitsTest, TlogReplayBufferedWhileIndexingTest, BadCopyFieldTest, TestCodecSupport, MoveReplicaTest, TestBadConfig, TestFastOutputStream, SolrShardReporterTest, DateMathParserTest, TestReversedWildcardFilterFactory, TestStressCloudBlindAtomicUpdates, TestPHPSerializedResponseWriter, CurrencyFieldTypeTest, SliceStateTest, TestDistributedStatsComponentCardinality, UninvertDocValuesMergePolicyTest, TestSchemaVersionResource, ActionThrottleTest, TestMergePolicyConfig, AssignBackwardCompatibilityTest, TestSubQueryTransformerDistrib, TestMacroExpander, TestShortCircuitedRequests, TestManagedStopFilterFactory, TestFieldCacheReopen, IndexSchemaRuntimeFieldTest, ResponseHeaderTest, ForceLeaderTest, DistributedFacetPivotLargeTest, PeerSyncTest, TestJoin, TestManagedSchemaThreadSafety, UpdateParamsTest, TestConfigSetsAPI, CacheHeaderTest, RestartWhileUpdatingTest, BasicFunctionalityTest, SpellCheckCollatorTest, ResourceLoaderTest, TestReplicationHandler, LeaderInitiatedRecoveryOnShardRestartTest, TestJsonFacetRefinement, TestDocBasedVersionConstraints, HdfsUnloadDistributedZkTest, TestConfigSetProperties, DistributedQueryComponentOptimizationTest, SimpleFacetsTest, TestRandomFaceting, HdfsSyncSliceTest, SearchHandlerTest, TestCSVLoader, TestSolrCloudWithDelegationTokens, ConnectionManagerTest, SegmentsInfoRequestHandlerTest, TestFieldCacheVsDocValues, TestIndexingPerformance, CursorPagingTest, TestClusterStateMutator, SolrGangliaReporterTest, SyncSliceTest, StatelessScriptUpdateProcessorFactoryTest, TestFieldSortValues, TestDistributedSearch, TestDownShardTolerantSearch, TestTrieFacet, MetricsHandlerTest, CleanupOldIndexTest, TestNumericRangeQuery64, TestCustomStream, NoCacheHeaderTest, TestDFRSimilarityFactory, TestClusterProperties, TestAuthorizationFramework, TestExportWriter, DeleteReplicaTest, TestSweetSpotSimilarityFactory, ExitableDirectoryReaderTest, AnalyticsMergeStrategyTest, TestQueryUtils, ZkFailoverTest, TestSolrIndexConfig, TestCryptoKeys, TestSQLHandler, OverseerTaskQueueTest, TimePartitionedUpdateProcessorTest, VersionInfoTest, SpatialHeatmapFacetsTest, CloudMLTQParserTest, TestLegacyField, TestPostingsSolrHighlighter, TestInPlaceUpdatesDistrib, HLLUtilTest, TestUtils, ZkControllerTest, AnalysisAfterCoreReloadTest, TestComponentsName, TestExactSharedStatsCache, JvmMetricsTest, TestSolrCloudWithHadoopAuthPlugin, TestCloudManagedSchema, TermVectorComponentTest, TestPivotHelperCode, BigEndianAscendingWordDeserializerTest, TestSuggestSpellingConverter, TestTestInjection, TestCloudPseudoReturnFields, SimpleCollectionCreateDeleteTest, TestTlogReplica, CdcrReplicationHandlerTest, CdcrBidirectionalTest, CdcrBootstrapTest, HdfsBasicDistributedZkTest, TestCopyFieldCollectionResource, TestDynamicFieldCollectionResource, TestFieldCollectionResource, TestSchemaNameResource, TestSchemaSimilarityResource, TestManagedSynonymFilterFactory, ChangedSchemaMergeTest, DocValuesMissingTest, TestBulkSchemaConcurrent, AnalyticsQueryTest, LargeFieldTest, MergeStrategyTest, TestComplexPhraseLeadingWildcard, TestCustomSort, TestGraphTermsQParserPlugin, TestInitQParser, TestMissingGroups, TestRecoveryHdfs, TestDistribIDF, TestSha256AuthenticationProvider, TestImpersonationWithHadoopAuth, BlockDirectoryTest, TestDocTermOrds, AddBlockUpdateTest, CdcrUpdateLogTest] [junit4] Completed [728/749 (5!)] on J0 in 60.10s, 12 tests, 1 failure <<< FAILURES! [...truncated 87 lines...] [junit4] JVM J0: stdout was not empty, see: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/temp/junit4-J0-20171119_103411_837842076705073708169.sysout [junit4] >>> JVM J0 emitted unexpected output (verbatim) ---- [junit4] java.lang.OutOfMemoryError: Java heap space [junit4] Dumping heap to /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/heapdumps/java_pid22797.hprof ... [junit4] Heap dump file created [459542533 bytes in 4.658 secs] [junit4] <<< JVM J0: EOF ---- [...truncated 8453 lines...] BUILD FAILED /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:843: The following error occurred while executing this line: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:787: Some of the tests produced a heap dump, but did not fail. Maybe a suppressed OutOfMemoryError? Dumps created: * java_pid22797.hprof Total time: 892 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-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org