Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1849/
2 tests failed. FAILED: org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([35554349D37B0989:4EEFD7C76441959]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:941) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:901) at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:569) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) 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:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) 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 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.base/java.lang.Thread.run(Thread.java:834) Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/long[@name='hits' and 3 <= . and . <= 13] xml response was: <?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">4</int></lst><result name="response" numFound="0" start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst name="everother"><int name="numFound">1</int><int name="startOffset">9</int><int name="endOffset">18</int><arr name="suggestion"><str>everyother</str></arr></lst></lst><lst name="collations"><lst name="collation"><str name="collationQuery">teststop:everyother</str><long name="hits">14</long><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst> </response> request was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5 at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:934) ... 40 more FAILED: org.apache.solr.cloud.autoscaling.HdfsAutoAddReplicasIntegrationTest.testSimple Error Message: Waiting for collection testSimple2 Timeout waiting to see state for collection=testSimple2 :DocCollection(testSimple2//collections/testSimple2/state.json/25)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node2":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node2/data/", "base_url":"http://127.0.0.1:42384/solr", "node_name":"127.0.0.1:42384_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node2/data/tlog", "core":"testSimple2_shard1_replica_n1", "shared_storage":"true", "state":"down"}, "core_node5":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node5/data/", "base_url":"http://127.0.0.1:43787/solr", "node_name":"127.0.0.1:43787_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node5/data/tlog", "core":"testSimple2_shard1_replica_n3", "shared_storage":"true", "state":"active", "leader":"true"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{ "core_node7":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node7/data/", "base_url":"http://127.0.0.1:42384/solr", "node_name":"127.0.0.1:42384_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node7/data/tlog", "core":"testSimple2_shard2_replica_n4", "shared_storage":"true", "state":"down"}, "core_node8":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node8/data/", "base_url":"http://127.0.0.1:43787/solr", "node_name":"127.0.0.1:43787_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node8/data/tlog", "core":"testSimple2_shard2_replica_n6", "shared_storage":"true", "state":"active", "leader":"true"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2", "autoAddReplicas":"true", "nrtReplicas":"2", "tlogReplicas":"0"} Live Nodes: [127.0.0.1:35328_solr, 127.0.0.1:43787_solr] Last available state: DocCollection(testSimple2//collections/testSimple2/state.json/25)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node2":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node2/data/", "base_url":"http://127.0.0.1:42384/solr", "node_name":"127.0.0.1:42384_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node2/data/tlog", "core":"testSimple2_shard1_replica_n1", "shared_storage":"true", "state":"down"}, "core_node5":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node5/data/", "base_url":"http://127.0.0.1:43787/solr", "node_name":"127.0.0.1:43787_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node5/data/tlog", "core":"testSimple2_shard1_replica_n3", "shared_storage":"true", "state":"active", "leader":"true"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{ "core_node7":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node7/data/", "base_url":"http://127.0.0.1:42384/solr", "node_name":"127.0.0.1:42384_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node7/data/tlog", "core":"testSimple2_shard2_replica_n4", "shared_storage":"true", "state":"down"}, "core_node8":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node8/data/", "base_url":"http://127.0.0.1:43787/solr", "node_name":"127.0.0.1:43787_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node8/data/tlog", "core":"testSimple2_shard2_replica_n6", "shared_storage":"true", "state":"active", "leader":"true"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2", "autoAddReplicas":"true", "nrtReplicas":"2", "tlogReplicas":"0"} Stack Trace: java.lang.AssertionError: Waiting for collection testSimple2 Timeout waiting to see state for collection=testSimple2 :DocCollection(testSimple2//collections/testSimple2/state.json/25)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node2":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node2/data/", "base_url":"http://127.0.0.1:42384/solr", "node_name":"127.0.0.1:42384_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node2/data/tlog", "core":"testSimple2_shard1_replica_n1", "shared_storage":"true", "state":"down"}, "core_node5":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node5/data/", "base_url":"http://127.0.0.1:43787/solr", "node_name":"127.0.0.1:43787_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node5/data/tlog", "core":"testSimple2_shard1_replica_n3", "shared_storage":"true", "state":"active", "leader":"true"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{ "core_node7":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node7/data/", "base_url":"http://127.0.0.1:42384/solr", "node_name":"127.0.0.1:42384_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node7/data/tlog", "core":"testSimple2_shard2_replica_n4", "shared_storage":"true", "state":"down"}, "core_node8":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node8/data/", "base_url":"http://127.0.0.1:43787/solr", "node_name":"127.0.0.1:43787_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node8/data/tlog", "core":"testSimple2_shard2_replica_n6", "shared_storage":"true", "state":"active", "leader":"true"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2", "autoAddReplicas":"true", "nrtReplicas":"2", "tlogReplicas":"0"} Live Nodes: [127.0.0.1:35328_solr, 127.0.0.1:43787_solr] Last available state: DocCollection(testSimple2//collections/testSimple2/state.json/25)={ "pullReplicas":"0", "replicationFactor":"2", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node2":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node2/data/", "base_url":"http://127.0.0.1:42384/solr", "node_name":"127.0.0.1:42384_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node2/data/tlog", "core":"testSimple2_shard1_replica_n1", "shared_storage":"true", "state":"down"}, "core_node5":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node5/data/", "base_url":"http://127.0.0.1:43787/solr", "node_name":"127.0.0.1:43787_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node5/data/tlog", "core":"testSimple2_shard1_replica_n3", "shared_storage":"true", "state":"active", "leader":"true"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{ "core_node7":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node7/data/", "base_url":"http://127.0.0.1:42384/solr", "node_name":"127.0.0.1:42384_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node7/data/tlog", "core":"testSimple2_shard2_replica_n4", "shared_storage":"true", "state":"down"}, "core_node8":{ "dataDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node8/data/", "base_url":"http://127.0.0.1:43787/solr", "node_name":"127.0.0.1:43787_solr", "type":"NRT", "force_set_state":"false", "ulogDir":"hdfs://localhost:35040/solr_hdfs_home/testSimple2/core_node8/data/tlog", "core":"testSimple2_shard2_replica_n6", "shared_storage":"true", "state":"active", "leader":"true"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2", "autoAddReplicas":"true", "nrtReplicas":"2", "tlogReplicas":"0"} at __randomizedtesting.SeedInfo.seed([35554349D37B0989:DE667B7F488DD58]:0) at org.junit.Assert.fail(Assert.java:88) at org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:310) at org.apache.solr.cloud.autoscaling.AutoAddReplicasIntegrationTest.testSimple(AutoAddReplicasIntegrationTest.java:169) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:566) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) 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:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) 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 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.base/java.lang.Thread.run(Thread.java:834) Build Log: [...truncated 14005 lines...] [junit4] Suite: org.apache.solr.spelling.SpellCheckCollatorTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.spelling.SpellCheckCollatorTest_35554349D37B0989-001/init-core-data-001 [junit4] 2> 2007377 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2007407 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 2007430 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 2007527 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2007608 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true] [junit4] 2> 2007611 WARN (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@fd0b933[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2007614 WARN (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1d3f4ee4[provider=null,keyStore=null,trustStore=null] [junit4] 2> 2007633 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2007633 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2007658 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2fb8882b [junit4] 2> 2007673 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2fb8882b [junit4] 2> 2007673 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2fb8882b [junit4] 2> 2007676 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2007697 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 2007730 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2007872 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2007882 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2007883 INFO (coreLoadExecutor-7020-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@2fb8882b [junit4] 2> 2007883 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.spelling.SpellCheckCollatorTest_35554349D37B0989-001/init-core-data-001/] [junit4] 2> 2007885 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 2007957 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2007957 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2007958 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@3a51391a [junit4] 2> 2007959 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@625a2c99[collection1] main] [junit4] 2> 2007959 WARN (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead. [junit4] 2> 2007960 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2007994 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default [junit4] 2> 2008005 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: default_teststop [junit4] 2> 2008005 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop} [junit4] 2> 2008005 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt} [junit4] 2> 2008017 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold [junit4] 2> 2008018 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29} [junit4] 2> 2008018 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: threshold_direct [junit4] 2> 2008028 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: multipleFields [junit4] 2> 2008071 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: freq [junit4] 2> 2008088 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Registering newSearcher listener for spellchecker: fqcn [junit4] 2> 2008089 INFO (coreLoadExecutor-7020-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2008090 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2008092 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default_teststop [junit4] 2> 2008093 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 2008093 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct_lowerfilt [junit4] 2> 2008093 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2008093 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold [junit4] 2> 2008095 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 3 [junit4] 2> 2008099 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: threshold_direct [junit4] 2> 2008099 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 2008099 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 2008100 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 2008100 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 2008101 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 2008101 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 2008102 INFO (searcherExecutor-7021-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@625a2c99[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2008122 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 24 [junit4] 2> 2008138 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 14 [junit4] 2> 2008177 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 38 [junit4] 2> 2008180 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 1 [junit4] 2> 2008217 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 37 [junit4] 2> 2008219 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0 [junit4] 2> 2008298 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 78 [junit4] 2> 2008300 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 1 [junit4] 2> 2008312 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 12 [junit4] 2> 2008314 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[10]} 0 0 [junit4] 2> 2008322 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[11]} 0 7 [junit4] 2> 2008323 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[12]} 0 0 [junit4] 2> 2008331 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[13]} 0 8 [junit4] 2> 2008333 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[14]} 0 0 [junit4] 2> 2008347 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[15]} 0 13 [junit4] 2> 2008349 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[16]} 0 0 [junit4] 2> 2008349 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2008349 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3e180cad commitCommandVersion:0 [junit4] 2> 2008370 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a560917[collection1] main] [junit4] 2> 2008370 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2008370 INFO (searcherExecutor-7021-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default [junit4] 2> 2008467 INFO (searcherExecutor-7021-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: default_teststop [junit4] 2> 2008534 INFO (searcherExecutor-7021-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold [junit4] 2> 2008557 INFO (searcherExecutor-7021-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: threshold_direct [junit4] 2> 2008557 INFO (searcherExecutor-7021-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: multipleFields [junit4] 2> 2008628 INFO (searcherExecutor-7021-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: freq [junit4] 2> 2008934 INFO (searcherExecutor-7021-thread-1) [ ] o.a.s.h.c.SpellCheckComponent Building spell index for spell checker: fqcn [junit4] 2> 2009013 INFO (searcherExecutor-7021-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a560917[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(9.0.0):c2:[diagnostics={timestamp=1558034123096, os=Linux, java.runtime.version=11.0.1+13-LTS, mergeFactor=1, os.arch=amd64, source=merge, java.vendor=Oracle Corporation, os.version=4.4.0-137-generic, mergeMaxNumSegments=-1, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(9.0.0):c2:[diagnostics={os.version=4.4.0-137-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1558034123071, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.1+13-LTS}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_3(9.0.0):c2:[diagnostics={os.version=4.4.0-137-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1558034123120, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.1+13-LTS}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(9.0.0):c2:[diagnostics={os.version=4.4.0-137-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1558034123158, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.1+13-LTS}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(9.0.0):c2:[diagnostics={os.version=4.4.0-137-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1558034123225, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.1+13-LTS}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_6(9.0.0):c2:[diagnostics={os.version=4.4.0-137-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1558034123236, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.1+13-LTS}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_7(9.0.0):c2:[diagnostics={os.version=4.4.0-137-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1558034123245, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.1+13-LTS}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_8(9.0.0):c2:[diagnostics={os.version=4.4.0-137-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1558034123256, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.1+13-LTS}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_9(9.0.0):c1:[diagnostics={os.version=4.4.0-137-generic, os=Linux, java.vendor=Oracle Corporation, timestamp=1558034123279, java.version=11.0.1, java.vm.version=11.0.1+13-LTS, lucene.version=9.0.0, source=flush, os.arch=amd64, java.runtime.version=11.0.1+13-LTS}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))} [junit4] 2> 2009013 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 664 [junit4] 2> 2009178 INFO (TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={mm=1&q=partisian+politcal+mashine&defType=edismax&spellcheck.dictionary=direct&qt=/spellCheckCompRH&spellcheck=true&qf=teststop&spellcheck.maxCollations=10&spellcheck.count=10&spellcheck.maxCollationTries=10&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=157 [junit4] 2> 2009230 INFO (TEST-SpellCheckCollatorTest.testCollateWithOverride-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={mm=1&spellcheck.dictionary=direct&qt=/spellCheckCompRH&spellcheck.maxCollations=10&spellcheck.maxCollationTries=10&q=partisian+politcal+mashine&defType=edismax&spellcheck.collateParam.mm=100%25&spellcheck=true&qf=teststop&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=51 [junit4] 2> 2009277 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia} hits=0 status=0 QTime=6 [junit4] 2> 2009282 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=0} hits=0 status=0 QTime=4 [junit4] 2> 2009288 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=30} hits=0 status=0 QTime=4 [junit4] 2> 2009293 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=100} hits=0 status=0 QTime=4 [junit4] 2> 2009299 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10000} hits=0 status=0 QTime=5 [junit4] 2> 2009305 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=4 [junit4] 2> 2009311 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=15} hits=0 status=0 QTime=4 [junit4] 2> 2009317 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=4 [junit4] 2> 2009322 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=4 [junit4] 2> 2009331 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=15} hits=0 status=0 QTime=8 [junit4] 2> 2009336 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=4 [junit4] 2> 2009353 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=11 [junit4] 2> 2009358 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=4 [junit4] 2> 2009363 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=4 [junit4] 2> 2009368 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6} hits=0 status=0 QTime=4 [junit4] 2> 2009373 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6} hits=0 status=0 QTime=3 [junit4] 2> 2009377 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=13} hits=0 status=0 QTime=3 [junit4] 2> 2009380 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=3 [junit4] 2> 2009384 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=3 [junit4] 2> 2009388 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=3 [junit4] 2> 2009392 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=13} hits=0 status=0 QTime=3 [junit4] 2> 2009395 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=2 [junit4] 2> 2009399 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=3 [junit4] 2> 2009403 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=3 [junit4] 2> 2009407 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=4} hits=0 status=0 QTime=3 [junit4] 2> 2009414 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=1} hits=0 status=0 QTime=5 [junit4] 2> 2009421 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6} hits=0 status=0 QTime=6 [junit4] 2> 2009425 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=3 [junit4] 2> 2009432 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=5 [junit4] 2> 2009437 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=5 [junit4] 2> 2009443 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=4 [junit4] 2> 2009449 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=5 [junit4] 2> 2009455 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=2} hits=0 status=0 QTime=4 [junit4] 2> 2009460 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=5 [junit4] 2> 2009466 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=14} hits=0 status=0 QTime=4 [junit4] 2> 2009470 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=4} hits=0 status=0 QTime=3 [junit4] 2> 2009473 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=13} hits=0 status=0 QTime=3 [junit4] 2> 2009477 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=2 [junit4] 2> 2009481 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=2 [junit4] 2> 2009488 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6} hits=0 status=0 QTime=6 [junit4] 2> 2009492 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=3 [junit4] 2> 2009496 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=3 [junit4] 2> 2009500 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=15} hits=0 status=0 QTime=3 [junit4] 2> 2009504 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=3 [junit4] 2> 2009508 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=3 [junit4] 2> 2009513 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=15} hits=0 status=0 QTime=3 [junit4] 2> 2009520 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=2} hits=0 status=0 QTime=6 [junit4] 2> 2009525 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=4 [junit4] 2> 2009530 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=2} hits=0 status=0 QTime=4 [junit4] 2> 2009536 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=13} hits=0 status=0 QTime=4 [junit4] 2> 2009543 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=6 [junit4] 2> 2009547 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=3 [junit4] 2> 2009551 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=3 [junit4] 2> 2009559 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=6} hits=0 status=0 QTime=7 [junit4] 2> 2009567 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=15} hits=0 status=0 QTime=7 [junit4] 2> 2009578 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=9 [junit4] 2> 2009585 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=6 [junit4] 2> 2009592 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=6 [junit4] 2> 2009597 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=2} hits=0 status=0 QTime=4 [junit4] 2> 2009602 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:metnoia&spellcheck.collateMaxCollectDocs=11} hits=0 status=0 QTime=3 [junit4] 2> 2009608 INFO (TEST-SpellCheckCollatorTest.testEstimatedHitCounts-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=4 [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=SpellCheckCollatorTest -Dtests.method=testEstimatedHitCounts -Dtests.seed=35554349D37B0989 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt -Dtests.locale=et-EE -Dtests.timezone=Australia/Tasmania -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.35s J0 | SpellCheckCollatorTest.testEstimatedHitCounts <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([35554349D37B0989:4EEFD7C76441959]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:941) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:901) [junit4] > at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:569) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:566) [junit4] > at java.base/java.lang.Thread.run(Thread.java:834) [junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/long[@name='hits' and 3 <= . and . <= 13] [junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] > <response> [junit4] > <lst name="responseHeader"><int name="status">0</int><int name="QTime">4</int></lst><result name="response" numFound="0" start="0"></result><lst name="spellcheck"><lst name="suggestions"><lst name="everother"><int name="numFound">1</int><int name="startOffset">9</int><int name="endOffset">18</int><arr name="suggestion"><str>everyother</str></arr></lst></lst><lst name="collations"><lst name="collation"><str name="collationQuery">teststop:everyother</str><long name="hits">14</long><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst> [junit4] > </response> [junit4] > request was:spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&q=teststop:everother&spellcheck.collateMaxCollectDocs=5 [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:934) [junit4] > ... 40 more [junit4] 1> id:[1 TO 10] AND lowerfilt:love [junit4] 2> 2010166 INFO (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.build=true&spellcheck.extendedResults=true&q=teststop:(flew+AND+form+AND+heathrow)&spellcheck.maxResultsForSuggest=0&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=8 [junit4] 2> 2010174 INFO (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.extendedResults=true&q=teststop:(june+AND+customs)&spellcheck.maxResultsForSuggest=1&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=1 status=0 QTime=5 [junit4] 2> 2010177 INFO (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={mm=2&q=teststop:(june+customs)&qt=/spellCheckCompRH&spellcheck.dictionary=direct&indent=true&spellcheck=true&spellcheck.count=10&spellcheck.alternativeTermCount=0&wt=xml&spellcheck.collate=true} hits=2 status=0 QTime=1 [junit4] 2> 2010234 INFO (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.build=true&spellcheck.extendedResults=true&q=teststop:(flew+AND+form+AND+heathrow)&spellcheck.maxResultsForSuggest=0&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=0 status=0 QTime=56 [junit4] 2> 2010239 INFO (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={spellcheck.collateExtendedResults=true&qt=/spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck.maxCollations=1&spellcheck.maxCollationTries=10&spellcheck.alternativeTermCount=5&spellcheck.extendedResults=true&q=teststop:(june+AND+customs)&spellcheck.maxResultsForSuggest=1&spellcheck=true&spellcheck.count=10&wt=xml&spellcheck.collate=true} hits=1 status=0 QTime=3 [junit4] 2> 2010242 INFO (TEST-SpellCheckCollatorTest.testContextSensitiveCollate-seed#[35554349D37B0989]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={mm=2&q=teststop:(june+customs)&qt=/spellCheckCompRH&spellcheck.dictionary=default_teststop&indent=true&spellcheck=true&spellcheck.count=10&spellcheck.alternativeTermCount=0&wt=xml&spellcheck.collate=true} hits=2 status=0 QTime=1 [junit4] 2> 2010243 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=304105115 [junit4] 2> 2010244 INFO (coreCloseExecutor-7025-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@67d66cb3 [junit4] 2> 2010244 INFO (coreCloseExecutor-7025-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=67d66cb3 [junit4] 2> 2010244 INFO (coreCloseExecutor-7025-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3d4bd178: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1b365be5 [junit4] 2> 2010262 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2010262 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@404adaf6: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@309d8d2f [junit4] 2> 2010272 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2010272 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@166ea2ce: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@b2d57f1 [junit4] 2> 2010279 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2010279 INFO (SUITE-SpellCheckCollatorTest-seed#[35554349D37B0989]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@62cface4: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@21623257 [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.spelling.SpellCheckCollatorTest_35554349D37B0989-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene80): {start1=PostingsFormat(name=Direct), range_facet_l_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), intDefault=PostingsFormat(name=MockRandom), range_facet_l=PostingsFormat(name=MockRandom), lowerfilt1and2=PostingsFormat(name=LuceneVarGapDocFreqInterval), end4=PostingsFormat(name=Direct), end3=PostingsFormat(name=LuceneVarGapDocFreqInterval), end2=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), end1=PostingsFormat(name=MockRandom), lowerfilt=PostingsFormat(name=LuceneVarGapDocFreqInterval), gram1=PostingsFormat(name=MockRandom), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), gram2=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), gram3=PostingsFormat(name=LuceneVarGapDocFreqInterval), start3=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), gram4=PostingsFormat(name=Direct), start2=PostingsFormat(name=LuceneVarGapDocFreqInterval), timestamp=PostingsFormat(name=MockRandom), start4=PostingsFormat(name=MockRandom), lowerfilt1=PostingsFormat(name=Direct), teststop=PostingsFormat(name=LuceneVarGapDocFreqInterval), _root_=PostingsFormat(name=MockRandom), id_i1=PostingsFormat(name=LuceneVarGapDocFreqInterval), range_facet_i_dv=PostingsFormat(name=MockRandom), word=PostingsFormat(name=MockRandom)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), multiDefault=DocValuesFormat(name=Asserting), teststop=DocValuesFormat(name=Asserting), _root_=DocValuesFormat(name=Lucene80), intDefault=DocValuesFormat(name=Lucene80), range_facet_l=DocValuesFormat(name=Lucene80), lowerfilt1and2=DocValuesFormat(name=Asserting), id_i1=DocValuesFormat(name=Asserting), lowerfilt=DocValuesFormat(name=Asserting), range_facet_i_dv=DocValuesFormat(name=Lucene80), id=DocValuesFormat(name=Direct), intDvoDefault=DocValuesFormat(name=Lucene80), timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=621, maxMBSortInHeap=5.808596316163167, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@2d8b626d), locale=et-EE, timezone=Australia/Tasmania [junit4] 2> NOTE: Linux 4.4.0-137-generic amd64/Oracle Corporation 11.0.1 (64-bit)/cpus=4,threads=1,free=168406240,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [TestOrdValues, StatelessScriptUpdateProcessorFactoryTest, SolrPluginUtilsTest, DocumentAnalysisRequestHandlerTest, AnalysisAfterCoreReloadTest, ForceLeaderWithTlogReplicasTest, CoreMergeIndexesAdminHandlerTest, BlockCacheTest, MetricsConfigTest, FullHLLTest, CloneFieldUpdateProcessorFactoryTest, WrapperMergePolicyFactoryTest, LoggingHandlerTest, ExternalFileFieldSortTest, ChangedSchemaMergeTest, MultiSolrCloudTestCaseTest, TestCollationField, SchemaApiFailureTest, HdfsRestartWhileUpdatingTest, NodeAddedTriggerTest, SharedFSAutoReplicaFailoverTest, TestStressRecovery, HdfsDirectoryTest, SearchRateTriggerTest, HighlighterMaxOffsetTest, RollingRestartTest, TestInitParams, TestBulkSchemaConcurrent, TestDistributedMissingSort, CdcrBidirectionalTest, PeerSyncReplicationTest, TestSimTriggerIntegration, AnalysisErrorHandlingTest, TestSubQueryTransformerDistrib, TestFieldCacheWithThreads, TestDeprecatedFilters, CustomCollectionTest, StatsComponentTest, TestSolrDeletionPolicy2, TestSolrCLIRunExample, TestRebalanceLeaders, CustomTermsComponentTest, SolrJmxReporterCloudTest, TestLeaderElectionZkExpiry, LeaderFailoverAfterPartitionTest, TestQueryTypes, TestCoreContainer, ShardsWhitelistTest, ResponseBuilderTest, VersionInfoTest, ConcurrentCreateRoutedAliasTest, TestSkipOverseerOperations, AsyncCallRequestStatusResponseTest, JavabinLoaderTest, MoreLikeThisHandlerTest, UnloadDistributedZkTest, TestReplicationHandlerDiskOverFlow, TestCollectionAPIs, BJQParserTest, TestTolerantUpdateProcessorRandomCloud, SpellCheckCollatorTest] [junit4] Completed [324/857 (1!)] on J0 in 3.03s, 11 tests, 1 error <<< FAILURES! [...truncated 456 lines...] [junit4] Suite: org.apache.solr.cloud.autoscaling.HdfsAutoAddReplicasIntegrationTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.HdfsAutoAddReplicasIntegrationTest_35554349D37B0989-001/init-core-data-001 [junit4] 1> Formatting using clusterid: testClusterID [junit4] 2> 3069802 WARN (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried hadoop-metrics2-namenode.properties,hadoop-metrics2.properties [junit4] 2> 3069843 WARN (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 3069846 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.1+13-LTS [junit4] 2> 3069849 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 3069849 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 3069849 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 3069849 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1e59d4be{static,/static,jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,AVAILABLE} [junit4] 2> 3070117 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.w.WebAppContext@318afa9f{hdfs,/,file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/jetty-localhost-45833-hdfs-_-any-11859608640119150602.dir/webapp/,AVAILABLE}{/hdfs} [junit4] 2> 3070118 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@175fb0bd{HTTP/1.1,[http/1.1]}{localhost:45833} [junit4] 2> 3070118 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.Server Started @3070174ms [junit4] 2> 3070245 WARN (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 3070247 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.1+13-LTS [junit4] 2> 3070248 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 3070248 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 3070248 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 3070248 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1a721ba{static,/static,jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,AVAILABLE} [junit4] 2> 3070420 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.w.WebAppContext@b3e950e{datanode,/,file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/jetty-localhost-32845-datanode-_-any-3418181467145684711.dir/webapp/,AVAILABLE}{/datanode} [junit4] 2> 3070420 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5460ac26{HTTP/1.1,[http/1.1]}{localhost:32845} [junit4] 2> 3070420 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.Server Started @3070476ms [junit4] 2> 3070476 WARN (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j [junit4] 2> 3070480 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.1+13-LTS [junit4] 2> 3070481 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 3070481 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 3070481 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 3070481 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1418ac{static,/static,jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,AVAILABLE} [junit4] 2> 3070597 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x3e925dcf7b525354: Processing first storage report for DS-94bd0915-fcd8-4785-be10-e1642b3d8eae from datanode ea55ca53-6403-49c4-b250-d414bd685fb8 [junit4] 2> 3070598 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x3e925dcf7b525354: from storage DS-94bd0915-fcd8-4785-be10-e1642b3d8eae node DatanodeRegistration(127.0.0.1:45970, datanodeUuid=ea55ca53-6403-49c4-b250-d414bd685fb8, infoPort=37748, infoSecurePort=0, ipcPort=40500, storageInfo=lv=-57;cid=testClusterID;nsid=1091001222;c=1558035184657), blocks: 0, hasStaleStorage: true, processing time: 0 msecs, invalidatedBlocks: 0 [junit4] 2> 3070598 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x3e925dcf7b525354: Processing first storage report for DS-9c031835-f235-42ca-a1fa-bdad2bab8b29 from datanode ea55ca53-6403-49c4-b250-d414bd685fb8 [junit4] 2> 3070598 INFO (Block report processor) [ ] BlockStateChange BLOCK* processReport 0x3e925dcf7b525354: from storage DS-9c031835-f235-42ca-a1fa-bdad2bab8b29 node DatanodeRegistration(127.0.0.1:45970, datanodeUuid=ea55ca53-6403-49c4-b250-d414bd685fb8, infoPort=37748, infoSecurePort=0, ipcPort=40500, storageInfo=lv=-57;cid=testClusterID;nsid=1091001222;c=1558035184657), blocks: 0, hasStaleStorage: false, processing time: 0 msecs, invalidatedBlocks: 0 [junit4] 2> 3070710 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.w.WebAppContext@46d07c44{datanode,/,file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/jetty-localhost-38128-datanode-_-any-15674679880655231333.dir/webapp/,AVAILABLE}{/datanode} [junit4] 2> 3070710 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@36ea018{HTTP/1.1,[http/1.1]}{localhost:38128} [junit4] 2> 3070710 INFO (SUITE-HdfsAutoAddReplicasIntegrationTest-seed#[35554349D37B0989]-worker) [ ] o.e.j. [...truncated too long message...] rceLoader.java (at line 19) [ecj-lint] import javax.naming.Context; [ecj-lint] ^^^^^^^^^^^^^^^^^^^^ [ecj-lint] The type javax.naming.Context is not accessible [ecj-lint] ---------- [ecj-lint] 6. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/core/SolrResourceLoader.java (at line 20) [ecj-lint] import javax.naming.InitialContext; [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] The type javax.naming.InitialContext is not accessible [ecj-lint] ---------- [ecj-lint] 7. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/core/SolrResourceLoader.java (at line 21) [ecj-lint] import javax.naming.NamingException; [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] The type javax.naming.NamingException is not accessible [ecj-lint] ---------- [ecj-lint] 8. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/core/SolrResourceLoader.java (at line 22) [ecj-lint] import javax.naming.NoInitialContextException; [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] The type javax.naming.NoInitialContextException is not accessible [ecj-lint] ---------- [ecj-lint] 9. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/core/SolrResourceLoader.java (at line 776) [ecj-lint] Context c = new InitialContext(); [ecj-lint] ^^^^^^^ [ecj-lint] Context cannot be resolved to a type [ecj-lint] ---------- [ecj-lint] 10. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/core/SolrResourceLoader.java (at line 776) [ecj-lint] Context c = new InitialContext(); [ecj-lint] ^^^^^^^^^^^^^^ [ecj-lint] InitialContext cannot be resolved to a type [ecj-lint] ---------- [ecj-lint] 11. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/core/SolrResourceLoader.java (at line 779) [ecj-lint] } catch (NoInitialContextException e) { [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] NoInitialContextException cannot be resolved to a type [ecj-lint] ---------- [ecj-lint] 12. ERROR in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/core/SolrResourceLoader.java (at line 781) [ecj-lint] } catch (NamingException e) { [ecj-lint] ^^^^^^^^^^^^^^^ [ecj-lint] NamingException cannot be resolved to a type [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 13. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/handler/admin/SegmentsInfoRequestHandler.java (at line 215) [ecj-lint] leafReader = ((FilterLeafReader)leafReader).getDelegate(); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: 'leafReader' is not closed at this location [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 14. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/handler/component/HttpShardHandler.java (at line 142) [ecj-lint] return new JavaBinCodec(null, stringCache).setReadStringAsCharSeq(true); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 15. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/handler/loader/JavabinLoader.java (at line 137) [ecj-lint] new JavaBinCodec() { [ecj-lint] SolrParams params; [ecj-lint] AddUpdateCommand addCmd = null; [ecj-lint] [ecj-lint] @Override [ecj-lint] public List<Object> readIterator(DataInputInputStream fis) throws IOException { [ecj-lint] while (true) { [ecj-lint] Object o = readVal(fis); [ecj-lint] if (o == END_OBJ) break; [ecj-lint] if (o instanceof NamedList) { [ecj-lint] params = ((NamedList) o).toSolrParams(); [ecj-lint] } else { [ecj-lint] try { [ecj-lint] if (o instanceof byte[]) { [ecj-lint] if (params != null) req.setParams(params); [ecj-lint] byte[] buf = (byte[]) o; [ecj-lint] contentStreamLoader.load(req, rsp, new ContentStreamBase.ByteArrayStream(buf, null), processor); [ecj-lint] } else { [ecj-lint] throw new RuntimeException("unsupported type "); [ecj-lint] } [ecj-lint] } catch (Exception e) { [ecj-lint] throw new RuntimeException(e); [ecj-lint] } finally { [ecj-lint] params = null; [ecj-lint] req.setParams(old); [ecj-lint] } [ecj-lint] } [ecj-lint] } [ecj-lint] return Collections.emptyList(); [ecj-lint] } [ecj-lint] [ecj-lint] }.unmarshal(in); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 16. INFO in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/logging/log4j2/Log4j2Watcher.java (at line 187) [ecj-lint] if (logger == root || root.equals(logger) || isRootLogger(name) || "".equals(name)) { [ecj-lint] ^^^^^^ [ecj-lint] Unlikely argument type for equals(): Map.Entry<String,LoggerConfig> seems to be unrelated to Logger [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 17. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/update/SolrIndexSplitter.java (at line 258) [ecj-lint] HardlinkCopyDirectoryWrapper hardLinkedDir = new HardlinkCopyDirectoryWrapper(splitDir); [ecj-lint] ^^^^^^^^^^^^^ [ecj-lint] Resource leak: 'hardLinkedDir' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 18. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/util/FileUtils.java (at line 50) [ecj-lint] in = new FileInputStream(src).getChannel(); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed [ecj-lint] ---------- [ecj-lint] 19. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/util/FileUtils.java (at line 51) [ecj-lint] out = new FileOutputStream(destination).getChannel(); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: '<unassigned Closeable value>' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 20. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/util/SolrCLI.java (at line 1143) [ecj-lint] SnapshotCloudManager snapshotCloudManager = new SnapshotCloudManager(simCloudManager, config); [ecj-lint] ^^^^^^^^^^^^^^^^^^^^ [ecj-lint] Resource leak: 'snapshotCloudManager' is never closed [ecj-lint] ---------- [ecj-lint] ---------- [ecj-lint] 21. WARNING in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/java/org/apache/solr/util/TestInjection.java (at line 263) [ecj-lint] timers.remove(this); [ecj-lint] ^^^^ [ecj-lint] Unlikely argument type new TimerTask(){} for remove(Object) on a Collection<Timer> [ecj-lint] ---------- [ecj-lint] 21 problems (9 errors, 11 warnings, 1 info) BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:652: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/build.xml:101: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build.xml:681: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/common-build.xml:2010: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/common-build.xml:2049: Compile failed; see the compiler error output for details. Total time: 331 minutes 4 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