Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/11707/ Java: 32bit/jdk1.8.0_40-ea-b22 -server -XX:+UseSerialGC
2 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.cloud.DistribCursorPagingTest Error Message: Some resources were not closed, shutdown, or released. Stack Trace: java.lang.AssertionError: Some resources were not closed, shutdown, or released. at __randomizedtesting.SeedInfo.seed([A31131679AE87001]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:213) at sun.reflect.GeneratedMethodAccessor27.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([A31131679AE87001:92AA8F523FD760D1]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:748) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:715) at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:530) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits' and 6 <= . and . <= 10] xml response was: <?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">5</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><int name="hits">12</int><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%3Aeverother&spellcheck.collateMaxCollectDocs=5 at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:741) ... 42 more Build Log: [...truncated 8971 lines...] [junit4] Suite: org.apache.solr.spelling.SpellCheckCollatorTest [junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001 [junit4] 2> 321889 T549 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false) [junit4] 2> 321889 T549 oas.SolrTestCaseJ4.initCore ####initCore [junit4] 2> 321890 T549 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/' [junit4] 2> 321890 T549 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 321891 T549 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 321891 T549 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 321917 T549 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 321924 T549 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 321941 T549 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-spellcheckcomponent.xml [junit4] 2> 321942 T549 oass.IndexSchema.readSchema Reading Solr Schema from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 321948 T549 oass.IndexSchema.readSchema [null] Schema name=test [junit4] 2> 322060 T549 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 322063 T549 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 322064 T549 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 322069 T549 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 322071 T549 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 322072 T549 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 322072 T549 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 322072 T549 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 322073 T549 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 322073 T549 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 322073 T549 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 322073 T549 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 322074 T549 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr [junit4] 2> 322074 T549 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/' [junit4] 2> 322084 T549 oasc.CoreContainer.<init> New CoreContainer 30420362 [junit4] 2> 322084 T549 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/] [junit4] 2> 322085 T549 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 600000 [junit4] 2> 322085 T549 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null [junit4] 2> 322085 T549 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 60000 [junit4] 2> 322085 T549 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 322085 T549 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 322085 T549 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 322086 T549 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 322086 T549 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 322086 T549 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 322086 T549 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 322086 T549 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 322087 T549 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 322087 T549 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 322087 T549 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 322087 T549 oasc.CoreContainer.load Host Name: null [junit4] 2> 322088 T550 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/' [junit4] 2> 322088 T550 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 322089 T550 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 322089 T550 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 322101 T550 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 322110 T550 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 322124 T550 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-spellcheckcomponent.xml [junit4] 2> 322124 T550 oass.IndexSchema.readSchema Reading Solr Schema from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 322128 T550 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 322227 T550 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 322233 T550 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 322234 T550 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 322238 T550 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 322240 T550 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 322241 T550 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 322241 T550 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 322241 T550 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 322241 T550 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 322241 T550 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 322242 T550 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 322242 T550 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/ [junit4] 2> 322242 T550 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 322242 T550 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001/ [junit4] 2> 322242 T550 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 322243 T550 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001 [junit4] 2> 322243 T550 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001/index/ [junit4] 2> 322243 T550 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001/index' doesn't exist. Creating new index... [junit4] 2> 322243 T550 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001/index [junit4] 2> 322243 T550 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=39, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 322244 T550 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11f59a0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b948d8),segFN=segments_1,generation=1} [junit4] 2> 322244 T550 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 322245 T550 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 322245 T550 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 322245 T550 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 322245 T550 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 322246 T550 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 322246 T550 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler [junit4] 2> 322246 T550 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler [junit4] 2> 322246 T550 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler [junit4] 2> 322246 T550 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler [junit4] 2> 322246 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler [junit4] 2> 322247 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler [junit4] 2> 322247 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler [junit4] 2> 322247 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler [junit4] 2> 322247 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler [junit4] 2> 322247 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler [junit4] 2> 322247 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler [junit4] 2> 322248 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler [junit4] 2> 322248 T550 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler [junit4] 2> 322248 T550 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 322248 T550 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4] 2> 322248 T550 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4] 2> 322248 T550 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler [junit4] 2> 322250 T550 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 322250 T550 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 322251 T550 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 322252 T550 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 322252 T550 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 322252 T550 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 322253 T550 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 322253 T550 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=93.982421875, floorSegmentMB=0.541015625, forceMergeDeletesPctAllowed=21.39944711266031, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7802529576884853 [junit4] 2> 322253 T550 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11f59a0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b948d8),segFN=segments_1,generation=1} [junit4] 2> 322254 T550 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 322254 T550 oass.SolrIndexSearcher.<init> Opening Searcher@11177c8[collection1] main [junit4] 2> 322254 T550 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead. [junit4] 2> 322254 T550 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 322255 T550 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 322255 T550 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 322255 T550 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 322384 T550 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: default [junit4] 2> 322388 T550 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: default_teststop [junit4] 2> 322398 T550 oass.DirectSolrSpellChecker.init init: {name=direct,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=teststop} [junit4] 2> 322399 T550 oass.DirectSolrSpellChecker.init init: {name=direct_lowerfilt,classname=solr.DirectSolrSpellChecker,minQueryLength=3,maxQueryFrequency=100.0,field=lowerfilt} [junit4] 2> 322403 T550 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: threshold [junit4] 2> 322403 T550 oass.DirectSolrSpellChecker.init init: {name=threshold_direct,classname=solr.DirectSolrSpellChecker,field=lowerfilt,spellcheckIndexDir=spellcheckerThreshold,buildOnCommit=true,thresholdTokenFrequency=0.29} [junit4] 2> 322403 T550 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: threshold_direct [junit4] 2> 322406 T550 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: multipleFields [junit4] 2> 322418 T550 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: freq [junit4] 2> 322422 T550 oashc.SpellCheckComponent.inform Registering newSearcher listener for spellchecker: fqcn [junit4] 2> 322423 T550 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 322423 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 322423 T550 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 322424 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default_teststop [junit4] 2> 322424 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 322424 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct_lowerfilt [junit4] 2> 322425 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 322425 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: threshold [junit4] 2> 322425 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: threshold_direct [junit4] 2> 322425 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 322425 T549 oas.SolrTestCaseJ4.initCore ####initCore end [junit4] 2> 322426 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 322426 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 322427 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> ASYNC NEW_CORE C2549 name=collection1 org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 322427 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[0]} 0 1 [junit4] 2> 322427 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 322428 T551 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 322428 T551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@11177c8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 322430 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1]} 0 1 [junit4] 2> 322433 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2]} 0 3 [junit4] 2> 322434 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[3]} 0 0 [junit4] 2> 322435 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4]} 0 0 [junit4] 2> 322439 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5]} 0 3 [junit4] 2> 322440 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[6]} 0 1 [junit4] 2> 322441 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7]} 0 0 [junit4] 2> 322444 T549 C2549 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8]} 0 3 [junit4] 2> ASYNC NEW_CORE C2550 name=collection1 org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 322454 T549 C2550 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[9]} 0 9 [junit4] 2> 322455 T549 C2550 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10]} 0 0 [junit4] 2> 322458 T549 C2550 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11]} 0 2 [junit4] 2> 322459 T549 C2550 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12]} 0 0 [junit4] 2> 322460 T549 C2550 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[13]} 0 0 [junit4] 2> 322464 T549 C2550 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[14]} 0 3 [junit4] 2> 322466 T549 C2550 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15]} 0 1 [junit4] 2> 322466 T549 C2550 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[16]} 0 0 [junit4] 2> 322467 T549 C2550 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 322494 T549 C2550 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11f59a0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b948d8),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11f59a0 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1b948d8),segFN=segments_2,generation=2} [junit4] 2> 322495 T549 C2550 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 322496 T549 C2550 oass.SolrIndexSearcher.<init> Opening Searcher@d9aca6[collection1] main [junit4] 2> 322497 T549 C2550 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 322497 T551 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: default [junit4] 2> 322534 T551 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: default_teststop [junit4] 2> 322582 T551 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: threshold [junit4] 2> 322594 T551 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: threshold_direct [junit4] 2> 322595 T551 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: multipleFields [junit4] 2> 322642 T551 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: freq [junit4] 2> 322682 T551 oashc.SpellCheckComponent$SpellCheckerListener.buildSpellIndex Building spell index for spell checker: fqcn [junit4] 2> 322719 T551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d9aca6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C3) Uninverting(_1(6.0.0):C3) Uninverting(_2(6.0.0):C3) Uninverting(_3(6.0.0):C3) Uninverting(_4(6.0.0):C3) Uninverting(_5(6.0.0):C2)))} [junit4] 2> ASYNC NEW_CORE C2551 name=collection1 org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 322719 T549 C2551 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 252 [junit4] 2> 322722 T549 oas.SolrTestCaseJ4.setUp ###Starting testEstimatedHitCounts [junit4] 2> 322790 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia} hits=0 status=0 QTime=68 [junit4] 2> 322801 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=0} hits=0 status=0 QTime=9 [junit4] 2> 322812 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=30} hits=0 status=0 QTime=9 [junit4] 2> 322823 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=100} hits=0 status=0 QTime=10 [junit4] 2> 322832 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=10000} hits=0 status=0 QTime=8 [junit4] 2> 322840 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=7 [junit4] 2> 322847 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=6 [junit4] 2> 322853 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=5 [junit4] 2> 322860 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=6 [junit4] 2> 322866 T549 C2551 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=15} hits=0 status=0 QTime=5 [junit4] 2> ASYNC NEW_CORE C2552 name=collection1 org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 322880 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=11} hits=0 status=0 QTime=6 [junit4] 2> 322887 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=5 [junit4] 2> 322893 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=5 [junit4] 2> 322901 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=7 [junit4] 2> 322908 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=1} hits=0 status=0 QTime=6 [junit4] 2> 322916 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=1} hits=0 status=0 QTime=7 [junit4] 2> 322922 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=13} hits=0 status=0 QTime=5 [junit4] 2> 322928 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=9} hits=0 status=0 QTime=5 [junit4] 2> 322935 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=5 [junit4] 2> 322941 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=6} hits=0 status=0 QTime=4 [junit4] 2> 322947 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=7} hits=0 status=0 QTime=5 [junit4] 2> 322953 T549 C2552 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=16} hits=0 status=0 QTime=5 [junit4] 2> ASYNC NEW_CORE C2553 name=collection1 org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 322963 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=3} hits=0 status=0 QTime=4 [junit4] 2> 322967 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=4} hits=0 status=0 QTime=3 [junit4] 2> 322971 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=8} hits=0 status=0 QTime=3 [junit4] 2> 322976 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=10} hits=0 status=0 QTime=4 [junit4] 2> 322980 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=3 [junit4] 2> 322985 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=3 [junit4] 2> 322991 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=14} hits=0 status=0 QTime=5 [junit4] 2> 322996 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=4 [junit4] 2> 323000 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=14} hits=0 status=0 QTime=3 [junit4] 2> 323005 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=12} hits=0 status=0 QTime=4 [junit4] 2> 323009 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=1} hits=0 status=0 QTime=3 [junit4] 2> 323014 T549 C2553 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=4 [junit4] 2> ASYNC NEW_CORE C2554 name=collection1 org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 323024 T549 C2554 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=17} hits=0 status=0 QTime=4 [junit4] 2> 323029 T549 C2554 oasc.SolrCore.execute [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%3Ametnoia&spellcheck.collateMaxCollectDocs=15} hits=0 status=0 QTime=4 [junit4] 2> 323035 T549 C2554 oasc.SolrCore.execute [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%3Aeverother&spellcheck.collateMaxCollectDocs=5} hits=0 status=0 QTime=5 [junit4] 2> 323037 T549 oas.SolrTestCaseJ4.assertQ ERROR REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits' and 6 <= . and . <= 10] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">5</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><int name="hits">12</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst> [junit4] 2> </response> [junit4] 2> [junit4] 2> 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%3Aeverother&spellcheck.collateMaxCollectDocs=5 [junit4] 2> 323038 T549 oasc.SolrException.log ERROR REQUEST FAILED: spellcheck=true&spellcheck.dictionary=direct&spellcheck.count=1&spellcheck.collate=true&spellcheck.maxCollationTries=1&spellcheck.maxCollations=1&spellcheck.collateExtendedResults=true&qt=spellCheckCompRH&q=teststop%3Aeverother&spellcheck.collateMaxCollectDocs=5:java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits' and 6 <= . and . <= 10] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">5</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><int name="hits">12</int><lst name="misspellingsAndCorrections"><str name="everother">everyother</str></lst></lst></lst></lst> [junit4] 2> </response> [junit4] 2> [junit4] 2> 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%3Aeverother&spellcheck.collateMaxCollectDocs=5 [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:741) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:715) [junit4] 2> at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:530) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 323039 T549 oas.SolrTestCaseJ4.tearDown ###Ending testEstimatedHitCounts [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SpellCheckCollatorTest -Dtests.method=testEstimatedHitCounts -Dtests.seed=A31131679AE87001 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lv -Dtests.timezone=CNT -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] ERROR 0.33s J1 | SpellCheckCollatorTest.testEstimatedHitCounts <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([A31131679AE87001:92AA8F523FD760D1]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:748) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:715) [junit4] > at org.apache.solr.spelling.SpellCheckCollatorTest.testEstimatedHitCounts(SpellCheckCollatorTest.java:530) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//lst[@name='spellcheck']/lst[@name='collations']/lst[@name='collation']/int[@name='hits' and 6 <= . and . <= 10] [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">5</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><int name="hits">12</int><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%3Aeverother&spellcheck.collateMaxCollectDocs=5 [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:741) [junit4] > ... 42 more [junit4] 2> 323050 T549 oas.SolrTestCaseJ4.setUp ###Starting testCollateWithOverride [junit4] 2> 323080 T549 C2554 oasc.SolrCore.execute [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=29 [junit4] 2> 323092 T549 C2554 oasc.SolrCore.execute [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=11 [junit4] 2> 323093 T549 oas.SolrTestCaseJ4.tearDown ###Ending testCollateWithOverride [junit4] 2> 323095 T549 oas.SolrTestCaseJ4.setUp ###Starting testExtendedCollate [junit4] 2> 323163 T549 oas.SolrTestCaseJ4.tearDown ###Ending testExtendedCollate [junit4] 2> 323167 T549 oas.SolrTestCaseJ4.setUp ###Starting testCollateWithFilter [junit4] 2> 323233 T549 oas.SolrTestCaseJ4.tearDown ###Ending testCollateWithFilter [junit4] 2> 323237 T549 oas.SolrTestCaseJ4.setUp ###Starting testContextSensitiveCollate [junit4] 2> ASYNC NEW_CORE C2555 name=collection1 org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 323246 T549 C2555 oasc.SolrCore.execute [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=9 [junit4] 2> 323252 T549 C2555 oasc.SolrCore.execute [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=4 [junit4] 2> 323255 T549 C2555 oasc.SolrCore.execute [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> ASYNC NEW_CORE C2556 name=collection1 org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 323313 T549 C2556 oasc.SolrCore.execute [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=58 [junit4] 2> 323317 T549 C2556 oasc.SolrCore.execute [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> 323320 T549 C2556 oasc.SolrCore.execute [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> 323321 T549 oas.SolrTestCaseJ4.tearDown ###Ending testContextSensitiveCollate [junit4] 2> 323324 T549 oas.SolrTestCaseJ4.setUp ###Starting testCollateWithMultipleRequestHandlers [junit4] 2> 323367 T549 oas.SolrTestCaseJ4.tearDown ###Ending testCollateWithMultipleRequestHandlers [junit4] 2> 323370 T549 oas.SolrTestCaseJ4.setUp ###Starting testCollateWithGrouping [junit4] 2> 323420 T549 oas.SolrTestCaseJ4.tearDown ###Ending testCollateWithGrouping [junit4] 2> 323423 T549 oas.SolrTestCaseJ4.setUp ###Starting testCollationWithHypens [junit4] 2> 323529 T549 oas.SolrTestCaseJ4.tearDown ###Ending testCollationWithHypens [junit4] 2> 323532 T549 oas.SolrTestCaseJ4.setUp ###Starting testZeroTries [junit4] 2> 323583 T549 oas.SolrTestCaseJ4.tearDown ###Ending testZeroTries [junit4] 2> 323584 T549 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> 323584 T549 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=30420362 [junit4] 2> 323584 T549 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@15bb72f [junit4] 2> 323585 T549 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=17,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4] 2> 323585 T549 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 323585 T549 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 323585 T549 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 323586 T549 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 323586 T549 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 323586 T549 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001/index;done=false>>] [junit4] 2> 323587 T549 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001/index [junit4] 2> 323587 T549 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001;done=false>>] [junit4] 2> 323587 T549 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001/init-core-data-001 [junit4] 2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.spelling.SpellCheckCollatorTest A31131679AE87001-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {start1=PostingsFormat(name=Asserting), lowerfilt1=PostingsFormat(name=Asserting), multiDefault=BlockTreeOrds(blocksize=128), teststop=BlockTreeOrds(blocksize=128), intDefault=PostingsFormat(name=Memory doPackFST= true), range_facet_l=PostingsFormat(name=Memory doPackFST= true), lowerfilt1and2=BlockTreeOrds(blocksize=128), end4=PostingsFormat(name=Asserting), end3=BlockTreeOrds(blocksize=128), end2=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), end1=PostingsFormat(name=Memory doPackFST= true), lowerfilt=BlockTreeOrds(blocksize=128), gram1=PostingsFormat(name=Memory doPackFST= true), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), gram2=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), gram3=BlockTreeOrds(blocksize=128), start3=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), gram4=PostingsFormat(name=Asserting), start2=BlockTreeOrds(blocksize=128), word=PostingsFormat(name=Memory doPackFST= true), timestamp=PostingsFormat(name=Memory doPackFST= true), start4=PostingsFormat(name=Memory doPackFST= true)}, docValues:{timestamp=DocValuesFormat(name=Asserting)}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=lv, timezone=CNT [junit4] 2> NOTE: Linux 3.13.0-44-generic i386/Oracle Corporation 1.8.0_40-ea (32-bit)/cpus=8,threads=1,free=29839440,total=68435968 [junit4] 2> NOTE: All tests run in this JVM: [TestRebalanceLeaders, PolyFieldTest, DistanceUnitsTest, TestFieldResource, TestSolrDeletionPolicy2, RAMDirectoryFactoryTest, TestRealTimeGet, HdfsCollectionsAPIDistributedZkTest, TestReloadAndDeleteDocs, HdfsSyncSliceTest, TestRandomFaceting, TestConfigSets, TestFiltering, HdfsChaosMonkeySafeLeaderTest, TestRecoveryHdfs, OverseerCollectionProcessorTest, TestManagedSchema, TestIntervalFaceting, TestValueSourceCache, TestRangeQuery, HighlighterConfigTest, CoreMergeIndexesAdminHandlerTest, TestRemoteStreaming, TestSchemaManager, TermsComponentTest, AddSchemaFieldsUpdateProcessorFactoryTest, SpellCheckCollatorTest] [junit4] Completed on J1 in 1.72s, 9 tests, 1 error <<< FAILURES! [...truncated 196 lines...] [junit4] Suite: org.apache.solr.cloud.DistribCursorPagingTest [junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/init-core-data-001 [junit4] 2> 532710 T3643 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 532711 T3643 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: / [junit4] 2> 532712 T3643 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 532713 T3644 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 532813 T3643 oasc.ZkTestServer.run start zk server on port:57650 [junit4] 2> 532813 T3643 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 532814 T3643 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 532817 T3651 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@9a8b03 name:ZooKeeperConnection Watcher:127.0.0.1:57650 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 532817 T3643 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 532818 T3643 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 532819 T3643 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 532822 T3643 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 532822 T3643 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 532824 T3654 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1120bc7 name:ZooKeeperConnection Watcher:127.0.0.1:57650/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 532824 T3643 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 532824 T3643 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 532824 T3643 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 532826 T3643 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 532828 T3643 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 532830 T3643 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 532832 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-deeppaging.xml to /configs/conf1/solrconfig.xml [junit4] 2> 532833 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 532836 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema-sorts.xml to /configs/conf1/schema.xml [junit4] 2> 532837 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 532841 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 532841 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 532844 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 532844 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 532846 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 532846 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 532848 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 532848 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 532849 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 532849 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 532850 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 532851 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 532852 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 532853 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 532855 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 532856 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 532858 T3643 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 532858 T3643 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 532860 T3643 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 532860 T3643 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 532861 T3657 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8637f5 name:ZooKeeperConnection Watcher:127.0.0.1:57650/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 532861 T3643 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 532862 T3643 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 533107 T3643 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/cores/collection1 [junit4] 2> 533109 T3643 oejs.Server.doStart jetty-9.2.6.v20141205 [junit4] 2> 533111 T3643 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@1a8b179{/,null,AVAILABLE} [junit4] 2> 533119 T3643 oejs.AbstractConnector.doStart Started ServerConnector@b575d3{SSL-http/1.1}{127.0.0.1:57920} [junit4] 2> 533119 T3643 oejs.Server.doStart Started @534290ms [junit4] 2> 533120 T3643 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a [junit4] 2> 533121 T3643 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 533121 T3643 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001 [junit4] 2> 533121 T3643 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/' [junit4] 2> 533145 T3643 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/solr.xml [junit4] 2> 533149 T3643 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/cores [junit4] 2> 533150 T3643 oasc.CoreContainer.<init> New CoreContainer 1737316 [junit4] 2> 533151 T3643 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=../../../../../../../../../../mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/] [junit4] 2> 533152 T3643 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 533152 T3643 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 533153 T3643 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 533153 T3643 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 533154 T3643 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 533154 T3643 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 533154 T3643 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 533155 T3643 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 533155 T3643 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 533155 T3643 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 533155 T3643 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 533156 T3643 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 533157 T3643 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 533157 T3643 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 533158 T3643 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 533158 T3643 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:57650/solr [junit4] 2> 533159 T3643 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 533159 T3643 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider [junit4] 2> 533159 T3643 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 533161 T3671 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@9605c2 name:ZooKeeperConnection Watcher:127.0.0.1:57650 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 533161 T3643 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 533162 T3643 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider [junit4] 2> 533164 T3643 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 533165 T3674 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@31c375 name:ZooKeeperConnection Watcher:127.0.0.1:57650/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 533165 T3643 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 533166 T3643 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 533168 T3643 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 533170 T3643 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 533171 T3643 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 533172 T3643 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 533174 T3643 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 533175 T3643 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:57920_ [junit4] 2> 533176 T3643 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:57920_ [junit4] 2> 533177 T3643 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 533178 T3643 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 533179 T3643 oasc.Overseer.close Overseer (id=null) closing [junit4] 2> 533180 T3643 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:57920_ [junit4] 2> 533180 T3643 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 533181 T3643 oasc.Overseer.start Overseer (id=93226764850364420-127.0.0.1:57920_-n_0000000000) starting [junit4] 2> 533182 T3643 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 533186 T3643 oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 533186 T3676 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 533187 T3643 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 533188 T3643 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 533189 T3643 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 533191 T3675 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 533191 T3643 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/cores [junit4] 2> 533191 T3643 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/cores/collection1/ [junit4] 2> 533192 T3643 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 533192 T3678 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection [junit4] 2> 533193 T3678 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 533193 T3674 oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 533194 T3678 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 533197 T3675 oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 0, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57920", [junit4] 2> "node_name":"127.0.0.1:57920_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 533198 T3675 oasco.ReplicaMutator.updateState Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57920", [junit4] 2> "node_name":"127.0.0.1:57920_", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 533199 T3675 oasco.ClusterStateMutator.createCollection building a new cName: control_collection [junit4] 2> 533199 T3675 oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1 [junit4] 2> 533200 T3674 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 534194 T3678 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 534194 T3678 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection [junit4] 2> 534195 T3678 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 534195 T3678 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 534196 T3678 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 534197 T3678 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/cores/collection1/' [junit4] 2> 534214 T3678 oasc.ZkController.watchZKConfDir watch zkdir /configs/conf1 [junit4] 2> 534215 T3678 oasc.Config.<init> loaded config solrconfig.xml with version 0 [junit4] 2> 534219 T3678 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 534222 T3678 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 534228 T3678 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 534230 T3678 oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 534233 T3678 oass.IndexSchema.readSchema [collection1] Schema name=sortable [junit4] 2> 534338 T3678 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 534339 T3678 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 534339 T3678 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 534339 T3678 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/control-001/cores/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/tempDir-001/control/data/ [junit4] 2> 534339 T3678 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 534340 T3678 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/tempDir-001/control/data [junit4] 2> 534340 T3678 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/tempDir-001/control/data/index/ [junit4] 2> 534340 T3678 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/tempDir-001/control/data/index' doesn't exist. Creating new index... [junit4] 2> 534341 T3678 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/tempDir-001/control/data/index [junit4] 2> 534341 T3678 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 534342 T3678 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1de6689 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@100e465),segFN=segments_1,generation=1} [junit4] 2> 534342 T3678 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 534343 T3678 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 534343 T3678 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 534343 T3678 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 534343 T3678 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 534343 T3678 oasc.RequestHandlers.initHandlersFromConfig created /update/ [...truncated too long message...] CoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 605894 T4380 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 605894 T4380 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 605895 T4380 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 1 directories currently being tracked [junit4] 2> 605895 T4380 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/tempDir-001/jetty4 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/tempDir-001/jetty4;done=false>>] [junit4] 2> 605895 T4380 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest A31131679AE87001-001/tempDir-001/jetty4 [junit4] 2> 607391 T4490 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK [junit4] 2> 607394 T3643 oejs.AbstractConnector.doStop Stopped ServerConnector@1a13f4f{SSL-http/1.1}{127.0.0.1:0} [junit4] 2> 607395 T3643 oejsh.ContextHandler.doStop Stopped o.e.j.s.ServletContextHandler@1b63b72{/,null,UNAVAILABLE} [junit4] 2> 607396 T3643 oasc.ChaosMonkey.monkeyLog monkey: stop shard! 57920 [junit4] 2> 607397 T3643 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:57650 57650 [junit4] 2> 608078 T3644 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:57650 57650 [junit4] 2> 608079 T3644 oasc.ZkTestServer$ZKServerMain.runFromConfig WARN Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 6 /solr/aliases.json [junit4] 2> 6 /solr/clusterstate.json [junit4] 2> 5 /solr/configs/conf1 [junit4] 2> 4 /solr/collections/collection1/state.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 6 /solr/live_nodes [junit4] 2> 5 /solr/overseer/collection-queue-work [junit4] 2> 4 /solr/overseer/queue [junit4] 2> [junit4] 2> 608082 T3643 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> ObjectTracker found objects that were not released!!! [junit4] 2> org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException [junit4] 2> at org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:33) [junit4] 2> at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:182) [junit4] 2> at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:141) [junit4] 2> at org.apache.solr.update.UpdateLog.ensureLog(UpdateLog.java:830) [junit4] 2> at org.apache.solr.update.UpdateLog.deleteByQuery(UpdateLog.java:467) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.doDeleteByQuery(DistributedUpdateProcessor.java:1347) [junit4] 2> at org.apache.solr.update.processor.DistributedUpdateProcessor.processDelete(DistributedUpdateProcessor.java:1133) [junit4] 2> at org.apache.solr.update.processor.LogUpdateProcessor.processDelete(LogUpdateProcessorFactory.java:125) [junit4] 2> at org.apache.solr.handler.loader.JavabinLoader.delete(JavabinLoader.java:150) [junit4] 2> at org.apache.solr.handler.loader.JavabinLoader.parseAndLoadDocs(JavabinLoader.java:111) [junit4] 2> at org.apache.solr.handler.loader.JavabinLoader.load(JavabinLoader.java:58) [junit4] 2> at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:103) [junit4] 2> at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74) [junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:144) [junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2006) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.execute(SolrDispatchFilter.java:777) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:413) [junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:204) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) [junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:143) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) [junit4] 2> at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83) [junit4] 2> at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:300) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1125) [junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515) [junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185) [junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1059) [junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97) [junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:497) [junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:313) [junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:248) [junit4] 2> at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:626) [junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:546) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> NOTE: test params are: codec=Lucene50, sim=DefaultSimilarity, locale=ar_TN, timezone=Africa/Bangui [junit4] 2> NOTE: Linux 3.13.0-44-generic i386/Oracle Corporation 1.8.0_40-ea (32-bit)/cpus=8,threads=1,free=40913560,total=188645376 [junit4] 2> NOTE: All tests run in this JVM: [TestXIncludeConfig, TestOrdValues, AnalysisAfterCoreReloadTest, OutOfBoxZkACLAndCredentialsProvidersTest, SolrCoreTest, TestBinaryField, SoftAutoCommitTest, DocValuesMissingTest, TestChildDocTransformer, HdfsLockFactoryTest, ClusterStateUpdateTest, TestAtomicUpdateErrorCases, NoCacheHeaderTest, SSLMigrationTest, HardAutoCommitTest, TestAddFieldRealTimeGet, TestStressVersions, UniqFieldsUpdateProcessorFactoryTest, SuggesterTest, TestStressReorder, TestCloudManagedSchemaConcurrent, CursorPagingTest, UUIDUpdateProcessorFallbackTest, DocumentAnalysisRequestHandlerTest, TestCollapseQParserPlugin, ZkStateWriterTest, HttpPartitionTest, TestConfigReload, ShowFileRequestHandlerTest, OverseerTest, TestCharFilters, ResponseLogComponentTest, TestLazyCores, SortByFunctionTest, TestClusterStateMutator, DistributedFacetPivotLongTailTest, TestCursorMarkWithoutUniqueKey, DistributedQueueTest, TestWriterPerf, DistribCursorPagingTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistribCursorPagingTest -Dtests.seed=A31131679AE87001 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_TN -Dtests.timezone=Africa/Bangui -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] ERROR 0.00s J0 | DistribCursorPagingTest (suite) <<< [junit4] > Throwable #1: java.lang.AssertionError: Some resources were not closed, shutdown, or released. [junit4] > at __randomizedtesting.SeedInfo.seed([A31131679AE87001]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:213) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] Completed on J0 in 75.93s, 1 test, 1 failure <<< FAILURES! [...truncated 1073 lines...] BUILD FAILED /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:519: The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:467: The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:61: The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:39: The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:191: The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:510: The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1348: The following error occurred while executing this line: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:956: There were test failures: 461 suites, 1845 tests, 1 suite-level error, 1 error, 45 ignored (20 assumptions) Total time: 63 minutes 10 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 32bit/jdk1.8.0_40-ea-b22 -server -XX:+UseSerialGC 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