You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/12/13 18:36:23 UTC
[JENKINS] Lucene-Solr-Tests-5.x-Java7 - Build # 2323 - Failure
Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.x-Java7/2323/
1 tests failed.
REGRESSION: org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds
Error Message:
soft529 wasn't fast enough
Stack Trace:
java.lang.AssertionError: soft529 wasn't fast enough
at __randomizedtesting.SeedInfo.seed([F772DD44458DAE07:A6A624C4F4FE9EA0]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds(SoftAutoCommitTest.java:111)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 8869 lines...]
[junit4] Suite: org.apache.solr.update.SoftAutoCommitTest
[junit4] 2> log4j:WARN No such property [conversionPattern] in org.apache.solr.util.SolrLogLayout.
[junit4] 2> Creating dataDir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001
[junit4] 2> 4688 T11 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
[junit4] 2> 4870 T11 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 5366 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 5378 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 5379 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 5380 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 7342 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 7907 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 7993 T11 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 8210 T11 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 12035 T11 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 12125 T11 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 12129 T11 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 13779 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 13833 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 13843 T11 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 13857 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 13858 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 13859 T11 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 13862 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 13863 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 13888 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 13889 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr
[junit4] 2> 13890 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/'
[junit4] 2> 14246 T11 oasc.CoreContainer.<init> New CoreContainer 654645043
[junit4] 2> 14247 T11 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/]
[junit4] 2> 14414 T11 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 14414 T11 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 14415 T11 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 14416 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 14416 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 14417 T11 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 14417 T11 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 14418 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 14419 T11 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 14419 T11 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 15551 T11 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 15575 T11 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 15582 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 15592 T11 oasc.CoreContainer.load Host Name:
[junit4] 2> 15959 T12 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 15962 T12 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 15964 T12 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 15965 T12 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 16252 T12 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 16341 T12 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 16343 T12 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 16428 T12 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 17022 T12 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 17054 T12 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 17058 T12 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 17103 T12 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 17113 T12 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 17121 T12 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 17124 T12 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 17125 T12 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 17126 T12 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 17127 T12 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 17128 T12 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 17138 T12 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/
[junit4] 2> 17567 T12 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 17606 T12 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/
[junit4] 2> 17616 T12 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 17843 T12 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001
[junit4] 2> 17844 T12 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index/
[junit4] 2> 17845 T12 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index' doesn't exist. Creating new index...
[junit4] 2> 17873 T12 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index
[junit4] 2> 17876 T12 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=15, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4649423947397895]
[junit4] 2> 18272 T12 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_1,generation=1}
[junit4] 2> 18281 T12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 18401 T12 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 20961 T12 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 21186 T12 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 21187 T12 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 21188 T12 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 21188 T12 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 21189 T12 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 21190 T12 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 21247 T12 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 21247 T12 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 21561 T12 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 21562 T12 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 21563 T12 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 21726 T12 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 21727 T12 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 21728 T12 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 21728 T12 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 21729 T12 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 21730 T12 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 21775 T12 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 21785 T12 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 21786 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 21788 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 21789 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 21790 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 21790 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 21791 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 21792 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 21793 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 21850 T12 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 22035 T12 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 22036 T12 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 22112 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 22193 T12 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 22194 T12 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 22194 T12 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 22202 T12 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 22202 T12 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 22203 T12 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 22203 T12 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 22204 T12 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 22205 T12 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 22205 T12 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 22206 T12 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 22206 T12 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 22266 T12 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 22327 T12 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 22327 T12 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-def: solr.SearchHandler
[junit4] 2> 22328 T12 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-invariants: solr.SearchHandler
[junit4] 2> 22620 T12 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 22667 T12 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 22670 T12 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 22672 T12 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 22682 T12 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 22877 T12 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 22878 T12 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 22879 T12 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=21, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=32.8701171875, floorSegmentMB=1.3759765625, forceMergeDeletesPctAllowed=15.524390822296661, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 22909 T12 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_1,generation=1}
[junit4] 2> 22909 T12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 23207 T12 oass.SolrIndexSearcher.<init> Opening Searcher@9a9303c[collection1] main
[junit4] 2> 23293 T12 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 23483 T12 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 23483 T12 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 23509 T12 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 23510 T12 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 23511 T12 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 24259 T12 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 25375 T12 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 25390 T12 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 25390 T13 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9a9303c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 25438 T11 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 25504 T11 oas.SolrTestCaseJ4.setUp ###Starting testSoftAndHardCommitMaxTimeMixedAdds
[junit4] 2> 25505 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 25507 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 25509 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 25510 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 25756 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 25855 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 25857 T11 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 25952 T11 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 26889 T11 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 26919 T11 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 26926 T11 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 26972 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 26983 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 26992 T11 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 26995 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 26996 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 26998 T11 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 27000 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 27001 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 27002 T11 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/
[junit4] 2> 27003 T11 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/
[junit4] 2> 27004 T11 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 27005 T11 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index/
[junit4] 2> 27006 T11 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 27010 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 27012 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 27013 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 27014 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 27015 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 27017 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 27018 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 27020 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 27021 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 27022 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 27024 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 27025 T11 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 27027 T11 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 27028 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 27029 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 27031 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 27032 T11 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 27033 T11 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 27034 T11 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 27035 T11 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 27036 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 27039 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 27040 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 27041 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 27043 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 27044 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 27046 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 27047 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 27049 T11 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 27050 T11 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 27051 T11 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 27053 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 27054 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 27056 T11 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 27057 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 27058 T11 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 27060 T11 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 27061 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 27062 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 27064 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 27066 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 27067 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 27068 T11 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 27069 T11 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 27070 T11 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 27071 T11 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 27072 T11 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-def: solr.SearchHandler
[junit4] 2> 27073 T11 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-invariants: solr.SearchHandler
[junit4] 2> 27103 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 27108 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 27112 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 27116 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 27120 T11 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 27134 T11 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 27136 T11 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 27137 T11 oass.SolrIndexSearcher.<init> Opening Searcher@9720f12[collection1] main
[junit4] 2> 27139 T11 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 27140 T11 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 27142 T11 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 27143 T11 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 27143 T11 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 27144 T11 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 27151 T11 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 27182 T11 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 27184 T15 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9720f12[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 27185 T11 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 27186 T11 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 27187 T11 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 27190 T11 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=50, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 27193 T11 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_1,generation=1}
[junit4] 2> 27194 T11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 27196 T11 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 27198 T11 oass.SolrIndexSearcher.<init> Opening Searcher@29fe1277[collection1] main
[junit4] 2> 27208 T11 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 27209 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@395c2873
[junit4] 2> 27210 T11 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=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 27211 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 27233 T15 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@29fe1277[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> ASYNC NEW_CORE C0 name=collection1 org.apache.solr.core.SolrCore@b3d0a63
[junit4] 2> 29124 T11 C0 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[529 (1487393009405263872)]} 0 1890
[junit4] 2> 29604 T17 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 30248 T11 oas.SolrTestCaseJ4.tearDown ###Ending testSoftAndHardCommitMaxTimeMixedAdds
[junit4] 2> 30304 T16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SoftAutoCommitTest -Dtests.method=testSoftAndHardCommitMaxTimeMixedAdds -Dtests.seed=F772DD44458DAE07 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=pl -Dtests.timezone=Asia/Thimphu -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 5.07s J3 | SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds <<<
[junit4] > Throwable #1: java.lang.AssertionError: soft529 wasn't fast enough
[junit4] > at __randomizedtesting.SeedInfo.seed([F772DD44458DAE07:A6A624C4F4FE9EA0]:0)
[junit4] > at org.apache.solr.update.SoftAutoCommitTest.testSoftAndHardCommitMaxTimeMixedAdds(SoftAutoCommitTest.java:111)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 30548 T11 oas.SolrTestCaseJ4.setUp ###Starting testSoftAndHardCommitMaxTimeDelete
[junit4] 2> 30549 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 30552 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 30554 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 30556 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 30960 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 31107 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 31109 T11 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 31395 T11 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 31451 T17 oass.SolrIndexSearcher.<init> Opening Searcher@41016a75[collection1] main
[junit4] 2> 31463 T17 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 31463 T15 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@41016a75[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1)))}
[junit4] 2> 31465 T16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_2,generation=2}
[junit4] 2> 31466 T16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 31468 T16 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 31471 T16 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 32150 T11 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 32177 T11 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 32184 T11 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 32228 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 32255 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 32265 T11 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 32268 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 32269 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 32270 T11 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 32271 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 32272 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 32273 T11 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/
[junit4] 2> 32275 T11 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/
[junit4] 2> 32276 T11 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 32277 T11 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index/
[junit4] 2> 32280 T11 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 32283 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 32284 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 32285 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 32286 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 32287 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 32288 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 32289 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 32291 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 32292 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 32294 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 32295 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 32298 T11 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 32300 T11 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 32301 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 32302 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 32304 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 32305 T11 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 32306 T11 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 32307 T11 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 32308 T11 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 32309 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 32311 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 32312 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 32313 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 32314 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 32315 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 32317 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 32318 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 32319 T11 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 32320 T11 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 32321 T11 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 32322 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 32323 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 32324 T11 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 32325 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 32326 T11 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 32327 T11 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 32328 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 32328 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 32330 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 32331 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 32332 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 32333 T11 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 32334 T11 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 32336 T11 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 32337 T11 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 32337 T11 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-def: solr.SearchHandler
[junit4] 2> 32338 T11 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-invariants: solr.SearchHandler
[junit4] 2> 32366 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 32369 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 32374 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 32377 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 32381 T11 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 32415 T11 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 32416 T11 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 32418 T11 oass.SolrIndexSearcher.<init> Opening Searcher@33a76e2e[collection1] main
[junit4] 2> 32420 T11 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 32421 T11 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 32421 T11 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 32422 T11 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 32423 T11 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 32424 T11 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 32428 T11 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 32462 T11 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 32469 T18 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@33a76e2e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1)))}
[junit4] 2> 32471 T11 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 32472 T11 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 32473 T11 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 32482 T11 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@5cde5e61
[junit4] 2> 32491 T11 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_2,generation=2}
[junit4] 2> 32492 T11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 32493 T11 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 32502 T11 oass.SolrIndexSearcher.<init> Opening Searcher@49e3c29e[collection1] main
[junit4] 2> 32505 T18 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@49e3c29e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1)))}
[junit4] 2> 32506 T11 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 32507 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@b3d0a63
[junit4] 2> 32509 T11 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommit maxTime=1200ms,autocommits=1,soft autocommit maxTime=500ms,soft autocommits=1,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=143,transaction_logs_total_number=1}
[junit4] 2> 32512 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> ASYNC NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@7020573e
[junit4] 2> 32522 T11 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[529 (1487393014121758720)]} 0 7
[junit4] 2> 32526 T11 C1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 32700 T11 C1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_3,generation=3}
[junit4] 2> 32701 T11 C1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 32708 T11 C1 oass.SolrIndexSearcher.<init> Opening Searcher@4fc9273e[collection1] main
[junit4] 2> 32710 T18 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4fc9273e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.0.0):c1)))}
[junit4] 2> 32711 T11 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 32714 T11 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 188
[junit4] 2> 32726 T11 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {delete=[529 (-1487393014340911104)]} 0 3
[junit4] 2> 33234 T20 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 33249 T20 oass.SolrIndexSearcher.<init> Opening Searcher@76966a1d[collection1] main
[junit4] 2> 33251 T20 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 33251 T18 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@76966a1d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 33257 T11 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[550 (1487393014894559232)]} 0 6
[junit4] 2> 33758 T20 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 33791 T20 oass.SolrIndexSearcher.<init> Opening Searcher@59052e[collection1] main
[junit4] 2> 33792 T20 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 33793 T18 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@59052e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(5.0.0):c1)))}
[junit4] 2> 33928 T19 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 33930 T19 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_4,generation=4}
[junit4] 2> 33931 T19 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 33932 T19 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 33933 T19 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 35934 T11 oas.SolrTestCaseJ4.tearDown ###Ending testSoftAndHardCommitMaxTimeDelete
[junit4] 2> 35957 T11 oas.SolrTestCaseJ4.setUp ###Starting testSoftAndHardCommitMaxTimeRapidAdds
[junit4] 2> 35958 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 35960 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 35962 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 35963 T11 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 36270 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 36395 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 36397 T11 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml
[junit4] 2> 36464 T11 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 37072 T11 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 37101 T11 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 37107 T11 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 37151 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 37162 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 37171 T11 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 37173 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 37174 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 37175 T11 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 37176 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 37177 T11 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 37178 T11 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/
[junit4] 2> 37179 T11 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/
[junit4] 2> 37180 T11 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 37180 T11 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index/
[junit4] 2> 37181 T11 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 37184 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 37185 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 37185 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 37186 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 37187 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 37188 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 37189 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 37190 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 37191 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 37193 T11 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 37195 T11 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 37196 T11 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 37197 T11 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 37198 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 37199 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 37200 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 37201 T11 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 37202 T11 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 37203 T11 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 37204 T11 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 37204 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 37206 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 37207 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 37207 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 37208 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 37209 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 37210 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 37211 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 37211 T11 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 37212 T11 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 37213 T11 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 37214 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 37215 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 37215 T11 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 37216 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 37216 T11 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 37217 T11 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 37218 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 37219 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 37219 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 37221 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 37222 T11 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 37223 T11 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 37224 T11 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 37225 T11 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 37226 T11 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 37227 T11 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-def: solr.SearchHandler
[junit4] 2> 37228 T11 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-invariants: solr.SearchHandler
[junit4] 2> 37259 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 37262 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 37267 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 37269 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 37278 T11 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 37282 T11 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 37283 T11 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 37285 T11 oass.SolrIndexSearcher.<init> Opening Searcher@1457e85c[collection1] main
[junit4] 2> 37286 T11 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 37287 T11 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 37287 T11 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 37288 T11 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 37289 T11 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 37289 T11 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 37296 T11 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 37320 T11 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 37321 T11 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 37321 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1457e85c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(5.0.0):c1)))}
[junit4] 2> 37322 T11 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 37323 T11 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 37325 T11 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 37332 T11 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_4,generation=4}
[junit4] 2> 37333 T11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 37334 T11 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 37346 T11 oass.SolrIndexSearcher.<init> Opening Searcher@4786e866[collection1] main
[junit4] 2> 37348 T11 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 37348 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4786e866[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(5.0.0):c1)))}
[junit4] 2> 37349 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7020573e
[junit4] 2> 37353 T11 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=4,autocommit maxTime=1200ms,autocommits=1,soft autocommit maxTime=500ms,soft autocommits=2,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=1,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=437,transaction_logs_total_number=3}
[junit4] 2> 37355 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> ASYNC NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@66fec404
[junit4] 2> 37364 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5000 (1487393019200012288)]} 0 7
[junit4] 2> 37370 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5001 (1487393019210498048)]} 0 2
[junit4] 2> 37376 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5002 (1487393019216789504)]} 0 2
[junit4] 2> 37382 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5003 (1487393019223080960)]} 0 2
[junit4] 2> 37388 T11 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5004 (1487393019229372416)]} 0 3
[junit4] 2> 37391 T11 oas.SolrTestCaseJ4.tearDown ###Ending testSoftAndHardCommitMaxTimeRapidAdds
[junit4] 2> 37398 T11 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 37399 T11 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=654645043
[junit4] 2> 37400 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@66fec404
[junit4] 2> 37401 T11 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommit maxTime=1200ms,autocommits=0,soft autocommit maxTime=500ms,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=5,adds=5,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=437,transaction_logs_total_number=3}
[junit4] 2> 37402 T11 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 37403 T11 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 37404 T11 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 37405 T11 C2 oasu.DirectUpdateHandler2.closeWriter Committing on IndexWriter close.
[junit4] 2> 37444 T11 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@68de1359 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4bc86dd8)),segFN=segments_5,generation=5}
[junit4] 2> 37445 T11 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 37447 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 37449 T11 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 37451 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index;done=false>>]
[junit4] 2> 37451 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001/index
[junit4] 2> 37452 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001 [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001;done=false>>]
[junit4] 2> 37453 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001/init-core-data-001
[junit4] 2> NOTE: leaving temporary files on disk at: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.update.SoftAutoCommitTest-F772DD44458DAE07-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), _version_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), range_facet_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), id=PostingsFormat(name=Memory doPackFST= true), subject=FSTOrd50, multiDefault=FSTOrd50, intDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), text=BlockTreeOrds(blocksize=128)}, docValues:{timestamp=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, locale=pl, timezone=Asia/Thimphu
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 (64-bit)/cpus=16,threads=1,free=116684608,total=249561088
[junit4] 2> NOTE: All tests run in this JVM: [SoftAutoCommitTest]
[junit4] Completed on J3 in 38.43s, 3 tests, 1 failure <<< FAILURES!
[...truncated 1468 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:529: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:477: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:61: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/extra-targets.xml:39: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build.xml:190: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/common-build.xml:508: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:1363: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:970: There were test failures: 450 suites, 1843 tests, 1 failure, 60 ignored (23 assumptions)
Total time: 60 minutes 15 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-5.x-Java7 #2322
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 228327464 bytes
Compression is 0.0%
Took 42 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-Tests-5.x-Java7 - Build # 2324 - Still
Failing
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.x-Java7/2324/
1 tests failed.
FAILED: org.apache.solr.client.solrj.TestLBHttpSolrServer.testReliability
Error Message:
No live SolrServers available to handle this request
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request
at __randomizedtesting.SeedInfo.seed([174F5484CF53E770:D68789C26E3536D9]:0)
at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:539)
at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:91)
at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
at org.apache.solr.client.solrj.TestLBHttpSolrServer.testReliability(TestLBHttpSolrServer.java:223)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:11313/solr
at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:579)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:492)
... 43 more
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:152)
at java.net.SocketInputStream.read(SocketInputStream.java:122)
at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260)
at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123)
at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486)
at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57)
at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:465)
... 46 more
Build Log:
[...truncated 10745 lines...]
[junit4] Suite: org.apache.solr.client.solrj.TestLBHttpSolrServer
[junit4] 2> SLF4J: Class path contains multiple SLF4J bindings.
[junit4] 2> SLF4J: Found binding in [jar:file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/solrj/test-lib/slf4j-log4j12-1.7.6.jar!/org/slf4j/impl/StaticLoggerBinder.class]
[junit4] 2> SLF4J: Found binding in [jar:file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/lib/slf4j-log4j12-1.7.6.jar!/org/slf4j/impl/StaticLoggerBinder.class]
[junit4] 2> SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
[junit4] 2> SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
[junit4] 2> log4j:WARN No such property [conversionPattern] in org.apache.solr.util.SolrLogLayout.
[junit4] 2> Creating dataDir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/init-core-data-001
[junit4] 2> 4860 T11 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
[junit4] 2> 5082 T11 oas.SolrTestCaseJ4.setUp ###Starting testReliability
[junit4] 2> 6968 T11 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 7498 T11 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:18621
[junit4] 2> 7723 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 7935 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 7936 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001
[junit4] 2> 7937 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/'
[junit4] 2> 9315 T11 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/solr.xml
[junit4] 2> 9698 T11 oasc.CoreContainer.<init> New CoreContainer 159055558
[junit4] 2> 9708 T11 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/]
[junit4] 2> 9975 T11 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 9976 T11 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 9976 T11 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 9977 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 9978 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 9981 T11 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 9982 T11 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 9983 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 9983 T11 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 9984 T11 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 10445 T11 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 10477 T11 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 10487 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 10505 T11 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 11396 T23 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/'
[junit4] 2> 11790 T23 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 12067 T23 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 12146 T23 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf/schema.xml
[junit4] 2> 12209 T23 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 12691 T23 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 12717 T23 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/
[junit4] 2> 13115 T23 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockFSDirectoryFactory
[junit4] 2> 13162 T23 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/
[junit4] 2> 13163 T23 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 13316 T23 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data
[junit4] 2> 13318 T23 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index/
[junit4] 2> 13320 T23 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 13340 T23 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index
[junit4] 2> 13629 T23 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> 13636 T23 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 15678 T23 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 15878 T23 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 15879 T23 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 15880 T23 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 15881 T23 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 15882 T23 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 15891 T23 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 15893 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 15895 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 15896 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 15897 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 15898 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 15899 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 15899 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 15907 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 15908 T23 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 15946 T23 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 15946 T23 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 15947 T23 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 15954 T23 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 15983 T23 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 16054 T23 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 16239 T23 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 16273 T23 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 16275 T23 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 16278 T23 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 16388 T23 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 16389 T23 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 16418 T23 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> 16419 T23 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 16610 T23 oass.SolrIndexSearcher.<init> Opening Searcher@716acb4e[collection1] main
[junit4] 2> 16666 T23 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf
[junit4] 2> 16667 T23 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf}
[junit4] 2> 16789 T23 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf
[junit4] 2> 16790 T23 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 16811 T23 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf
[junit4] 2> 16812 T23 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 17015 T23 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 17016 T23 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 17025 T24 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@716acb4e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 17029 T11 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0
[junit4] 2> 17030 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C0 name=collection1 org.apache.solr.core.SolrCore@2d9917bc
[junit4] 2> 20208 T18 C0 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 1480
[junit4] 2> 20590 T18 C0 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 21858 T18 C0 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_2,generation=2}
[junit4] 2> 21862 T18 C0 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 22134 T18 C0 oass.SolrIndexSearcher.<init> Opening Searcher@1fe569ac[collection1] main
[junit4] 2> 22142 T18 C0 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 22158 T24 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1fe569ac[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C10)))}
[junit4] 2> 22160 T18 C0 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={softCommit=false&waitSearcher=true&commit=true&wt=javabin&version=2} {commit=} 0 1570
[junit4] 2> 22183 T11 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 22186 T11 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:23356
[junit4] 2> 22187 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 22188 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 22189 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001
[junit4] 2> 22190 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/'
[junit4] 2> 22253 T11 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/solr.xml
[junit4] 2> 22400 T11 oasc.CoreContainer.<init> New CoreContainer 1484331793
[junit4] 2> 22401 T11 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/]
[junit4] 2> 22404 T11 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 22405 T11 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 22405 T11 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 22406 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 22407 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 22408 T11 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 22408 T11 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 22409 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 22410 T11 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 22411 T11 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 22412 T11 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 22413 T11 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 22414 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 22415 T11 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 22422 T35 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/'
[junit4] 2> 22495 T35 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 22570 T35 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 22572 T35 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/conf/schema.xml
[junit4] 2> 22582 T35 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 22605 T35 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 22607 T35 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/
[junit4] 2> 22607 T35 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockFSDirectoryFactory
[junit4] 2> 22608 T35 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/
[junit4] 2> 22609 T35 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 22611 T35 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data
[junit4] 2> 22612 T35 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index/
[junit4] 2> 22614 T35 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 22615 T35 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index
[junit4] 2> 22623 T35 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> 22624 T35 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 22626 T35 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 22627 T35 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 22628 T35 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 22628 T35 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 22629 T35 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 22630 T35 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 22630 T35 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 22631 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 22632 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 22632 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 22633 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 22634 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 22634 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 22635 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 22635 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 22636 T35 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 22637 T35 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 22637 T35 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 22638 T35 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 22638 T35 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 22639 T35 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 22639 T35 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 22662 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 22664 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 22666 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 22668 T35 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 22671 T35 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 22672 T35 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 22676 T35 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> 22676 T35 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 22677 T35 oass.SolrIndexSearcher.<init> Opening Searcher@2bda037e[collection1] main
[junit4] 2> 22678 T35 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/conf
[junit4] 2> 22678 T35 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/conf}
[junit4] 2> 22679 T35 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/conf
[junit4] 2> 22680 T35 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 22681 T35 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/conf
[junit4] 2> 22682 T35 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 22682 T35 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 22683 T36 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2bda037e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 22683 T35 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 22684 T11 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0
[junit4] 2> 22685 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@77d7aa76
[junit4] 2> 22695 T28 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 6
[junit4] 2> 22700 T28 C1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 22724 T28 C1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_2,generation=2}
[junit4] 2> 22724 T28 C1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 22730 T28 C1 oass.SolrIndexSearcher.<init> Opening Searcher@299a3d4[collection1] main
[junit4] 2> 22731 T28 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 22731 T36 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@299a3d4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C10)))}
[junit4] 2> 22732 T28 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={softCommit=false&waitSearcher=true&commit=true&wt=javabin&version=2} {commit=} 0 33
[junit4] 2> 22743 T11 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 22746 T11 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:11313
[junit4] 2> 22747 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 22747 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 22748 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001
[junit4] 2> 22748 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/'
[junit4] 2> 22765 T11 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/solr.xml
[junit4] 2> 22838 T11 oasc.CoreContainer.<init> New CoreContainer 1118682820
[junit4] 2> 22839 T11 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/]
[junit4] 2> 22840 T11 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 22841 T11 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 22841 T11 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 22842 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 22842 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 22843 T11 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 22844 T11 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 22844 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 22845 T11 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 22845 T11 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 22846 T11 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 22847 T11 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 22847 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 22848 T11 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 22854 T47 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/'
[junit4] 2> 22913 T47 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 22970 T47 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 22972 T47 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/conf/schema.xml
[junit4] 2> 22982 T47 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 23000 T47 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 23002 T47 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/
[junit4] 2> 23003 T47 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockFSDirectoryFactory
[junit4] 2> 23004 T47 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/
[junit4] 2> 23005 T47 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 23007 T47 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data
[junit4] 2> 23009 T47 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index/
[junit4] 2> 23011 T47 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 23013 T47 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index
[junit4] 2> 23023 T47 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> 23024 T47 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 23028 T47 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 23029 T47 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 23030 T47 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 23031 T47 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 23032 T47 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 23033 T47 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 23033 T47 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 23034 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 23036 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 23037 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 23037 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 23038 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 23039 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 23040 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 23041 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 23042 T47 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 23043 T47 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 23043 T47 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 23044 T47 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 23044 T47 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 23045 T47 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 23046 T47 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 23050 T47 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 23053 T47 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 23057 T47 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 23060 T47 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 23065 T47 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 23066 T47 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 23071 T47 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> 23072 T47 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 23073 T47 oass.SolrIndexSearcher.<init> Opening Searcher@3c03a9a1[collection1] main
[junit4] 2> 23074 T47 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/conf
[junit4] 2> 23075 T47 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/conf}
[junit4] 2> 23076 T47 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/conf
[junit4] 2> 23078 T47 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 23079 T47 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/conf
[junit4] 2> 23080 T47 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 23080 T47 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 23081 T48 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3c03a9a1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23082 T47 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 23083 T11 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0
[junit4] 2> 23084 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@676bf22f
[junit4] 2> 23094 T40 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 7
[junit4] 2> 23099 T40 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 23131 T40 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_2,generation=2}
[junit4] 2> 23132 T40 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 23140 T40 C2 oass.SolrIndexSearcher.<init> Opening Searcher@373afe05[collection1] main
[junit4] 2> 23141 T40 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 23141 T48 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@373afe05[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C10)))}
[junit4] 2> 23142 T40 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={softCommit=false&waitSearcher=true&commit=true&wt=javabin&version=2} {commit=} 0 44
[junit4] 2> 23145 T11 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1484331793
[junit4] 2> 23146 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@77d7aa76
[junit4] 2> 23147 T11 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=10,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 23148 T11 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 23148 T11 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 23149 T11 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 23152 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 23154 T11 oasc.CachingDirectoryFactory.close Closing MockFSDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 23155 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index;done=false>>]
[junit4] 2> 23156 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index
[junit4] 2> 23349 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data;done=false>>]
[junit4] 2> 23350 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data
[junit4] 2> 23352 T11 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> ASYNC NEW_CORE C3 name=collection1 org.apache.solr.core.SolrCore@2d9917bc
[junit4] 2> 28949 T16 C3 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=10 status=0 QTime=727
[junit4] 2> ASYNC NEW_CORE C4 name=collection1 org.apache.solr.core.SolrCore@676bf22f
[junit4] 2> 28949 T44 C4 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=10 status=0 QTime=206
[junit4] 2> 28995 T11 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=159055558
[junit4] 2> 28996 T11 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 29008 T16 C3 oass.SolrDispatchFilter.writeResponse Unable to write response, client closed connection or we are shutting down org.eclipse.jetty.io.EofException
[junit4] 2> at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:142)
[junit4] 2> at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:107)
[junit4] 2> at org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:214)
[junit4] 2> at org.apache.solr.common.util.FastOutputStream.flushBuffer(FastOutputStream.java:207)
[junit4] 2> at org.apache.solr.common.util.JavaBinCodec.marshal(JavaBinCodec.java:98)
[junit4] 2> at org.apache.solr.response.BinaryResponseWriter.write(BinaryResponseWriter.java:52)
[junit4] 2> at org.apache.solr.response.QueryResponseWriterUtil.writeQueryResponse(QueryResponseWriterUtil.java:50)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.writeResponse(SolrDispatchFilter.java:765)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:422)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:201)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:137)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 2> at org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 2> at org.eclipse.jetty.server.BlockingHttpConnection.handleRequest(BlockingHttpConnection.java:53)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:942)
[junit4] 2> at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1004)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:640)
[junit4] 2> at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
[junit4] 2> at org.eclipse.jetty.server.BlockingHttpConnection.handle(BlockingHttpConnection.java:72)
[junit4] 2> at org.eclipse.jetty.server.bio.SocketConnector$ConnectorEndPoint.run(SocketConnector.java:264)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 29010 T16 C3 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2d9917bc
[junit4] 2> 29011 T16 C3 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=10,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 29011 T16 C3 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 29012 T16 C3 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 29012 T16 C3 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 29022 T16 C3 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 29023 T16 C3 oasc.CachingDirectoryFactory.close Closing MockFSDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 29024 T16 C3 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index;done=false>>]
[junit4] 2> 29024 T16 C3 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index
[junit4] 2> 29036 T16 C3 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data;done=false>>]
[junit4] 2> 29037 T16 C3 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data
[junit4] 2> 29607 T41 C4 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&rows=0&sort=_docid_+asc&wt=javabin&q=*:*&version=2} hits=10 status=0 QTime=110
[junit4] 2> 34041 T11 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1118682820
[junit4] 2> 34042 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@676bf22f
[junit4] 2> 34043 T11 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=10,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 34044 T11 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 34045 T11 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 34045 T11 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 34055 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 34057 T11 oasc.CachingDirectoryFactory.close Closing MockFSDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 34058 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data;done=false>>]
[junit4] 2> 34058 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data
[junit4] 2> 34060 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index;done=false>>]
[junit4] 2> 34061 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index
[junit4] 2> 34077 T11 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 39053 T11 oas.SolrTestCaseJ4.tearDown ###Ending testReliability
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestLBHttpSolrServer -Dtests.method=testReliability -Dtests.seed=174F5484CF53E770 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=th -Dtests.timezone=Antarctica/Mawson -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 34.2s J0 | TestLBHttpSolrServer.testReliability <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request
[junit4] > at __randomizedtesting.SeedInfo.seed([174F5484CF53E770:D68789C26E3536D9]:0)
[junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:539)
[junit4] > at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:91)
[junit4] > at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
[junit4] > at org.apache.solr.client.solrj.TestLBHttpSolrServer.testReliability(TestLBHttpSolrServer.java:223)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:11313/solr
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:579)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
[junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrServer.request(LBHttpSolrServer.java:492)
[junit4] > ... 43 more
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:152)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:122)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
[junit4] > at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260)
[junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
[junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
[junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:465)
[junit4] > ... 46 more
[junit4] 2> 39268 T11 oas.SolrTestCaseJ4.setUp ###Starting testTwoServers
[junit4] 2> 39280 T11 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 39283 T11 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:56800
[junit4] 2> 39284 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 39285 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 39285 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001
[junit4] 2> 39286 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/'
[junit4] 2> 39331 T11 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/solr.xml
[junit4] 2> 39431 T11 oasc.CoreContainer.<init> New CoreContainer 2022975100
[junit4] 2> 39431 T11 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/]
[junit4] 2> 39433 T11 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 39434 T11 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 39434 T11 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 39435 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 39435 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 39436 T11 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 39436 T11 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 39437 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 39438 T11 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 39438 T11 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 39439 T11 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 39440 T11 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 39441 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 39441 T11 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 39448 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/'
[junit4] 2> 39505 T60 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 39560 T60 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 39561 T60 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf/schema.xml
[junit4] 2> 39570 T60 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 39591 T60 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 39592 T60 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/
[junit4] 2> 39593 T60 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockFSDirectoryFactory
[junit4] 2> 39593 T60 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/
[junit4] 2> 39594 T60 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 39595 T60 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data
[junit4] 2> 39596 T60 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index/
[junit4] 2> 39597 T60 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 39599 T60 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index
[junit4] 2> 39609 T60 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> 39609 T60 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 39612 T60 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 39613 T60 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 39614 T60 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 39614 T60 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 39615 T60 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 39615 T60 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 39616 T60 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 39617 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 39618 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 39618 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 39619 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 39619 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 39620 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 39621 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 39621 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 39622 T60 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 39622 T60 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 39623 T60 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 39623 T60 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 39624 T60 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 39625 T60 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 39625 T60 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 39643 T60 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 39645 T60 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 39648 T60 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 39651 T60 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 39654 T60 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 39654 T60 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 39658 T60 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> 39659 T60 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 39659 T60 oass.SolrIndexSearcher.<init> Opening Searcher@78f01077[collection1] main
[junit4] 2> 39660 T60 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf
[junit4] 2> 39661 T60 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf}
[junit4] 2> 39661 T60 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf
[junit4] 2> 39662 T60 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 39663 T60 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/conf
[junit4] 2> 39664 T60 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 39664 T60 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 39665 T61 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@78f01077[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 39665 T60 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 39666 T11 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0
[junit4] 2> 39667 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C5 name=collection1 org.apache.solr.core.SolrCore@3a111dff
[junit4] 2> 39676 T53 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9]} 0 6
[junit4] 2> 39680 T53 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 39699 T53 C5 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(NIOFSDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c32cdeb),segFN=segments_2,generation=2}
[junit4] 2> 39700 T53 C5 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 39704 T53 C5 oass.SolrIndexSearcher.<init> Opening Searcher@21b52472[collection1] main
[junit4] 2> 39705 T53 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 39705 T61 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@21b52472[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):C10)))}
[junit4] 2> 39706 T53 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={softCommit=false&waitSearcher=true&commit=true&wt=javabin&version=2} {commit=} 0 26
[junit4] 2> 39715 T11 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 39718 T11 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:56805
[junit4] 2> 39719 T11 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 39720 T11 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 39720 T11 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001
[junit4] 2> 39721 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/'
[junit4] 2> 39740 T11 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/solr.xml
[junit4] 2> 39810 T11 oasc.CoreContainer.<init> New CoreContainer 1494344563
[junit4] 2> 39811 T11 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/]
[junit4] 2> 39813 T11 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 39813 T11 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 39814 T11 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 39814 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 39815 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 39816 T11 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 39816 T11 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 39817 T11 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 39817 T11 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 39818 T11 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 39819 T11 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 39820 T11 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 39820 T11 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 39821 T11 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 39827 T72 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/'
[junit4] 2> 39876 T72 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 39922 T72 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 39923 T72 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/conf/schema.xml
[junit4] 2> 39931 T72 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 39945 T72 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 39946 T72 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/
[junit4] 2> 39947 T72 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockFSDirectoryFactory
[junit4] 2> 39947 T72 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/
[junit4] 2> 39
[...truncated too long message...]
llection1] Closing main searcher on request.
[junit4] 2> 72801 T11 oasc.CachingDirectoryFactory.close Closing MockFSDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 72802 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data;done=false>>]
[junit4] 2> 72802 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data
[junit4] 2> 72803 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index;done=false>>]
[junit4] 2> 72804 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-0-001/collection1/data/index
[junit4] 2> 72814 T11 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 77802 T11 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=69191309
[junit4] 2> 77803 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2a859b96
[junit4] 2> 77804 T11 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=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 77804 T11 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 77805 T11 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 77805 T11 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 77810 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 77811 T11 oasc.CachingDirectoryFactory.close Closing MockFSDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 77812 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index;done=false>>]
[junit4] 2> 77812 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data/index
[junit4] 2> 77826 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data;done=false>>]
[junit4] 2> 77827 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-1-001/collection1/data
[junit4] 2> 77828 T11 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 82812 T11 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=984065633
[junit4] 2> 82813 T11 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7f2dcd23
[junit4] 2> 82814 T11 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=10,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 82815 T11 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 82815 T11 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 82816 T11 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 82820 T11 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 82821 T11 oasc.CachingDirectoryFactory.close Closing MockFSDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 82822 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data;done=false>>]
[junit4] 2> 82823 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data
[junit4] 2> 82824 T11 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index;done=false>>]
[junit4] 2> 82824 T11 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001/instance-2-001/collection1/data/index
[junit4] 2> 82839 T11 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 87823 T11 oas.SolrTestCaseJ4.tearDown ###Ending testSimple
[junit4] 2> 87829 T11 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.TestLBHttpSolrServer-174F5484CF53E770-001
[junit4] 2> NOTE: test params are: codec=Lucene50, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=th, timezone=Antarctica/Mawson
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 (64-bit)/cpus=16,threads=4,free=204964864,total=237502464
[junit4] 2> NOTE: All tests run in this JVM: [TestLBHttpSolrServer]
[junit4] Completed on J0 in 88.60s, 3 tests, 1 error <<< FAILURES!
[...truncated 99 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:529: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:477: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:61: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/extra-targets.xml:39: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build.xml:203: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/common-build.xml:508: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:1363: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:970: There were test failures: 52 suites, 329 tests, 1 error
Total time: 64 minutes 56 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-Tests-5.x-Java7 #2322
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 9284303 bytes
Compression is 0.0%
Took 2.1 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure