You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/02/14 11:25:26 UTC
[JENKINS] Lucene-Solr-4.x-Linux (64bit/ibm-j9-jdk7) - Build # 9364
- Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/9364/
Java: 64bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
3 tests failed.
REGRESSION: org.apache.solr.update.AutoCommitTest.testMaxTime
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at __randomizedtesting.SeedInfo.seed([D7FF2456D8352DE4:4D0B59B446AFB1D8]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:644)
at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:227)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
at java.lang.reflect.Method.invoke(Method.java:613)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
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:70)
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:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:780)
Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=0]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int name="QTime">1411</int></lst><result name="response" numFound="1" start="0"><doc><int name="id">529</int><int name="range_facet_si">529</int><arr name="range_facet_l"><long>529</long></arr><arr name="range_facet_sl"><long>529</long></arr><arr name="field_t"><str>what's inside?</str></arr><arr name="subject"><str>info</str></arr><long name="_version_">1460008713008971776</long><int name="intDefault">42</int><date name="timestamp">2014-02-14T10:13:31.326Z</date><arr name="multiDefault"><str>muLti-Default</str></arr></doc></result>
</response>
request was:rows=20&version=2.2&qt=standard&start=0&q=id:529
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:637)
... 41 more
REGRESSION: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection
Error Message:
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
at __randomizedtesting.SeedInfo.seed([D7FF2456D8352DE4:8CCFDF9EDB728E98]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection(SignatureUpdateProcessorFactoryTest.java:119)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
at java.lang.reflect.Method.invoke(Method.java:613)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
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:70)
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:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:780)
REGRESSION: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testMultiThreaded
Error Message:
expected:<1> but was:<3>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<3>
at __randomizedtesting.SeedInfo.seed([D7FF2456D8352DE4:B66AFEB630E42712]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testMultiThreaded(SignatureUpdateProcessorFactoryTest.java:222)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
at java.lang.reflect.Method.invoke(Method.java:613)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
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:70)
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:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:780)
Build Log:
[...truncated 10252 lines...]
[junit4] Suite: org.apache.solr.update.AutoCommitTest
[junit4] 2> 73884 T234 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054
[junit4] 2> 73885 T234 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 73886 T234 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 73886 T234 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 73942 T234 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 74000 T234 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 74001 T234 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 74009 T234 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 74326 T234 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 74326 T234 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 74327 T234 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 74334 T234 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 74336 T234 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 74343 T234 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 74346 T234 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 74349 T234 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 74350 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 74350 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 74351 T234 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 74351 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 74351 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 74352 T234 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 74352 T234 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4] 2> 74352 T234 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4] 2> 74394 T234 oasc.CoreContainer.<init> New CoreContainer 256644271
[junit4] 2> 74394 T234 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
[junit4] 2> 74395 T234 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 74395 T234 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 74395 T234 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 74396 T234 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 74396 T234 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 74396 T234 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 74397 T234 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 74397 T234 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 74397 T234 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 74400 T234 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 74401 T234 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 74401 T234 oasc.CoreContainer.load Host Name:
[junit4] 2> 74404 T235 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 74404 T235 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 74405 T235 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 74405 T235 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 74441 T235 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 74491 T235 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 74492 T235 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 74500 T235 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 74808 T235 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 74808 T235 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 74809 T235 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 74816 T235 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 74819 T235 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 74827 T235 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 74830 T235 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 74834 T235 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 74835 T235 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 74835 T235 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 74835 T235 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 74836 T235 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 74836 T235 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 74836 T235 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 74837 T235 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/
[junit4] 2> 74837 T235 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 74837 T235 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054
[junit4] 2> 74838 T235 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index/
[junit4] 2> 74838 T235 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index' doesn't exist. Creating new index...
[junit4] 2> 74838 T235 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index
[junit4] 2> 74839 T235 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=49, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5840406908790946]
[junit4] 2> 74840 T235 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_1,generation=1}
[junit4] 2> 74840 T235 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 74840 T235 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 74841 T235 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 74842 T235 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 74842 T235 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 74842 T235 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 74843 T235 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 74843 T235 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 74843 T235 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 74843 T235 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 74844 T235 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 74844 T235 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 74844 T235 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 74845 T235 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 74845 T235 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 74845 T235 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 74846 T235 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 74846 T235 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 74846 T235 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 74847 T235 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 74847 T235 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 74847 T235 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 74847 T235 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 74848 T235 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 74848 T235 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 74848 T235 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 74848 T235 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 74849 T235 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 74849 T235 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 74849 T235 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 74849 T235 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 74850 T235 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 74850 T235 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 74851 T235 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 74851 T235 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 74852 T235 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 74852 T235 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 74852 T235 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 74854 T235 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 74857 T235 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 74859 T235 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 74859 T235 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 74860 T235 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=21, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 74861 T235 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_1,generation=1}
[junit4] 2> 74861 T235 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 74862 T235 oass.SolrIndexSearcher.<init> Opening Searcher@36e54047[collection1] main
[junit4] 2> 74862 T235 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 74867 T235 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 74893 T235 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 74894 T236 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@36e54047[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 74895 T234 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 74898 T234 oas.SolrTestCaseJ4.setUp ###Starting testMaxTime
[junit4] 2> ASYNC NEW_CORE C173 name=collection1 org.apache.solr.core.SolrCore@8cb37d7
[junit4] 2> 74899 T234 C173 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1460008711690911744)} 0 1
[junit4] 2> 74903 T234 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 74903 T234 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 74904 T234 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 74904 T234 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 74942 T234 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 74990 T234 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 74990 T234 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 74998 T234 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 75431 T234 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 75432 T234 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 75433 T234 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 75441 T234 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 75444 T234 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 75455 T234 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 75461 T234 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 75467 T234 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 75468 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 75469 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 75470 T234 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 75471 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 75471 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 75472 T234 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/
[junit4] 2> 75473 T234 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 75474 T234 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index/
[junit4] 2> 75474 T234 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 75476 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 75478 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 75479 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 75479 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 75480 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 75483 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 75484 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 75485 T234 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 75486 T234 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 75488 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 75490 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 75495 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 75500 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 75500 T234 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 75501 T234 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 75502 T234 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 75503 T234 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 75504 T234 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 75506 T234 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 75507 T234 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 75508 T234 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 75509 T234 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 75511 T234 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 75512 T234 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 75512 T234 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 75513 T234 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 75515 T234 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 75517 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 75518 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 75519 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 75520 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 75522 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 75523 T234 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 75525 T234 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 75526 T234 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 75527 T234 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 75530 T234 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 75535 T234 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 75541 T234 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 75542 T234 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 75545 T234 oass.SolrIndexSearcher.<init> Opening Searcher@a8e6e4f3[collection1] main
[junit4] 2> 75549 T234 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 75556 T234 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 75573 T234 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 75573 T234 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 75574 T234 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 75575 T238 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a8e6e4f3[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 75577 T234 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6422844065605602]
[junit4] 2> 75583 T234 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_1,generation=1}
[junit4] 2> 75584 T234 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 75585 T234 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 75588 T234 oass.SolrIndexSearcher.<init> Opening Searcher@9477b310[collection1] main
[junit4] 2> 75592 T238 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9477b310[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 75593 T234 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 75593 T234 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@8cb37d7
[junit4] 2> 75594 T234 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 75597 T234 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 76158 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[529 (1460008713008971776)]} 0 555
[junit4] 2> 77158 T239 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 77170 T239 oass.SolrIndexSearcher.<init> Opening Searcher@6e89f7ad[collection1] main
[junit4] 2> 77170 T239 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 77171 T238 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6e89f7ad[collection1] main{StandardDirectoryReader(segments_1:3:nrt _0(4.7):c1)}
[junit4] 2> ASYNC NEW_CORE C174 name=collection1 org.apache.solr.core.SolrCore@42ec8998
[junit4] 2> 77569 T234 C174 oasc.SolrCore.execute [collection1] webapp=null path=null params={rows=20&version=2.2&qt=standard&start=0&q=id:529} hits=1 status=0 QTime=1411
[junit4] 2> 77583 T234 oas.SolrTestCaseJ4.assertQ ERROR REQUEST FAILED: xpath=//result[@numFound=0]
[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">1411</int></lst><result name="response" numFound="1" start="0"><doc><int name="id">529</int><int name="range_facet_si">529</int><arr name="range_facet_l"><long>529</long></arr><arr name="range_facet_sl"><long>529</long></arr><arr name="field_t"><str>what's inside?</str></arr><arr name="subject"><str>info</str></arr><long name="_version_">1460008713008971776</long><int name="intDefault">42</int><date name="timestamp">2014-02-14T10:13:31.326Z</date><arr name="multiDefault"><str>muLti-Default</str></arr></doc></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:rows=20&version=2.2&qt=standard&start=0&q=id:529
[junit4] 2> 77584 T234 oasc.SolrException.log ERROR REQUEST FAILED: rows=20&version=2.2&qt=standard&start=0&q=id:529:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=0]
[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">1411</int></lst><result name="response" numFound="1" start="0"><doc><int name="id">529</int><int name="range_facet_si">529</int><arr name="range_facet_l"><long>529</long></arr><arr name="range_facet_sl"><long>529</long></arr><arr name="field_t"><str>what's inside?</str></arr><arr name="subject"><str>info</str></arr><long name="_version_">1460008713008971776</long><int name="intDefault">42</int><date name="timestamp">2014-02-14T10:13:31.326Z</date><arr name="multiDefault"><str>muLti-Default</str></arr></doc></result>
[junit4] 2> </response>
[junit4] 2>
[junit4] 2> request was:rows=20&version=2.2&qt=standard&start=0&q=id:529
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:637)
[junit4] 2> at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:227)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:613)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[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:70)
[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:358)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[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:70)
[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:358)
[junit4] 2> at java.lang.Thread.run(Thread.java:780)
[junit4] 2>
[junit4] 2> 77585 T234 oas.SolrTestCaseJ4.tearDown ###Ending testMaxTime
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest -Dtests.method=testMaxTime -Dtests.seed=D7FF2456D8352DE4 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=vi_VN -Dtests.timezone=Asia/Dubai -Dtests.file.encoding=UTF-8
[junit4] ERROR 2.70s J0 | AutoCommitTest.testMaxTime <<<
[junit4] > Throwable #1: java.lang.RuntimeException: Exception during query
[junit4] > at __randomizedtesting.SeedInfo.seed([D7FF2456D8352DE4:4D0B59B446AFB1D8]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:644)
[junit4] > at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:227)
[junit4] > at java.lang.Thread.run(Thread.java:780)
[junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=0]
[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">1411</int></lst><result name="response" numFound="1" start="0"><doc><int name="id">529</int><int name="range_facet_si">529</int><arr name="range_facet_l"><long>529</long></arr><arr name="range_facet_sl"><long>529</long></arr><arr name="field_t"><str>what's inside?</str></arr><arr name="subject"><str>info</str></arr><long name="_version_">1460008713008971776</long><int name="intDefault">42</int><date name="timestamp">2014-02-14T10:13:31.326Z</date><arr name="multiDefault"><str>muLti-Default</str></arr></doc></result>
[junit4] > </response>
[junit4] > request was:rows=20&version=2.2&qt=standard&start=0&q=id:529
[junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:637)
[junit4] > ... 41 more
[junit4] 2> 77595 T234 oas.SolrTestCaseJ4.setUp ###Starting testCommitWithin
[junit4] 2> 77597 T234 C174 oass.SolrIndexSearcher.<init> Opening Searcher@75951b49[collection1] realtime
[junit4] 2> 77597 T234 C174 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1460008714517872640)} 0 2
[junit4] 2> 77608 T234 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 77609 T234 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 77610 T234 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 77610 T234 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 77665 T234 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 77731 T234 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 77731 T234 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 77740 T234 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 78227 T234 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 78228 T234 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 78229 T234 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 78240 T234 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 78244 T234 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 78255 T234 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 78261 T234 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 78266 T234 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 78268 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 78268 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 78269 T234 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 78270 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 78270 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 78271 T234 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/
[junit4] 2> 78272 T234 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 78272 T234 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index/
[junit4] 2> 78273 T234 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 78275 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 78275 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 78276 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 78277 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 78277 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 78278 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 78278 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 78279 T234 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 78280 T234 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 78280 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 78281 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 78282 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 78283 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 78283 T234 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 78284 T234 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 78284 T234 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 78285 T234 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 78286 T234 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 78286 T234 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 78287 T234 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 78288 T234 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 78288 T234 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 78289 T234 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 78290 T234 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 78290 T234 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 78291 T234 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 78291 T234 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 78292 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 78293 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 78293 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 78294 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 78294 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 78295 T234 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 78296 T234 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 78296 T234 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 78297 T234 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 78299 T234 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 78301 T234 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 78304 T234 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 78304 T234 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 78305 T234 oass.SolrIndexSearcher.<init> Opening Searcher@4bc5bb8d[collection1] main
[junit4] 2> 78306 T234 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 78307 T234 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 78322 T234 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 78322 T234 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 78323 T234 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 78322 T240 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4bc5bb8d[collection1] main{StandardDirectoryReader(segments_1:5:nrt)}
[junit4] 2> 78324 T234 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_2,generation=2}
[junit4] 2> 78325 T234 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 78326 T234 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11251375037302856]
[junit4] 2> 78327 T234 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_2,generation=2}
[junit4] 2> 78327 T234 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 78328 T234 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 78329 T234 oass.SolrIndexSearcher.<init> Opening Searcher@e6044b90[collection1] main
[junit4] 2> 78331 T234 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 78332 T234 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@42ec8998
[junit4] 2> 78333 T234 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommit maxTime=1000ms,soft autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=1,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 78333 T240 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e6044b90[collection1] main{StandardDirectoryReader(segments_2:5:nrt)}
[junit4] 2> 78334 T234 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 78397 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[529 (1460008715356733440)]} 0 57
[junit4] 2> ASYNC NEW_CORE C175 name=collection1 org.apache.solr.core.SolrCore@4ddd2b40
[junit4] 2> 78398 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={qt=standard&start=0&q=id:529&rows=20&version=2.2} hits=0 status=0 QTime=1
[junit4] 2> 82397 T241 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 82402 T241 oass.SolrIndexSearcher.<init> Opening Searcher@5627868a[collection1] main
[junit4] 2> 82403 T241 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 82404 T240 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5627868a[collection1] main{StandardDirectoryReader(segments_2:7:nrt _1(4.7):c1)}
[junit4] 2> 82653 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[530 (1460008719821570048)]} 0 57
[junit4] 2> 82654 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:530&qt=standard&version=2.2&rows=20} hits=0 status=0 QTime=0
[junit4] 2> 82657 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[529 (-1460008719825764352)]} 0 57
[junit4] 2> 82657 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={start=0&q=id:529&qt=standard&version=2.2&rows=20} hits=1 status=0 QTime=0
[junit4] 2> 83657 T241 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 83662 T241 oass.SolrIndexSearcher.<init> Opening Searcher@78cbcb0f[collection1] main
[junit4] 2> 83663 T241 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 83663 T240 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@78cbcb0f[collection1] main{StandardDirectoryReader(segments_2:11:nrt _2(4.7):c1)}
[junit4] 2> 83910 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={qt=standard&q=id:529&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4] 2> 83912 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={qt=standard&start=0&q=id:530&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 83914 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721142775808)]} 0 57
[junit4] 2> 83915 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721144872960)]} 0 57
[junit4] 2> 83916 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721145921536)]} 0 57
[junit4] 2> 83917 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721145921537)]} 0 57
[junit4] 2> 83918 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721146970112)]} 0 57
[junit4] 2> 83918 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721148018688)]} 0 57
[junit4] 2> 83919 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721149067264)]} 0 57
[junit4] 2> 83920 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721150115840)]} 0 57
[junit4] 2> 83921 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721151164416)]} 0 57
[junit4] 2> 83922 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1460008721151164417)]} 0 57
[junit4] 2> 83922 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:500&start=0&qt=standard&version=2.2&rows=20} hits=0 status=0 QTime=0
[junit4] 2> 83924 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721154310144)]} 0 57
[junit4] 2> 83925 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721154310145)]} 0 57
[junit4] 2> 83925 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721155358720)]} 0 57
[junit4] 2> 83926 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721156407296)]} 0 57
[junit4] 2> 83926 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721156407297)]} 0 57
[junit4] 2> 83927 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721157455872)]} 0 57
[junit4] 2> 83927 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721157455873)]} 0 57
[junit4] 2> 83928 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721158504448)]} 0 57
[junit4] 2> 83928 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721158504449)]} 0 57
[junit4] 2> 83929 T234 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1460008721159553024)]} 0 57
[junit4] 2> 83929 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={version=2.2&rows=20&q=id:530&start=0&qt=standard} hits=1 status=0 QTime=0
[junit4] 2> 84924 T241 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 84930 T241 oass.SolrIndexSearcher.<init> Opening Searcher@a433667c[collection1] main
[junit4] 2> 84931 T241 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 84932 T240 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a433667c[collection1] main{StandardDirectoryReader(segments_2:15:nrt _3(4.7):c10/9:delGen=1)}
[junit4] 2> 85182 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={version=2.2&rows=20&start=0&q=id:500&qt=standard} hits=1 status=0 QTime=0
[junit4] 2> 85184 T234 C175 oasc.SolrCore.execute [collection1] webapp=null path=null params={version=2.2&rows=20&start=0&q=id:530&qt=standard} hits=0 status=0 QTime=0
[junit4] 2> 85186 T234 oas.SolrTestCaseJ4.tearDown ###Ending testCommitWithin
[junit4] 2> 85190 T234 oas.SolrTestCaseJ4.setUp ###Starting testMaxDocs
[junit4] 2> 85191 T234 C175 oass.SolrIndexSearcher.<init> Opening Searcher@df109b46[collection1] realtime
[junit4] 2> 85192 T234 C175 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1460008722482855936)} 0 1
[junit4] 2> 85194 T234 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 85195 T234 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 85195 T234 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 85196 T234 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 85231 T234 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 85276 T234 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 85277 T234 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 85289 T234 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 85644 T234 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 85644 T234 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 85645 T234 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 85651 T234 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 85653 T234 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 85660 T234 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 85664 T234 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 85667 T234 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 85667 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 85668 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 85668 T234 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 85669 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 85669 T234 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 85670 T234 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/
[junit4] 2> 85670 T234 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 85671 T234 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index/
[junit4] 2> 85671 T234 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 85672 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 85672 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 85673 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 85673 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 85674 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 85674 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 85674 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 85675 T234 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 85675 T234 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 85676 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 85676 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 85676 T234 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 85677 T234 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 85677 T234 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 85678 T234 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 85678 T234 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 85678 T234 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 85679 T234 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 85679 T234 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 85680 T234 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 85680 T234 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 85680 T234 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 85681 T234 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 85681 T234 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 85682 T234 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 85682 T234 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 85682 T234 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 85683 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 85683 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 85683 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 85684 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 85684 T234 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 85685 T234 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 85685 T234 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 85685 T234 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 85686 T234 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 85687 T234 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 85688 T234 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 85690 T234 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 85690 T234 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 85691 T234 oass.SolrIndexSearcher.<init> Opening Searcher@f5948e66[collection1] main
[junit4] 2> 85691 T234 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 85692 T234 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 85697 T234 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 85698 T234 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 85698 T234 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 85697 T242 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f5948e66[collection1] main{StandardDirectoryReader(segments_2:17:nrt)}
[junit4] 2> 85699 T234 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_3,generation=3}
[junit4] 2> 85699 T234 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 85700 T234 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=305000755, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 85701 T234 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_3,generation=3}
[junit4] 2> 85701 T234 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 85702 T234 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 85702 T234 oass.SolrIndexSearcher.<init> Opening Searcher@1eb90e9a[collection1] main
[junit4] 2> 85703 T234 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 85703 T234 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4ddd2b40
[junit4] 2> 85703 T242 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1eb90e9a[collection1] main{StandardDirectoryReader(segments_3:17:nrt)}
[junit4] 2> 85703 T234 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=3,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=12,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=12,cumulative_deletesById=11,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 85704 T234 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 85707 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[0 (1460008723022872576)]} 0 1
[junit4] 2> 85708 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[1 (1460008723023921152)]} 0 1
[junit4] 2> 85708 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[2 (1460008723024969728)]} 0 1
[junit4] 2> 85709 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[3 (1460008723026018304)]} 0 1
[junit4] 2> 85710 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[4 (1460008723027066880)]} 0 1
[junit4] 2> 85711 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[5 (1460008723028115456)]} 0 1
[junit4] 2> 85712 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[6 (1460008723028115457)]} 0 1
[junit4] 2> 85712 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[7 (1460008723029164032)]} 0 1
[junit4] 2> 85713 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[8 (1460008723030212608)]} 0 1
[junit4] 2> 85714 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[9 (1460008723031261184)]} 0 1
[junit4] 2> 85715 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[10 (1460008723032309760)]} 0 1
[junit4] 2> 85716 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[11 (1460008723032309761)]} 0 1
[junit4] 2> 85717 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[12 (1460008723033358336)]} 0 1
[junit4] 2> 85717 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[13 (1460008723034406912)]} 0 1
[junit4] 2> ASYNC NEW_CORE C176 name=collection1 org.apache.solr.core.SolrCore@c867ad68
[junit4] 2> 85718 T234 C176 oasc.SolrCore.execute [collection1] webapp=null path=null params={rows=20&version=2.2&qt=standard&start=0&q=id:1} hits=0 status=0 QTime=0
[junit4] 2> 85720 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[14 (1460008723037552640)]} 0 1
[junit4] 2> 85721 T243 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 85727 T243 oass.SolrIndexSearcher.<init> Opening Searcher@9ddbfd28[collection1] main
[junit4] 2> 85727 T243 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 85728 T242 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9ddbfd28[collection1] main{StandardDirectoryReader(segments_3:19:nrt _4(4.7):c15)}
[junit4] 2> 85972 T234 oasup.LogUpdateProcessor.finish [collection1] {add=[15 (1460008723300745216)]} 0 1
[junit4] 2> 85972 T234 C176 oasc.SolrCore.execute [collection1] webapp=null path=null params={version=2.2&rows=20&q=id:14&start=0&qt=standard} hits=1 status=0 QTime=0
[junit4] 2> 85975 T234 C176 oasc.SolrCore.execute [collection1] webapp=null path=null params={rows=20&version=2.2&qt=standard&q=id:15&start=0} hits=0 status=0 QTime=1
[junit4] 2> 85977 T234 oas.SolrTestCaseJ4.tearDown ###Ending testMaxDocs
[junit4] 2> 85980 T234 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 85980 T234 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=256644271
[junit4] 2> 85981 T234 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@c867ad68
[junit4] 2> 85981 T234 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommit maxDocs=14,soft autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=16,adds=1,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=16,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 85982 T234 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 85982 T234 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 85982 T234 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 85984 T234 C176 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@95b3358a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2bb6f6da)),segFN=segments_4,generation=4}
[junit4] 2> 85985 T234 C176 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 85986 T234 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 85986 T234 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 85986 T234 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index;done=false>>]
[junit4] 2> 85987 T234 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054/index
[junit4] 2> 85987 T234 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-AutoCommitTest-1392372809054;done=false>>]
[junit4] 2> 85987 T234
[...truncated too long message...]
irectUpdateHandler2.commit end_commit_flush
[junit4] 2> 180018 T659 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@67eebdfe[collection1] main{StandardDirectoryReader(segments_z:140:nrt)}
[junit4] 2> 180018 T657 C101 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
[junit4] 2> 180023 T657 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 180299 T657 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 180301 T657 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f9d5334f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f3d41151)),segFN=segments_z,generation=35}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f9d5334f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f3d41151)),segFN=segments_10,generation=36}
[junit4] 2> 180301 T657 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 36
[junit4] 2> 180302 T657 oass.SolrIndexSearcher.<init> Opening Searcher@58cb244b[collection1] main
[junit4] 2> 180303 T657 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 180305 T659 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@58cb244b[collection1] main{StandardDirectoryReader(segments_10:142:nrt _14(4.7):c5/1:delGen=1)}
[junit4] 2> 180306 T657 oas.SolrTestCaseJ4.tearDown ###Ending testNonStringFieldsValues
[junit4] 2> 180310 T657 oas.SolrTestCaseJ4.setUp ###Starting testNonIndexedSignatureField
[junit4] 2> 180311 T657 C101 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 180311 T657 C101 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 180313 T657 C101 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 180313 T657 C101 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f9d5334f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f3d41151)),segFN=segments_10,generation=36}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f9d5334f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f3d41151)),segFN=segments_11,generation=37}
[junit4] 2> 180314 T657 C101 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 37
[junit4] 2> 180314 T657 C101 oass.SolrIndexSearcher.<init> Opening Searcher@712d5137[collection1] main
[junit4] 2> 180315 T657 C101 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 180317 T659 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@712d5137[collection1] main{StandardDirectoryReader(segments_11:143:nrt)}
[junit4] 2> 180318 T657 C101 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 180323 T657 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 180325 T657 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f9d5334f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f3d41151)),segFN=segments_11,generation=37}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f9d5334f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f3d41151)),segFN=segments_12,generation=38}
[junit4] 2> 180325 T657 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 38
[junit4] 2> 180327 T657 oass.SolrIndexSearcher.<init> Opening Searcher@cc048f48[collection1] main
[junit4] 2> 180327 T657 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 180329 T659 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@cc048f48[collection1] main{StandardDirectoryReader(segments_12:145:nrt _15(4.7):c2)}
[junit4] 2> 180330 T657 oas.SolrTestCaseJ4.tearDown ###Ending testNonIndexedSignatureField
[junit4] 2> 180332 T657 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 180332 T657 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1853847040
[junit4] 2> 180333 T657 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@d10eee18
[junit4] 2> 180350 T657 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=42,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=253,cumulative_deletesById=0,cumulative_deletesByQuery=6,cumulative_errors=0}
[junit4] 2> 180350 T657 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 180350 T657 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 180351 T657 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 180351 T657 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 180351 T657 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 180352 T657 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1392372913585 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1392372913585;done=false>>]
[junit4] 2> 180352 T657 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1392372913585
[junit4] 2> 180352 T657 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1392372913585/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1392372913585/index;done=false>>]
[junit4] 2> 180353 T657 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1392372913585/index
[junit4] 2> NOTE: test params are: codec=Appending, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=ga_IE, timezone=America/Managua
[junit4] 2> NOTE: Linux 3.8.0-35-generic amd64/IBM Corporation 1.7.0 (64-bit)/cpus=8,threads=1,free=32950904,total=198508544
[junit4] 2> NOTE: All tests run in this JVM: [TestFreeTextSuggestions, BadIndexSchemaTest, TestRecovery, TestWordDelimiterFilterFactory, TestCopyFieldCollectionResource, TestLazyCores, DisMaxRequestHandlerTest, MultiTermTest, AddBlockUpdateTest, TestXIncludeConfig, ChaosMonkeySafeLeaderTest, TestPhraseSuggestions, NumericFieldsTest, DistanceFunctionTest, TestNoOpRegenerator, TestMaxScoreQueryParser, FieldAnalysisRequestHandlerTest, XsltUpdateRequestHandlerTest, TestZkChroot, SolrCoreCheckLockOnStartupTest, SimplePostToolTest, TestPartialUpdateDeduplication, PrimUtilsTest, StatsComponentTest, SolrRequestParserTest, PluginInfoTest, HardAutoCommitTest, TestIndexingPerformance, TimeZoneUtilsTest, TestAnalyzedSuggestions, CursorMarkTest, HighlighterConfigTest, TestFastOutputStream, TestManagedSchemaFieldResource, TestStressLucene, SuggesterWFSTTest, RAMDirectoryFactoryTest, HdfsCollectionsAPIDistributedZkTest, TestNumberUtils, TestStressUserVersions, TestUpdate, TestHashPartitioner, SolrPluginUtilsTest, CurrencyFieldOpenExchangeTest, SignatureUpdateProcessorFactoryTest]
[junit4] Completed on J1 in 1.76s, 6 tests, 2 failures <<< FAILURES!
[...truncated 761 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:459: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:452: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:491: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1308: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:941: There were test failures: 362 suites, 1562 tests, 1 error, 2 failures, 72 ignored (8 assumptions)
Total time: 38 minutes 5 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/ibm-j9-jdk7 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure