You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/08/08 18:46:44 UTC
[JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.8.0-ea-b99) - Build #
6844 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/6844/
Java: 64bit/jdk1.8.0-ea-b99 -XX:-UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.search.TestIndexSearcher
Error Message:
ERROR: SolrIndexSearcher opens=56 closes=53
Stack Trace:
java.lang.AssertionError: ERROR: SolrIndexSearcher opens=56 closes=53
at __randomizedtesting.SeedInfo.seed([9C20BA5F97330CB7]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:326)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:132)
at sun.reflect.GeneratedMethodAccessor25.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:491)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:700)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at java.lang.Thread.run(Thread.java:724)
REGRESSION: org.apache.solr.search.TestIndexSearcher.testReopen
Error Message:
expected:<_0(4.5):c2> but was:<_3(4.5):c6>
Stack Trace:
java.lang.AssertionError: expected:<_0(4.5):c2> but was:<_3(4.5):c6>
at __randomizedtesting.SeedInfo.seed([9C20BA5F97330CB7:B0686B49E40F8394]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:147)
at org.apache.solr.search.TestIndexSearcher.testReopen(TestIndexSearcher.java:92)
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:491)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at java.lang.Thread.run(Thread.java:724)
Build Log:
[...truncated 10334 lines...]
[junit4] Suite: org.apache.solr.search.TestIndexSearcher
[junit4] 2> 817635 T3565 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966
[junit4] 2> 817635 T3565 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 817635 T3565 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 817636 T3565 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 817660 T3565 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 817679 T3565 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 817679 T3565 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 817684 T3565 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 817778 T3565 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 817779 T3565 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 817779 T3565 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 817783 T3565 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 817784 T3565 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 817788 T3565 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 817789 T3565 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 817792 T3565 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 817792 T3565 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 817792 T3565 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4] 2> 817792 T3565 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4] 2> 817799 T3565 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 817799 T3565 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4] 2> 817800 T3565 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4] 2> 817812 T3565 oasc.CoreContainer.<init> New CoreContainer 110311409
[junit4] 2> 817813 T3565 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
[junit4] 2> 817813 T3565 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 817813 T3565 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 817813 T3565 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 817813 T3565 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 817814 T3565 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4] 2> 817817 T3565 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 817819 T3566 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 817819 T3566 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 817820 T3566 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 817820 T3566 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 817851 T3566 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
[junit4] 2> 817880 T3566 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 817881 T3566 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 817889 T3566 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 818010 T3566 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 818010 T3566 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 818011 T3566 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 818015 T3566 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 818017 T3566 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 818022 T3566 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 818024 T3566 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 818026 T3566 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 818026 T3566 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 818026 T3566 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 818027 T3566 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 818027 T3566 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 818027 T3566 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 818027 T3566 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 818028 T3566 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966/
[junit4] 2> 818028 T3566 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e8873a9
[junit4] 2> 818028 T3566 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966
[junit4] 2> 818029 T3566 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966/index/
[junit4] 2> 818029 T3566 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966/index' doesn't exist. Creating new index...
[junit4] 2> 818029 T3566 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966/index
[junit4] 2> 818030 T3566 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_1,generation=1}
[junit4] 2> 818030 T3566 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 818031 T3566 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 818034 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 818034 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 818035 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 818035 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 818036 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 818036 T3566 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 818036 T3566 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 818037 T3566 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 818037 T3566 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 818037 T3566 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 818038 T3566 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 818038 T3566 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 818038 T3566 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 818038 T3566 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 818039 T3566 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 818039 T3566 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 818039 T3566 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 818039 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 818040 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 818040 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 818040 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 818040 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 818041 T3566 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 818041 T3566 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 818041 T3566 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 818041 T3566 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 818043 T3566 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 818044 T3566 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 818045 T3566 oasc.SolrCore.initDeprecatedSupport WARN adding ShowFileRequestHandler with hidden files: [THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-REQUIRED-FIELDS.XML, SCHEMA-REPLICATION2.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SCHEMA-MINIMAL.XML, BAD-SCHEMA-DOCVALUES-NOT-REQUIRED-NO-DEFAULT.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-CACHING.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-REPEATER.XML, REGEX-BOOST-PROCESSOR-TEST.TXT, SOLRCONFIG-MERGEPOLICY.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, CURRENCY.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-COMPONENTS-NAME.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA11.XML, SOLRCONFIG-BASIC.XML, DA_COMPOUNDDICTIONARY.TXT, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-SLAVE.XML, ELEVATE.XML, TRIVIAL.UPDATEPROCESSOR0.JS, SCHEMA-SWEETSPOT.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SCHEMA-IB.XML, SCHEMA-CHARFILTERS.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SOLRCONFIG-QUERYSENDER.XML, SCHEMA-REPLICATION1.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, DA_UTF8.XML, BAD-SOLRCONFIG-MULTIPLE-INDEXCONFIGS.XML, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SHOULD-FAIL-TEST.XML, SCHEMA-TINY.XML, CONDITIONAL.UPDATEPROCESSOR.JS, SOLRCONFIG-DEFAULTS.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SOLRCONFIG-ENABLEPLUGIN.XML, HYPHENATION.DTD, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, STEMDICT.TXT, SCHEMA-PHRASESUGGEST.XML, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, HUNSPELL-TEST.AFF, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, SCHEMA-SNIPPET-TYPE.XML, STOPTYPES-1.TXT, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, SOLRCONFIG-TRANSFORMERS.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SCHEMA-DOCVALUES.XML, SOLRCONFIG-TLOG-MUTABLE-MANAGED-SCHEMA.XML, SOLRCONFIG-INFOSTREAM-LOGGING.XML, WDFTYPES.TXT, SCHEMA-REVERSED.XML, STOPTYPES-2.TXT, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG-PHRASESUGGEST.XML, SCHEMA-DFR.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, KEEP-1.TXT, SCHEMA-SPATIAL.XML, OPEN-EXCHANGE-RATES.JSON, STOPWITHBOM.TXT, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-WARMER.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SCHEMA-XINCLUDE.XML, SOLRCONFIG-MASTER1.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SCHEMA-BEHAVIOR.XML, SYNONYMS.TXT, SOLRCONFIG-MINIMAL.XML, SCHEMA-DOCVALUESMULTI.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, SCHEMA_CODEC.XML, SCHEMA-SNIPPET-TYPES.INCL, BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SCHEMA-EFF.XML, SOLRCONFIG-FUNCTIONQUERY.XML, STOP-2.TXT, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-TERMINDEX.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, SOLRCONFIG-ELEVATE.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, STOPWORDS.TXT, SCHEMA-FOLDING.XML, SCHEMA-STOP-KEEP.XML, BAD-SCHEMA-BOGUS-FIELD-PARAMETERS.XML, FUZZYSUGGEST.TXT, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SCHEMA-REST.XML, SOLRCONFIG-TLOG-MANAGED-SCHEMA.XML, SOLRCONFIG-PARSING-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, STOP-1.TXT, SOLRCONFIG-MANAGED-SCHEMA.XML, SOLRCONFIG-MASTER2.XML, SOLRCONFIG-MERGEPOLICY-DEFAULTS.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SOLRCONFIG-LAZYWRITER.XML, SCHEMA-LUCENEMATCHVERSION.XML, SCHEMA-CLASS-NAME-SHORTENING-ON-SERIALIZATION.XML, FRENCHARTICLES.TXT, BAD-MP-SOLRCONFIG.XML, SCHEMA15.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMASURROUND.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MASTER3.XML, HUNSPELL-TEST.DIC, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-XINCLUDE.XML, SOLRCONFIG-SLAVE1.XML, SOLRCONFIG-DELPOLICY1.XML, SCHEMA-SIM.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-COLLATE.XML, STOP-SNOWBALL.TXT, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, PROTWORDS.TXT, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CHAINS.XML, SCHEMA-TRIE.XML, SOLRCONFIG_CODEC.XML, SCHEMA-SYNONYM-TOKENIZER.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, JASUGGEST.TXT, SCHEMA-REST-LUCENE-MATCH-VERSION.XML, BAD-SOLRCONFIG-MULTIPLE-CFS.XML, SCHEMA-DOCVALUESFACETING.XML, SCHEMA-TFIDF.XML, SCHEMA-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-LMJELINEKMERCER.XML, PHRASESUGGEST.TXT, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, OLD_SYNONYMS.TXT, SOLRCONFIG-DELPOLICY2.XML, XSLT, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-MUTABLE-MANAGED-SCHEMA.XML, SOLRCONFIG-NOCACHE.XML, SCHEMA-BM25.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-ALTDIRECTORY.XML, COMPOUNDDICTIONARY.TXT, SOLRCONFIG_PERF.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEFAULT-CODE.XML, BAD-CURRENCY.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, KEEP-2.TXT, SCHEMA12.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, MAPPING-ISOLATIN1ACCENT.TXT, BAD_SOLRCONFIG.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML]
[junit4] 2> 818046 T3566 oass.SolrIndexSearcher.<init> Opening Searcher@619334cb main
[junit4] 2> 818046 T3566 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 818047 T3566 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 818047 T3566 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 818092 T3566 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 818111 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@619334cb main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 818114 T3566 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 818117 T3565 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 818120 T3565 oas.SolrTestCaseJ4.setUp ###Starting testReopen
[junit4] 2> ASYNC NEW_CORE C3872 name=collection1 org.apache.solr.core.SolrCore@66373019
[junit4] 2> 818124 T3565 C3872 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_1,generation=1}
[junit4] 2> 818130 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 818131 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1442819691987861504)]} 0 8
[junit4] 2> 818138 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2 (1442819692002541568)]} 0 1
[junit4] 2> 818141 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818143 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_2,generation=2}
[junit4] 2> 818144 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 818144 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@732a636f main
[junit4] 2> 818145 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818146 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@732a636f main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):c2)}
[junit4] 2> 818146 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 818151 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[3 (1442819692016173056)]} 0 1
[junit4] 2> 818154 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692020367360)]} 0 0
[junit4] 2> 818158 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818160 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_3,generation=3}
[junit4] 2> 818161 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 818162 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@6963b041 main
[junit4] 2> 818162 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818163 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6963b041 main{StandardDirectoryReader(segments_3:5:nrt _0(4.5):c2 _1(4.5):c2)}
[junit4] 2> 818164 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 818168 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5 (1442819692033998848)]} 0 1
[junit4] 2> 818171 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[6 (1442819692038193152)]} 0 0
[junit4] 2> 818175 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818184 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_4,generation=4}
[junit4] 2> 818184 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 818185 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@5925aab1 main
[junit4] 2> 818185 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818186 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5925aab1 main{StandardDirectoryReader(segments_4:9:nrt _3(4.5):c6)}
[junit4] 2> 818187 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 13
[junit4] 2> 818187 T3565 oas.SolrTestCaseJ4.tearDown ###Ending testReopen
[junit4] 2> 818191 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@5992df87 realtime
[junit4] 2> 818191 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1442819692058116096)} 0 1
[junit4] 2> 818194 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818195 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_5,generation=5}
[junit4] 2> 818195 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 818195 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@4f3e7528 main
[junit4] 2> 818196 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818197 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f3e7528 main{StandardDirectoryReader(segments_4:11:nrt)}
[junit4] 2> 818197 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestIndexSearcher -Dtests.method=testReopen -Dtests.seed=9C20BA5F97330CB7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ga_IE -Dtests.timezone=America/Costa_Rica -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.09s J1 | TestIndexSearcher.testReopen <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<_0(4.5):c2> but was:<_3(4.5):c6>
[junit4] > at __randomizedtesting.SeedInfo.seed([9C20BA5F97330CB7:B0686B49E40F8394]:0)
[junit4] > at org.apache.solr.search.TestIndexSearcher.testReopen(TestIndexSearcher.java:92)
[junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4] 2> 818208 T3565 oas.SolrTestCaseJ4.setUp ###Starting testCloses
[junit4] 2> 818211 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1442819692079087616)]} 0 1
[junit4] 2> 818213 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818215 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_6,generation=6}
[junit4] 2> 818216 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 818216 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@6400ec34 realtime
[junit4] 2> 818217 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818217 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
[junit4] 2> 818221 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692089573376)]} 0 1
[junit4] 2> 818224 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692092719104)]} 0 1
[junit4] 2> 818230 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[13 (1442819692100059136)]} 0 0
[junit4] 2> 818233 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10 (1442819692103204864)]} 0 0
[junit4] 2> ASYNC NEW_CORE C3873 name=collection1 org.apache.solr.core.SolrCore@66373019
[junit4] 2> 818242 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818244 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_7,generation=7}
[junit4] 2> 818245 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 818245 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@15630e21 realtime
[junit4] 2> 818246 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818246 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
[junit4] 2> 818249 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818252 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@1a533fd6 main
[junit4] 2> 818253 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818254 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a533fd6 main{StandardDirectoryReader(segments_7:17:nrt _6(4.5):c4)}
[junit4] 2> 818254 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 5
[junit4] 2> 818257 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818258 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_8,generation=8}
[junit4] 2> 818258 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 818258 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@7b9e36b4 main
[junit4] 2> 818258 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818260 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7b9e36b4 main{StandardDirectoryReader(segments_7:17:nrt _6(4.5):c4)}
[junit4] 2> 818260 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
[junit4] 2> 818264 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692134662144)]} 0 1
[junit4] 2> 818267 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[14 (1442819692138856448)]} 0 0
[junit4] 2> 818270 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15 (1442819692142002176)]} 0 0
[junit4] 2> 818273 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[3 (1442819692145147904)]} 0 0
[junit4] 2> 818276 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7 (1442819692148293632)]} 0 0
[junit4] 2> 818279 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692151439360)]} 0 0
[junit4] 2> 818282 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818284 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_9,generation=9}
[junit4] 2> 818284 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 818285 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@5fc7231 main
[junit4] 2> 818286 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818287 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5fc7231 main{StandardDirectoryReader(segments_9:19:nrt _6(4.5):c4 _7(4.5):c6)}
[junit4] 2> 818288 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 818291 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818295 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_a,generation=10}
[junit4] 2> 818295 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
[junit4] 2> 818296 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@6650e7f3 realtime
[junit4] 2> 818296 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818297 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 6
[junit4] 2> 818301 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692173459456)]} 0 2
[junit4] 2> 818304 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818311 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@7b2cdae6 main
[junit4] 2> 818311 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818313 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7b2cdae6 main{StandardDirectoryReader(segments_a:26:nrt _a(4.5):c10)}
[junit4] 2> 818313 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 9
[junit4] 2> 818317 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15 (1442819692190236672)]} 0 1
[junit4] 2> 818320 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692194430976)]} 0 1
[junit4] 2> 818323 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692197576704)]} 0 0
[junit4] 2> 818327 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818330 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@186f57c6 main
[junit4] 2> 818330 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818331 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@186f57c6 main{StandardDirectoryReader(segments_a:29:nrt _a(4.5):c10/3 _b(4.5):c3)}
[junit4] 2> 818332 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 818335 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[6 (1442819692210159616)]} 0 1
[junit4] 2> 818338 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818345 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@4099a280 main
[junit4] 2> 818345 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818346 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4099a280 main{StandardDirectoryReader(segments_a:33:nrt _d(4.5):c11)}
[junit4] 2> 818347 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 9
[junit4] 2> 818350 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818350 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@2ea1f5ef main
[junit4] 2> 818351 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818352 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2ea1f5ef main{StandardDirectoryReader(segments_a:33:nrt _d(4.5):c11)}
[junit4] 2> 818352 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
[junit4] 2> 818355 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11 (1442819692231131136)]} 0 0
[junit4] 2> 818358 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818365 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@4909eebc main
[junit4] 2> 818365 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818366 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4909eebc main{StandardDirectoryReader(segments_a:37:nrt _f(4.5):c12)}
[junit4] 2> 818367 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 9
[junit4] 2> 818369 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818370 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@13cbd28d main
[junit4] 2> 818370 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818371 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@13cbd28d main{StandardDirectoryReader(segments_a:37:nrt _f(4.5):c12)}
[junit4] 2> 818372 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
[junit4] 2> 818375 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7 (1442819692251054080)]} 0 1
[junit4] 2> 818378 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818382 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@6d53b389 main
[junit4] 2> 818382 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818383 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d53b389 main{StandardDirectoryReader(segments_a:40:nrt _f(4.5):c12/1 _g(4.5):c1)}
[junit4] 2> 818384 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 818387 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818388 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_a,generation=10}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_b,generation=11}
[junit4] 2> 818388 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
[junit4] 2> 818389 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@deeed76 main
[junit4] 2> 818389 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818390 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@deeed76 main{StandardDirectoryReader(segments_a:40:nrt _f(4.5):c12/1 _g(4.5):c1)}
[junit4] 2> 818390 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
[junit4] 2> 818393 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818394 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@68215c8f main
[junit4] 2> 818394 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818395 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@68215c8f main{StandardDirectoryReader(segments_a:40:nrt _f(4.5):c12/1 _g(4.5):c1)}
[junit4] 2> 818395 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
[junit4] 2> 818398 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818402 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_b,generation=11}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_c,generation=12}
[junit4] 2> 818403 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
[junit4] 2> 818404 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@76039e25 main
[junit4] 2> 818404 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818405 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@76039e25 main{StandardDirectoryReader(segments_c:42:nrt _h(4.5):c12)}
[junit4] 2> 818405 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 7
[junit4] 2> 818408 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818408 T3565 C3873 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 818409 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818409 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 1
[junit4] 2> 818412 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692289851392)]} 0 1
[junit4] 2> 818414 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818422 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_c,generation=12}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_d,generation=13}
[junit4] 2> 818423 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
[junit4] 2> 818424 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@6a13fa8c main
[junit4] 2> 818425 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818426 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6a13fa8c main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
[junit4] 2> 818427 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 13
[junit4] 2> 818430 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818431 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@4fc4d10a main
[junit4] 2> 818432 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818433 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4fc4d10a main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
[junit4] 2> 818434 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 4
[junit4] 2> 818437 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818438 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@a0d1435 main
[junit4] 2> 818438 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818440 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a0d1435 main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
[junit4] 2> 818440 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
[junit4] 2> 818444 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818444 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@73268a21 main
[junit4] 2> 818445 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818446 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@73268a21 main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
[junit4] 2> 818447 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
[junit4] 2> 818450 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818450 T3565 C3873 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 818450 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@1464652b main
[junit4] 2> 818451 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818452 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1464652b main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
[junit4] 2> 818453 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
[junit4] 2> 818455 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818456 T3565 C3873 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 818456 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818456 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 1
[junit4] 2> 818459 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818459 T3565 C3873 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 818459 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@5370a072 main
[junit4] 2> 818459 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818461 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5370a072 main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
[junit4] 2> 818461 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
[junit4] 2> 818465 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11 (1442819692345425920)]} 0 1
[junit4] 2> ASYNC NEW_CORE C3874 name=collection1 org.apache.solr.core.SolrCore@66373019
[junit4] 2> 818472 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818482 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_d,generation=13}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_e,generation=14}
[junit4] 2> 818483 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
[junit4] 2> 818483 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@5bf9850a realtime
[junit4] 2> 818484 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818484 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 12
[junit4] 2> 818488 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[13 (1442819692369543168)]} 0 1
[junit4] 2> 818491 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818497 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@4076f7a5 main
[junit4] 2> 818498 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818499 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4076f7a5 main{StandardDirectoryReader(segments_e:59:nrt _o(4.5):c12)}
[junit4] 2> 818500 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 9
[junit4] 2> 818503 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692386320384)]} 0 1
[junit4] 2> 818506 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11 (1442819692389466112)]} 0 0
[junit4] 2> 818509 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818511 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_e,generation=14}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_f,generation=15}
[junit4] 2> 818511 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
[junit4] 2> 818512 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@15548454 main
[junit4] 2> 818512 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818514 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15548454 main{StandardDirectoryReader(segments_f:62:nrt _o(4.5):c12/2 _p(4.5):c2)}
[junit4] 2> 818514 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 818518 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7 (1442819692401000448)]} 0 1
[junit4] 2> 818521 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818529 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@353eb0e9 main
[junit4] 2> 818529 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818531 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@353eb0e9 main{StandardDirectoryReader(segments_f:67:nrt _r(4.5):c12)}
[junit4] 2> 818531 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 11
[junit4] 2> 818534 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1442819692418826240)]} 0 0
[junit4] 2> 818537 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1442819692421971968)]} 0 0
[junit4] 2> 818540 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692425117696)]} 0 0
[junit4] 2> 818543 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[0 (1442819692428263424)]} 0 0
[junit4] 2> 818546 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818548 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_f,generation=15}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_g,generation=16}
[junit4] 2> 818549 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
[junit4] 2> 818550 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@3b450b76 main
[junit4] 2> 818550 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818551 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3b450b76 main{StandardDirectoryReader(segments_g:70:nrt _r(4.5):c12/2 _s(4.5):c4/1)}
[junit4] 2> 818552 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 818556 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10 (1442819692440846336)]} 0 1
[junit4] 2> 818559 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[0 (1442819692443992064)]} 0 1
[junit4] 2> 818561 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818573 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@61e28dca main
[junit4] 2> 818574 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818575 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@61e28dca main{StandardDirectoryReader(segments_g:79:nrt _w(4.5):c13)}
[junit4] 2> 818576 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 15
[junit4] 2> 818579 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[9 (1442819692464963584)]} 0 1
[junit4] 2> 818582 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692469157888)]} 0 1
[junit4] 2> 818585 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11 (1442819692472303616)]} 0 0
[junit4] 2> 818588 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818590 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_g,generation=16}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_h,generation=17}
[junit4] 2> 818591 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
[junit4] 2> 818592 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@28955802 realtime
[junit4] 2> 818593 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818593 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 818600 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818600 T3565 C3874 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 818600 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@161aa651 main
[junit4] 2> 818601 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818602 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@161aa651 main{StandardDirectoryReader(segments_h:82:nrt _w(4.5):c13/2 _x(4.5):c3)}
[junit4] 2> 818603 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
[junit4] 2> 818605 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818610 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_h,generation=17}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_i,generation=18}
[junit4] 2> 818610 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
[junit4] 2> 818611 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@677a17b7 main
[junit4] 2> 818612 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818613 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@677a17b7 main{StandardDirectoryReader(segments_i:84:nrt _y(4.5):c14)}
[junit4] 2> 818613 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 8
[junit4] 2> 818617 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15 (1442819692504809472)]} 0 1
[junit4] 2> 818619 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818626 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@2410ffc1 main
[junit4] 2> 818627 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818628 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2410ffc1 main{StandardDirectoryReader(segments_i:89:nrt _10(4.5):c14)}
[junit4] 2> 818629 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 10
[junit4] 2> 818635 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818635 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@1fed1fcf main
[junit4] 2> 818636 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818638 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1fed1fcf main{StandardDirectoryReader(segments_i:89:nrt _10(4.5):c14)}
[junit4] 2> 818638 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
[junit4] 2> 818642 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818643 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_i,generation=18}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_j,generation=19}
[junit4] 2> 818643 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
[junit4] 2> 818644 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818644 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
[junit4] 2> 818648 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818648 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@2d389c1f main
[junit4] 2> 818650 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818650 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2d389c1f main{StandardDirectoryReader(segments_i:89:nrt _10(4.5):c14)}
[junit4] 2> 818651 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
[junit4] 2> 818656 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2 (1442819692544655360)]} 0 2
[junit4] 2> 818660 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692549898240)]} 0 1
[junit4] 2> 818664 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818667 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@303d5f1d main
[junit4] 2> 818668 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818669 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@303d5f1d main{StandardDirectoryReader(segments_j:92:nrt _10(4.5):c14/1 _11(4.5):c2)}
[junit4] 2> 818669 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 818672 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818673 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_j,generation=19}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_k,generation=20}
[junit4] 2> 818673 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
[junit4] 2> 818673 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@3d20b0c9 main
[junit4] 2> 818674 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818675 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3d20b0c9 main{StandardDirectoryReader(segments_j:92:nrt _10(4.5):c14/1 _11(4.5):c2)}
[junit4] 2> 818676 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
[junit4] 2> 818678 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818679 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@63b03c70 main
[junit4] 2> 818679 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818680 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@63b03c70 main{StandardDirectoryReader(segments_j:92:nrt _10(4.5):c14/1 _11(4.5):c2)}
[junit4] 2> 818681 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
[junit4] 2> 818684 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692576112640)]} 0 0
[junit4] 2> 818687 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818690 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_k,generation=20}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_l,generation=21}
[junit4] 2> 818691 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
[junit4] 2> 818692 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@ada6078 realtime
[junit4] 2> 818692 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818693 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 818696 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818704 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@55d83d3c main
[junit4] 2> 818705 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818707 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@55d83d3c main{StandardDirectoryReader(segments_l:97:nrt _13(4.5):c15)}
[junit4] 2> 818707 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 11
[junit4] 2> 818712 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692604424192)]} 0 1
[junit4] 2> ASYNC NEW_CORE C3875 name=collection1 org.apache.solr.core.SolrCore@66373019
[junit4] 2> 818721 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7 (1442819692614909952)]} 0 1
[junit4] 2> 818725 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818736 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_l,generation=21}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_m,generation=22}
[junit4] 2> 818737 T3565 C3875 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
[junit4] 2> 818738 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@7dc6b38e realtime
[junit4] 2> 818739 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818739 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 15
[junit4] 2> 818742 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818743 T3565 C3875 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 818743 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818744 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 2
[junit4] 2> 818748 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5 (1442819692642172928)]} 0 1
[junit4] 2> 818752 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692647415808)]} 0 0
[junit4] 2> 818756 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818760 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@6e267926 main
[junit4] 2> 818760 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818762 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6e267926 main{StandardDirectoryReader(segments_m:105:nrt _15(4.5):c15/1 _16(4.5):c2)}
[junit4] 2> 818762 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 818769 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818770 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_m,generation=22}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_n,generation=23}
[junit4] 2> 818771 T3565 C3875 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
[junit4] 2> 818771 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@276c5a0b main
[junit4] 2> 818772 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818774 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@276c5a0b main{StandardDirectoryReader(segments_m:105:nrt _15(4.5):c15/1 _16(4.5):c2)}
[junit4] 2> 818774 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 818779 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2 (1442819692674678784)]} 0 1
[junit4] 2> 818784 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692679921664)]} 0 1
[junit4] 2> 818788 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15 (1442819692685164544)]} 0 1
[junit4] 2> 818791 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818811 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_n,generation=23}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_o,generation=24}
[junit4] 2> 818811 T3565 C3875 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
[junit4] 2> 818812 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@1f7ef847 main
[junit4] 2> 818813 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818814 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f7ef847 main{StandardDirectoryReader(segments_o:114:nrt _1a(4.5):C16)}
[junit4] 2> 818815 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 24
[junit4] 2> 818818 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692716621824)]} 0 1
[junit4] 2> 818821 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692719767552)]} 0 0
[junit4] 2> 818824 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818832 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@22ff293c main
[junit4] 2> 818833 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818834 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@22ff293c main{StandardDirectoryReader(segments_o:119:nrt _1c(4.5):c16)}
[junit4] 2> 818835 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 11
[junit4] 2> 818838 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818838 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_o,generation=24}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_p,generation=25}
[junit4] 2> 818839 T3565 C3875 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
[junit4] 2> 818839 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@1a5bd4c4 main
[junit4] 2> 818839 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818841 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a5bd4c4 main{StandardDirectoryReader(segments_o:119:nrt _1c(4.5):c16)}
[junit4] 2> 818841 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
[junit4] 2> 818844 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818844 T3565 C3875 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 818845 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818845 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 1
[junit4] 2> 818847 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 818848 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@ef9eb75 main
[junit4] 2> 818848 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 818850 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ef9eb75 main{StandardDirectoryReader(segments_o:119:nrt _1c(4.5):c16)}
[junit4] 2> 818850 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
[junit4] 2> 818855 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10 (1442819692754370560)]} 0 1
[junit4] 2> 818858 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 818865 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache
[...truncated too long message...]
.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4] 2> at java.lang.Thread.run(Thread.java:724)
[junit4] 2>
[junit4] 2> 831031 T3565 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966;done=false>>]
[junit4] 2> 831031 T3565 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966
[junit4] 2> 831032 T3565 oasc.SolrException.log ERROR Error closing directory:java.lang.AssertionError: 3
[junit4] 2> at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:199)
[junit4] 2> at org.apache.solr.core.SolrCore.close(SolrCore.java:1041)
[junit4] 2> at org.apache.solr.core.SolrCores.close(SolrCores.java:120)
[junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:367)
[junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:338)
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:535)
[junit4] 2> at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:130)
[junit4] 2> at sun.reflect.GeneratedMethodAccessor25.invoke(Unknown Source)
[junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:491)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:700)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4] 2> at java.lang.Thread.run(Thread.java:724)
[junit4] 2>
[junit4] 2> 952056 T3565 oas.SolrTestCaseJ4.endTrackingSearchers ERROR ERROR: SolrIndexSearcher opens=56 closes=53
[junit4] 2> NOTE: test params are: codec=Asserting, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=ga_IE, timezone=America/Costa_Rica
[junit4] 2> NOTE: Linux 3.2.0-51-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=124186776,total=417333248
[junit4] 2> NOTE: All tests run in this JVM: [HighlighterConfigTest, RequestHandlersTest, SliceStateTest, UUIDFieldTest, DocValuesMultiTest, XmlUpdateRequestHandlerTest, SuggesterTSTTest, DirectSolrConnectionTest, TestRangeQuery, TestOmitPositions, HighlighterTest, CollectionsAPIDistributedZkTest, TermVectorComponentDistributedTest, SpellingQueryConverterTest, OutputWriterTest, TestFuzzyAnalyzedSuggestions, TestFieldCollectionResource, UniqFieldsUpdateProcessorFactoryTest, TestCloudManagedSchema, PreAnalyzedFieldTest, PrimUtilsTest, TestCodecSupport, HdfsLockFactoryTest, CircularListTest, TestPartialUpdateDeduplication, BadCopyFieldTest, SortByFunctionTest, HdfsRecoveryZkTest, TestSchemaResource, NoCacheHeaderTest, SolrCoreCheckLockOnStartupTest, TestReload, TestIndexingPerformance, TestSchemaSimilarityResource, SolrRequestParserTest, DirectUpdateHandlerTest, SpellCheckComponentTest, TestUtils, SolrPluginUtilsTest, ConvertedLegacyTest, TestRandomFaceting, TestSolr4Spatial, OpenCloseCoreStressTest, TestQuerySenderListener, DebugComponentTest, TestSuggestSpellingConverter, TestSolrDeletionPolicy2, LeaderElectionIntegrationTest, TestLazyCores, HardAutoCommitTest, BadIndexSchemaTest, CurrencyFieldXmlFileTest, OpenExchangeRatesOrgProviderTest, TestComponentsName, DeleteShardTest, TestFoldingMultitermQuery, NumericFieldsTest, SpellCheckCollatorTest, TestCSVLoader, PluginInfoTest, HdfsDirectoryTest, CoreAdminCreateDiscoverTest, TestClassNameShortening, TestMultiCoreConfBootstrap, TestFastWriter, RAMDirectoryFactoryTest, TestRecoveryHdfs, TestFiltering, IndexSchemaRuntimeFieldTest, TestAddFieldRealTimeGet, ClusterStateTest, TestCoreDiscovery, ShardRoutingCustomTest, TestUpdate, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, OverseerTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, LeaderElectionTest, ZkSolrClientTest, TestZkChroot, TestRandomDVFaceting, TestRecovery, TestHashPartitioner, TestStressReorder, TestSort, TestIndexSearcher]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestIndexSearcher -Dtests.seed=9C20BA5F97330CB7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ga_IE -Dtests.timezone=America/Costa_Rica -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | TestIndexSearcher (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=56 closes=53
[junit4] > at __randomizedtesting.SeedInfo.seed([9C20BA5F97330CB7]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:326)
[junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:132)
[junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4] Completed on J1 in 134.44s, 2 tests, 2 failures <<< FAILURES!
[...truncated 98 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:395: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:375: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:181: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:449: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1233: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:876: There were test failures: 319 suites, 1350 tests, 1 suite-level error, 1 failure, 39 ignored (6 assumptions)
Total time: 38 minutes 21 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-ea-b99 -XX:-UseCompressedOops -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
Re: [JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.8.0-ea-b99) - Build
# 6844 - Failure!
Posted by Chris Hostetter <ho...@fucit.org>.
Failure certain this is due to merge policy randomization ... i'll dig.
: Date: Thu, 8 Aug 2013 16:46:44 +0000 (UTC)
: From: Policeman Jenkins Server <je...@thetaphi.de>
: Reply-To: dev@lucene.apache.org
: To: dev@lucene.apache.org
: Subject: [JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.8.0-ea-b99) - Build #
: 6844 - Failure!
:
: Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/6844/
: Java: 64bit/jdk1.8.0-ea-b99 -XX:-UseCompressedOops -XX:+UseParallelGC
:
: 2 tests failed.
: FAILED: junit.framework.TestSuite.org.apache.solr.search.TestIndexSearcher
:
: Error Message:
: ERROR: SolrIndexSearcher opens=56 closes=53
:
: Stack Trace:
: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=56 closes=53
: at __randomizedtesting.SeedInfo.seed([9C20BA5F97330CB7]:0)
: at org.junit.Assert.fail(Assert.java:93)
: at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:326)
: at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:132)
: at sun.reflect.GeneratedMethodAccessor25.invoke(Unknown Source)
: at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
: at java.lang.reflect.Method.invoke(Method.java:491)
: at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
: at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
: at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:700)
: at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
: at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
: at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
: at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
: at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
: at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
: at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
: at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
: at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
: at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
: at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
: at java.lang.Thread.run(Thread.java:724)
:
:
: REGRESSION: org.apache.solr.search.TestIndexSearcher.testReopen
:
: Error Message:
: expected:<_0(4.5):c2> but was:<_3(4.5):c6>
:
: Stack Trace:
: java.lang.AssertionError: expected:<_0(4.5):c2> but was:<_3(4.5):c6>
: at __randomizedtesting.SeedInfo.seed([9C20BA5F97330CB7:B0686B49E40F8394]:0)
: at org.junit.Assert.fail(Assert.java:93)
: at org.junit.Assert.failNotEquals(Assert.java:647)
: at org.junit.Assert.assertEquals(Assert.java:128)
: at org.junit.Assert.assertEquals(Assert.java:147)
: at org.apache.solr.search.TestIndexSearcher.testReopen(TestIndexSearcher.java:92)
: 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:491)
: at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
: at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
: at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
: at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
: at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
: at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
: at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
: at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
: at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
: at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
: at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
: at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
: at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
: at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
: at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
: at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
: at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
: at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
: at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
: at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
: at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
: at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
: at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
: at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
: at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
: at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
: at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
: at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
: at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
: at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
: at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
: at java.lang.Thread.run(Thread.java:724)
:
:
:
:
: Build Log:
: [...truncated 10334 lines...]
: [junit4] Suite: org.apache.solr.search.TestIndexSearcher
: [junit4] 2> 817635 T3565 oas.SolrTestCaseJ4.initCore ####initCore
: [junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966
: [junit4] 2> 817635 T3565 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
: [junit4] 2> 817635 T3565 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
: [junit4] 2> 817636 T3565 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
: [junit4] 2> 817660 T3565 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
: [junit4] 2> 817679 T3565 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
: [junit4] 2> 817679 T3565 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
: [junit4] 2> 817684 T3565 oass.IndexSchema.readSchema [null] Schema name=test
: [junit4] 2> 817778 T3565 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
: [junit4] 2> 817779 T3565 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
: [junit4] 2> 817779 T3565 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
: [junit4] 2> 817783 T3565 oass.IndexSchema.readSchema default search field in schema is text
: [junit4] 2> 817784 T3565 oass.IndexSchema.readSchema unique key field: id
: [junit4] 2> 817788 T3565 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
: [junit4] 2> 817789 T3565 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
: [junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
: [junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
: [junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
: [junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
: [junit4] 2> 817791 T3565 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
: [junit4] 2> 817792 T3565 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
: [junit4] 2> 817792 T3565 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
: [junit4] 2> 817792 T3565 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
: [junit4] 2> 817792 T3565 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
: [junit4] 2> 817799 T3565 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
: [junit4] 2> 817799 T3565 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
: [junit4] 2> 817800 T3565 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
: [junit4] 2> 817812 T3565 oasc.CoreContainer.<init> New CoreContainer 110311409
: [junit4] 2> 817813 T3565 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
: [junit4] 2> 817813 T3565 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
: [junit4] 2> 817813 T3565 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
: [junit4] 2> 817813 T3565 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
: [junit4] 2> 817813 T3565 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
: [junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
: [junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
: [junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
: [junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
: [junit4] 2> 817814 T3565 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
: [junit4] 2> 817814 T3565 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
: [junit4] 2> 817817 T3565 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
: [junit4] 2> 817819 T3566 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
: [junit4] 2> 817819 T3566 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
: [junit4] 2> 817820 T3566 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
: [junit4] 2> 817820 T3566 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
: [junit4] 2> 817851 T3566 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_45
: [junit4] 2> 817880 T3566 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
: [junit4] 2> 817881 T3566 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
: [junit4] 2> 817889 T3566 oass.IndexSchema.readSchema [collection1] Schema name=test
: [junit4] 2> 818010 T3566 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
: [junit4] 2> 818010 T3566 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
: [junit4] 2> 818011 T3566 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
: [junit4] 2> 818015 T3566 oass.IndexSchema.readSchema default search field in schema is text
: [junit4] 2> 818017 T3566 oass.IndexSchema.readSchema unique key field: id
: [junit4] 2> 818022 T3566 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
: [junit4] 2> 818024 T3566 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
: [junit4] 2> 818026 T3566 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
: [junit4] 2> 818026 T3566 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
: [junit4] 2> 818026 T3566 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
: [junit4] 2> 818027 T3566 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
: [junit4] 2> 818027 T3566 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
: [junit4] 2> 818027 T3566 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
: [junit4] 2> 818027 T3566 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
: [junit4] 2> 818028 T3566 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966/
: [junit4] 2> 818028 T3566 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1e8873a9
: [junit4] 2> 818028 T3566 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966
: [junit4] 2> 818029 T3566 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966/index/
: [junit4] 2> 818029 T3566 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966/index' doesn't exist. Creating new index...
: [junit4] 2> 818029 T3566 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966/index
: [junit4] 2> 818030 T3566 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_1,generation=1}
: [junit4] 2> 818030 T3566 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
: [junit4] 2> 818031 T3566 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
: [junit4] 2> 818034 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
: [junit4] 2> 818034 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
: [junit4] 2> 818035 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
: [junit4] 2> 818035 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
: [junit4] 2> 818036 T3566 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
: [junit4] 2> 818036 T3566 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
: [junit4] 2> 818036 T3566 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
: [junit4] 2> 818037 T3566 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
: [junit4] 2> 818037 T3566 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
: [junit4] 2> 818037 T3566 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
: [junit4] 2> 818038 T3566 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
: [junit4] 2> 818038 T3566 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
: [junit4] 2> 818038 T3566 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
: [junit4] 2> 818038 T3566 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
: [junit4] 2> 818039 T3566 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
: [junit4] 2> 818039 T3566 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
: [junit4] 2> 818039 T3566 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
: [junit4] 2> 818039 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
: [junit4] 2> 818040 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
: [junit4] 2> 818040 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
: [junit4] 2> 818040 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
: [junit4] 2> 818040 T3566 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
: [junit4] 2> 818041 T3566 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
: [junit4] 2> 818041 T3566 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
: [junit4] 2> 818041 T3566 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
: [junit4] 2> 818041 T3566 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
: [junit4] 2> 818043 T3566 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
: [junit4] 2> 818044 T3566 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
: [junit4] 2> 818045 T3566 oasc.SolrCore.initDeprecatedSupport WARN adding ShowFileRequestHandler with hidden files: [THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-REQUIRED-FIELDS.XML, SCHEMA-REPLICATION2.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SCHEMA-MINIMAL.XML, BAD-SCHEMA-DOCVALUES-NOT-REQUIRED-NO-DEFAULT.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-CACHING.XML, BAD-SOLRCONFIG-UNEXPECTED-SCHEMA-ATTRIBUTE.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-REPEATER.XML, REGEX-BOOST-PROCESSOR-TEST.TXT, SOLRCONFIG-MERGEPOLICY.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-CODE-IN-XML.XML, CURRENCY.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-COMPONENTS-NAME.XML, SOLRCONFIG-MERGEPOLICY-LEGACY.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA11.XML, SOLRCONFIG-BASIC.XML, DA_COMPOUNDDICTIONARY.TXT, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-SLAVE.XML, ELEVATE.XML, TRIVIAL.UPDATEPROCESSOR0.
JS, SCHEMA-SWEETSPOT.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SCHEMA-IB.XML, SCHEMA-CHARFILTERS.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SOLRCONFIG-QUERYSENDER.XML, SCHEMA-REPLICATION1.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, DA_UTF8.XML, BAD-SOLRCONFIG-MULTIPLE-INDEXCONFIGS.XML, BAD-SCHEMA-NON-GLOB-COPYFIELD-SOURCE-MATCHING-NOTHING-SHOULD-FAIL-TEST.XML, SCHEMA-TINY.XML, CONDITIONAL.UPDATEPROCESSOR.JS, SOLRCONFIG-DEFAULTS.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SOLRCONFIG-ENABLEPLUGIN.XML, HYPHENATION.DTD, BAD-SOLRCONFIG-SCHEMA-MUTABLE-BUT-NOT-MANAGED.XML, STEMDICT.TXT, SCHEMA-PHRASESUGGEST.XML, SCHEMA-ID-AND-VERSION-FIELDS-ONLY.XML, HUNSPELL-TEST.AFF, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD-UNIQUE-KEY.XML, BAD-SCHEMA-CURRENCY-FT-OER-NORATES.XML, SCHEMA-SNIPPET-TYPE.XML, STOPTYPES-1.TXT, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, SOLRCONFIG-TRANSFORMERS.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SCHEMA-DOCVALUES.XML, SOLRCONFIG-TLOG-MUTABLE-MANA
GED-SCHEMA.XML, SOLRCONFIG-INFOSTREAM-LOGGING.XML, WDFTYPES.TXT, SCHEMA-REVERSED.XML, STOPTYPES-2.TXT, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, BAD-SCHEMA-BOGUS-ANALYSIS-PARAMETERS.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG-PHRASESUGGEST.XML, SCHEMA-DFR.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, KEEP-1.TXT, SCHEMA-SPATIAL.XML, OPEN-EXCHANGE-RATES.JSON, STOPWITHBOM.TXT, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-WARMER.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SCHEMA-XINCLUDE.XML, SOLRCONFIG-MASTER1.XML, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-SOURCE-SHOULD-FAIL-TEST.XML, SCHEMA-BEHAVIOR.XML, SYNONYMS.TXT, SOLRCONFIG-MINIMAL.XML, SCHEMA-DOCVALUESMULTI.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, BAD-SCHEMA-UNSUPPORTED-DOCVALUES.XML, SCHEMA_CODEC.XML, SCHEMA-SNIPPET-TYPES.INCL, BAD-SCHEMA-SWEETSPOT-PARTIAL-HYPERBOLIC
.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SCHEMA-EFF.XML, SOLRCONFIG-FUNCTIONQUERY.XML, STOP-2.TXT, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-TERMINDEX.XML, SCHEMA-ONE-FIELD-NO-DYNAMIC-FIELD.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-NORMS.XML, SOLRCONFIG-ELEVATE.XML, BAD-SCHEMA-SWEETSPOT-PARTIAL-BASELINE.XML, STOPWORDS.TXT, SCHEMA-FOLDING.XML, SCHEMA-STOP-KEEP.XML, BAD-SCHEMA-BOGUS-FIELD-PARAMETERS.XML, FUZZYSUGGEST.TXT, BAD-SOLRCONFIG-MANAGED-SCHEMA-NAMED-SCHEMA.XML.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SCHEMA-REST.XML, SOLRCONFIG-TLOG-MANAGED-SCHEMA.XML, SOLRCONFIG-PARSING-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, STOP-1.TXT, SOLRCONFIG-MANAGED-SCHEMA.XML, SOLRCONFIG-MASTER2.XML, SOLRCONFIG-MERGEPOLICY-DEFAULTS.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, BAD-SCHEMA-MISPLACED-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, SOLRCONFIG-LAZYWRITER.XML, SCHEMA-LUCENEMATCHVERSION.XML, SCHEMA-CLASS-NAME-SHORTENING-ON-SERIALIZAT
ION.XML, FRENCHARTICLES.TXT, BAD-MP-SOLRCONFIG.XML, SCHEMA15.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMASURROUND.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MASTER3.XML, HUNSPELL-TEST.DIC, BAD-SCHEMA-MULTIPLE-ASTERISK-COPYFIELD-DEST-SHOULD-FAIL-TEST.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-XINCLUDE.XML, SOLRCONFIG-SLAVE1.XML, SOLRCONFIG-DELPOLICY1.XML, SCHEMA-SIM.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-COLLATE.XML, STOP-SNOWBALL.TXT, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, PROTWORDS.TXT, SOLRCONFIG-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR-CHAINS.XML, SCHEMA-TRIE.XML, SOLRCONFIG_CODEC.XML, SCHEMA-SYNONYM-TOKENIZER.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, JASUGGEST.TXT, SCHEMA-REST-LUCENE-MATCH-VERSION.XML, BAD-SOLRCONFIG-MULTIPLE-CFS.XML, SCHEMA-DOCVALUESFACETING.XML, SCHEMA-TFIDF.XML, SCHEMA-ADD-SCHEMA-FIELDS-UPDATE-PROCESSOR.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-LMJELINEKMERCER.XML, PHRASESUGGEST.TXT, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-BASIC-LU
CENEVERSION31.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, OLD_SYNONYMS.TXT, SOLRCONFIG-DELPOLICY2.XML, XSLT, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-MUTABLE-MANAGED-SCHEMA.XML, SOLRCONFIG-NOCACHE.XML, SCHEMA-BM25.XML, BAD-SCHEMA-SWEETSPOT-BOTH-TF.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-ALTDIRECTORY.XML, COMPOUNDDICTIONARY.TXT, SOLRCONFIG_PERF.XML, BAD-SCHEMA-CURRENCY-FT-BOGUS-DEFAULT-CODE.XML, BAD-CURRENCY.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, KEEP-2.TXT, SCHEMA12.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, MAPPING-ISOLATIN1ACCENT.TXT, BAD_SOLRCONFIG.XML, SOLRCONFIG.SNIPPET.RANDOMINDEXCONFIG.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML]
: [junit4] 2> 818046 T3566 oass.SolrIndexSearcher.<init> Opening Searcher@619334cb main
: [junit4] 2> 818046 T3566 oasu.CommitTracker.<init> Hard AutoCommit: disabled
: [junit4] 2> 818047 T3566 oasu.CommitTracker.<init> Soft AutoCommit: disabled
: [junit4] 2> 818047 T3566 oashc.SpellCheckComponent.inform Initializing spell checkers
: [junit4] 2> 818092 T3566 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
: [junit4] 2> 818111 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@619334cb main{StandardDirectoryReader(segments_1:1)}
: [junit4] 2> 818114 T3566 oasc.CoreContainer.registerCore registering core: collection1
: [junit4] 2> 818117 T3565 oas.SolrTestCaseJ4.initCore ####initCore end
: [junit4] 2> 818120 T3565 oas.SolrTestCaseJ4.setUp ###Starting testReopen
: [junit4] 2> ASYNC NEW_CORE C3872 name=collection1 org.apache.solr.core.SolrCore@66373019
: [junit4] 2> 818124 T3565 C3872 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_1,generation=1}
: [junit4] 2> 818130 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
: [junit4] 2> 818131 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1442819691987861504)]} 0 8
: [junit4] 2> 818138 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2 (1442819692002541568)]} 0 1
: [junit4] 2> 818141 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818143 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_1,generation=1}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_2,generation=2}
: [junit4] 2> 818144 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
: [junit4] 2> 818144 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@732a636f main
: [junit4] 2> 818145 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818146 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@732a636f main{StandardDirectoryReader(segments_2:3:nrt _0(4.5):c2)}
: [junit4] 2> 818146 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
: [junit4] 2> 818151 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[3 (1442819692016173056)]} 0 1
: [junit4] 2> 818154 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692020367360)]} 0 0
: [junit4] 2> 818158 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818160 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_2,generation=2}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_3,generation=3}
: [junit4] 2> 818161 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
: [junit4] 2> 818162 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@6963b041 main
: [junit4] 2> 818162 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818163 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6963b041 main{StandardDirectoryReader(segments_3:5:nrt _0(4.5):c2 _1(4.5):c2)}
: [junit4] 2> 818164 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
: [junit4] 2> 818168 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5 (1442819692033998848)]} 0 1
: [junit4] 2> 818171 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[6 (1442819692038193152)]} 0 0
: [junit4] 2> 818175 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818184 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_3,generation=3}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_4,generation=4}
: [junit4] 2> 818184 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
: [junit4] 2> 818185 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@5925aab1 main
: [junit4] 2> 818185 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818186 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5925aab1 main{StandardDirectoryReader(segments_4:9:nrt _3(4.5):c6)}
: [junit4] 2> 818187 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 13
: [junit4] 2> 818187 T3565 oas.SolrTestCaseJ4.tearDown ###Ending testReopen
: [junit4] 2> 818191 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@5992df87 realtime
: [junit4] 2> 818191 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1442819692058116096)} 0 1
: [junit4] 2> 818194 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818195 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_4,generation=4}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_5,generation=5}
: [junit4] 2> 818195 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
: [junit4] 2> 818195 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@4f3e7528 main
: [junit4] 2> 818196 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818197 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f3e7528 main{StandardDirectoryReader(segments_4:11:nrt)}
: [junit4] 2> 818197 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
: [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestIndexSearcher -Dtests.method=testReopen -Dtests.seed=9C20BA5F97330CB7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ga_IE -Dtests.timezone=America/Costa_Rica -Dtests.file.encoding=UTF-8
: [junit4] FAILURE 0.09s J1 | TestIndexSearcher.testReopen <<<
: [junit4] > Throwable #1: java.lang.AssertionError: expected:<_0(4.5):c2> but was:<_3(4.5):c6>
: [junit4] > at __randomizedtesting.SeedInfo.seed([9C20BA5F97330CB7:B0686B49E40F8394]:0)
: [junit4] > at org.apache.solr.search.TestIndexSearcher.testReopen(TestIndexSearcher.java:92)
: [junit4] > at java.lang.Thread.run(Thread.java:724)
: [junit4] 2> 818208 T3565 oas.SolrTestCaseJ4.setUp ###Starting testCloses
: [junit4] 2> 818211 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1442819692079087616)]} 0 1
: [junit4] 2> 818213 T3565 C3872 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818215 T3565 C3872 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_5,generation=5}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_6,generation=6}
: [junit4] 2> 818216 T3565 C3872 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
: [junit4] 2> 818216 T3565 C3872 oass.SolrIndexSearcher.<init> Opening Searcher@6400ec34 realtime
: [junit4] 2> 818217 T3565 C3872 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818217 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
: [junit4] 2> 818221 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692089573376)]} 0 1
: [junit4] 2> 818224 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692092719104)]} 0 1
: [junit4] 2> 818230 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[13 (1442819692100059136)]} 0 0
: [junit4] 2> 818233 T3565 C3872 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10 (1442819692103204864)]} 0 0
: [junit4] 2> ASYNC NEW_CORE C3873 name=collection1 org.apache.solr.core.SolrCore@66373019
: [junit4] 2> 818242 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818244 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_6,generation=6}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_7,generation=7}
: [junit4] 2> 818245 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
: [junit4] 2> 818245 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@15630e21 realtime
: [junit4] 2> 818246 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818246 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
: [junit4] 2> 818249 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818252 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@1a533fd6 main
: [junit4] 2> 818253 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818254 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a533fd6 main{StandardDirectoryReader(segments_7:17:nrt _6(4.5):c4)}
: [junit4] 2> 818254 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 5
: [junit4] 2> 818257 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818258 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_7,generation=7}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_8,generation=8}
: [junit4] 2> 818258 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
: [junit4] 2> 818258 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@7b9e36b4 main
: [junit4] 2> 818258 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818260 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7b9e36b4 main{StandardDirectoryReader(segments_7:17:nrt _6(4.5):c4)}
: [junit4] 2> 818260 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
: [junit4] 2> 818264 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692134662144)]} 0 1
: [junit4] 2> 818267 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[14 (1442819692138856448)]} 0 0
: [junit4] 2> 818270 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15 (1442819692142002176)]} 0 0
: [junit4] 2> 818273 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[3 (1442819692145147904)]} 0 0
: [junit4] 2> 818276 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7 (1442819692148293632)]} 0 0
: [junit4] 2> 818279 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692151439360)]} 0 0
: [junit4] 2> 818282 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818284 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_8,generation=8}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_9,generation=9}
: [junit4] 2> 818284 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
: [junit4] 2> 818285 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@5fc7231 main
: [junit4] 2> 818286 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818287 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5fc7231 main{StandardDirectoryReader(segments_9:19:nrt _6(4.5):c4 _7(4.5):c6)}
: [junit4] 2> 818288 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
: [junit4] 2> 818291 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818295 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_9,generation=9}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_a,generation=10}
: [junit4] 2> 818295 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
: [junit4] 2> 818296 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@6650e7f3 realtime
: [junit4] 2> 818296 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818297 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 6
: [junit4] 2> 818301 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692173459456)]} 0 2
: [junit4] 2> 818304 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818311 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@7b2cdae6 main
: [junit4] 2> 818311 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818313 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7b2cdae6 main{StandardDirectoryReader(segments_a:26:nrt _a(4.5):c10)}
: [junit4] 2> 818313 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 9
: [junit4] 2> 818317 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15 (1442819692190236672)]} 0 1
: [junit4] 2> 818320 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692194430976)]} 0 1
: [junit4] 2> 818323 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692197576704)]} 0 0
: [junit4] 2> 818327 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818330 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@186f57c6 main
: [junit4] 2> 818330 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818331 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@186f57c6 main{StandardDirectoryReader(segments_a:29:nrt _a(4.5):c10/3 _b(4.5):c3)}
: [junit4] 2> 818332 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
: [junit4] 2> 818335 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[6 (1442819692210159616)]} 0 1
: [junit4] 2> 818338 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818345 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@4099a280 main
: [junit4] 2> 818345 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818346 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4099a280 main{StandardDirectoryReader(segments_a:33:nrt _d(4.5):c11)}
: [junit4] 2> 818347 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 9
: [junit4] 2> 818350 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818350 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@2ea1f5ef main
: [junit4] 2> 818351 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818352 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2ea1f5ef main{StandardDirectoryReader(segments_a:33:nrt _d(4.5):c11)}
: [junit4] 2> 818352 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
: [junit4] 2> 818355 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11 (1442819692231131136)]} 0 0
: [junit4] 2> 818358 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818365 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@4909eebc main
: [junit4] 2> 818365 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818366 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4909eebc main{StandardDirectoryReader(segments_a:37:nrt _f(4.5):c12)}
: [junit4] 2> 818367 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 9
: [junit4] 2> 818369 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818370 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@13cbd28d main
: [junit4] 2> 818370 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818371 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@13cbd28d main{StandardDirectoryReader(segments_a:37:nrt _f(4.5):c12)}
: [junit4] 2> 818372 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
: [junit4] 2> 818375 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7 (1442819692251054080)]} 0 1
: [junit4] 2> 818378 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818382 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@6d53b389 main
: [junit4] 2> 818382 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818383 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d53b389 main{StandardDirectoryReader(segments_a:40:nrt _f(4.5):c12/1 _g(4.5):c1)}
: [junit4] 2> 818384 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
: [junit4] 2> 818387 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818388 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_a,generation=10}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_b,generation=11}
: [junit4] 2> 818388 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
: [junit4] 2> 818389 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@deeed76 main
: [junit4] 2> 818389 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818390 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@deeed76 main{StandardDirectoryReader(segments_a:40:nrt _f(4.5):c12/1 _g(4.5):c1)}
: [junit4] 2> 818390 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
: [junit4] 2> 818393 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818394 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@68215c8f main
: [junit4] 2> 818394 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818395 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@68215c8f main{StandardDirectoryReader(segments_a:40:nrt _f(4.5):c12/1 _g(4.5):c1)}
: [junit4] 2> 818395 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
: [junit4] 2> 818398 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818402 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_b,generation=11}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_c,generation=12}
: [junit4] 2> 818403 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
: [junit4] 2> 818404 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@76039e25 main
: [junit4] 2> 818404 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818405 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@76039e25 main{StandardDirectoryReader(segments_c:42:nrt _h(4.5):c12)}
: [junit4] 2> 818405 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 7
: [junit4] 2> 818408 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818408 T3565 C3873 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
: [junit4] 2> 818409 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818409 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 1
: [junit4] 2> 818412 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692289851392)]} 0 1
: [junit4] 2> 818414 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818422 T3565 C3873 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_c,generation=12}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_d,generation=13}
: [junit4] 2> 818423 T3565 C3873 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
: [junit4] 2> 818424 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@6a13fa8c main
: [junit4] 2> 818425 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818426 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6a13fa8c main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
: [junit4] 2> 818427 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 13
: [junit4] 2> 818430 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818431 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@4fc4d10a main
: [junit4] 2> 818432 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818433 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4fc4d10a main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
: [junit4] 2> 818434 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 4
: [junit4] 2> 818437 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818438 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@a0d1435 main
: [junit4] 2> 818438 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818440 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a0d1435 main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
: [junit4] 2> 818440 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
: [junit4] 2> 818444 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818444 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@73268a21 main
: [junit4] 2> 818445 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818446 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@73268a21 main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
: [junit4] 2> 818447 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
: [junit4] 2> 818450 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818450 T3565 C3873 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
: [junit4] 2> 818450 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@1464652b main
: [junit4] 2> 818451 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818452 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1464652b main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
: [junit4] 2> 818453 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
: [junit4] 2> 818455 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818456 T3565 C3873 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
: [junit4] 2> 818456 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818456 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 1
: [junit4] 2> 818459 T3565 C3873 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818459 T3565 C3873 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
: [junit4] 2> 818459 T3565 C3873 oass.SolrIndexSearcher.<init> Opening Searcher@5370a072 main
: [junit4] 2> 818459 T3565 C3873 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818461 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5370a072 main{StandardDirectoryReader(segments_d:47:nrt _j(4.5):c12)}
: [junit4] 2> 818461 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
: [junit4] 2> 818465 T3565 C3873 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11 (1442819692345425920)]} 0 1
: [junit4] 2> ASYNC NEW_CORE C3874 name=collection1 org.apache.solr.core.SolrCore@66373019
: [junit4] 2> 818472 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818482 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_d,generation=13}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_e,generation=14}
: [junit4] 2> 818483 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
: [junit4] 2> 818483 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@5bf9850a realtime
: [junit4] 2> 818484 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818484 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 12
: [junit4] 2> 818488 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[13 (1442819692369543168)]} 0 1
: [junit4] 2> 818491 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818497 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@4076f7a5 main
: [junit4] 2> 818498 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818499 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4076f7a5 main{StandardDirectoryReader(segments_e:59:nrt _o(4.5):c12)}
: [junit4] 2> 818500 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 9
: [junit4] 2> 818503 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692386320384)]} 0 1
: [junit4] 2> 818506 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11 (1442819692389466112)]} 0 0
: [junit4] 2> 818509 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818511 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_e,generation=14}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_f,generation=15}
: [junit4] 2> 818511 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
: [junit4] 2> 818512 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@15548454 main
: [junit4] 2> 818512 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818514 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15548454 main{StandardDirectoryReader(segments_f:62:nrt _o(4.5):c12/2 _p(4.5):c2)}
: [junit4] 2> 818514 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
: [junit4] 2> 818518 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7 (1442819692401000448)]} 0 1
: [junit4] 2> 818521 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818529 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@353eb0e9 main
: [junit4] 2> 818529 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818531 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@353eb0e9 main{StandardDirectoryReader(segments_f:67:nrt _r(4.5):c12)}
: [junit4] 2> 818531 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 11
: [junit4] 2> 818534 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1442819692418826240)]} 0 0
: [junit4] 2> 818537 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1442819692421971968)]} 0 0
: [junit4] 2> 818540 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692425117696)]} 0 0
: [junit4] 2> 818543 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[0 (1442819692428263424)]} 0 0
: [junit4] 2> 818546 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818548 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_f,generation=15}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_g,generation=16}
: [junit4] 2> 818549 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
: [junit4] 2> 818550 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@3b450b76 main
: [junit4] 2> 818550 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818551 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3b450b76 main{StandardDirectoryReader(segments_g:70:nrt _r(4.5):c12/2 _s(4.5):c4/1)}
: [junit4] 2> 818552 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
: [junit4] 2> 818556 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10 (1442819692440846336)]} 0 1
: [junit4] 2> 818559 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[0 (1442819692443992064)]} 0 1
: [junit4] 2> 818561 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818573 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@61e28dca main
: [junit4] 2> 818574 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818575 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@61e28dca main{StandardDirectoryReader(segments_g:79:nrt _w(4.5):c13)}
: [junit4] 2> 818576 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 15
: [junit4] 2> 818579 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[9 (1442819692464963584)]} 0 1
: [junit4] 2> 818582 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692469157888)]} 0 1
: [junit4] 2> 818585 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[11 (1442819692472303616)]} 0 0
: [junit4] 2> 818588 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818590 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_g,generation=16}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_h,generation=17}
: [junit4] 2> 818591 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
: [junit4] 2> 818592 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@28955802 realtime
: [junit4] 2> 818593 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818593 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
: [junit4] 2> 818600 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818600 T3565 C3874 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
: [junit4] 2> 818600 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@161aa651 main
: [junit4] 2> 818601 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818602 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@161aa651 main{StandardDirectoryReader(segments_h:82:nrt _w(4.5):c13/2 _x(4.5):c3)}
: [junit4] 2> 818603 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
: [junit4] 2> 818605 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818610 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_h,generation=17}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_i,generation=18}
: [junit4] 2> 818610 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
: [junit4] 2> 818611 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@677a17b7 main
: [junit4] 2> 818612 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818613 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@677a17b7 main{StandardDirectoryReader(segments_i:84:nrt _y(4.5):c14)}
: [junit4] 2> 818613 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 8
: [junit4] 2> 818617 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15 (1442819692504809472)]} 0 1
: [junit4] 2> 818619 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818626 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@2410ffc1 main
: [junit4] 2> 818627 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818628 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2410ffc1 main{StandardDirectoryReader(segments_i:89:nrt _10(4.5):c14)}
: [junit4] 2> 818629 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 10
: [junit4] 2> 818635 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818635 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@1fed1fcf main
: [junit4] 2> 818636 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818638 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1fed1fcf main{StandardDirectoryReader(segments_i:89:nrt _10(4.5):c14)}
: [junit4] 2> 818638 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
: [junit4] 2> 818642 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818643 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_i,generation=18}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_j,generation=19}
: [junit4] 2> 818643 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
: [junit4] 2> 818644 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818644 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
: [junit4] 2> 818648 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818648 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@2d389c1f main
: [junit4] 2> 818650 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818650 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2d389c1f main{StandardDirectoryReader(segments_i:89:nrt _10(4.5):c14)}
: [junit4] 2> 818651 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
: [junit4] 2> 818656 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2 (1442819692544655360)]} 0 2
: [junit4] 2> 818660 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692549898240)]} 0 1
: [junit4] 2> 818664 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818667 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@303d5f1d main
: [junit4] 2> 818668 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818669 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@303d5f1d main{StandardDirectoryReader(segments_j:92:nrt _10(4.5):c14/1 _11(4.5):c2)}
: [junit4] 2> 818669 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
: [junit4] 2> 818672 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818673 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_j,generation=19}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_k,generation=20}
: [junit4] 2> 818673 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
: [junit4] 2> 818673 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@3d20b0c9 main
: [junit4] 2> 818674 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818675 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3d20b0c9 main{StandardDirectoryReader(segments_j:92:nrt _10(4.5):c14/1 _11(4.5):c2)}
: [junit4] 2> 818676 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
: [junit4] 2> 818678 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818679 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@63b03c70 main
: [junit4] 2> 818679 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818680 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@63b03c70 main{StandardDirectoryReader(segments_j:92:nrt _10(4.5):c14/1 _11(4.5):c2)}
: [junit4] 2> 818681 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
: [junit4] 2> 818684 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4 (1442819692576112640)]} 0 0
: [junit4] 2> 818687 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818690 T3565 C3874 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_k,generation=20}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_l,generation=21}
: [junit4] 2> 818691 T3565 C3874 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
: [junit4] 2> 818692 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@ada6078 realtime
: [junit4] 2> 818692 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818693 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
: [junit4] 2> 818696 T3565 C3874 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818704 T3565 C3874 oass.SolrIndexSearcher.<init> Opening Searcher@55d83d3c main
: [junit4] 2> 818705 T3565 C3874 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818707 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@55d83d3c main{StandardDirectoryReader(segments_l:97:nrt _13(4.5):c15)}
: [junit4] 2> 818707 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 11
: [junit4] 2> 818712 T3565 C3874 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692604424192)]} 0 1
: [junit4] 2> ASYNC NEW_CORE C3875 name=collection1 org.apache.solr.core.SolrCore@66373019
: [junit4] 2> 818721 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[7 (1442819692614909952)]} 0 1
: [junit4] 2> 818725 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818736 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_l,generation=21}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_m,generation=22}
: [junit4] 2> 818737 T3565 C3875 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
: [junit4] 2> 818738 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@7dc6b38e realtime
: [junit4] 2> 818739 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818739 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 15
: [junit4] 2> 818742 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818743 T3565 C3875 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
: [junit4] 2> 818743 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818744 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 2
: [junit4] 2> 818748 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5 (1442819692642172928)]} 0 1
: [junit4] 2> 818752 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692647415808)]} 0 0
: [junit4] 2> 818756 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818760 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@6e267926 main
: [junit4] 2> 818760 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818762 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6e267926 main{StandardDirectoryReader(segments_m:105:nrt _15(4.5):c15/1 _16(4.5):c2)}
: [junit4] 2> 818762 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
: [junit4] 2> 818769 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818770 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_m,generation=22}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_n,generation=23}
: [junit4] 2> 818771 T3565 C3875 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
: [junit4] 2> 818771 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@276c5a0b main
: [junit4] 2> 818772 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818774 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@276c5a0b main{StandardDirectoryReader(segments_m:105:nrt _15(4.5):c15/1 _16(4.5):c2)}
: [junit4] 2> 818774 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
: [junit4] 2> 818779 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2 (1442819692674678784)]} 0 1
: [junit4] 2> 818784 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[8 (1442819692679921664)]} 0 1
: [junit4] 2> 818788 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[15 (1442819692685164544)]} 0 1
: [junit4] 2> 818791 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818811 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_n,generation=23}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_o,generation=24}
: [junit4] 2> 818811 T3565 C3875 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
: [junit4] 2> 818812 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@1f7ef847 main
: [junit4] 2> 818813 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818814 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f7ef847 main{StandardDirectoryReader(segments_o:114:nrt _1a(4.5):C16)}
: [junit4] 2> 818815 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 24
: [junit4] 2> 818818 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692716621824)]} 0 1
: [junit4] 2> 818821 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[12 (1442819692719767552)]} 0 0
: [junit4] 2> 818824 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818832 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@22ff293c main
: [junit4] 2> 818833 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818834 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@22ff293c main{StandardDirectoryReader(segments_o:119:nrt _1c(4.5):c16)}
: [junit4] 2> 818835 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 11
: [junit4] 2> 818838 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818838 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_o,generation=24}
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1554b22d)),segFN=segments_p,generation=25}
: [junit4] 2> 818839 T3565 C3875 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
: [junit4] 2> 818839 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@1a5bd4c4 main
: [junit4] 2> 818839 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818841 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a5bd4c4 main{StandardDirectoryReader(segments_o:119:nrt _1c(4.5):c16)}
: [junit4] 2> 818841 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 3
: [junit4] 2> 818844 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818844 T3565 C3875 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
: [junit4] 2> 818845 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818845 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 1
: [junit4] 2> 818847 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: [junit4] 2> 818848 T3565 C3875 oass.SolrIndexSearcher.<init> Opening Searcher@ef9eb75 main
: [junit4] 2> 818848 T3565 C3875 oasu.DirectUpdateHandler2.commit end_commit_flush
: [junit4] 2> 818850 T3567 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ef9eb75 main{StandardDirectoryReader(segments_o:119:nrt _1c(4.5):c16)}
: [junit4] 2> 818850 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
: [junit4] 2> 818855 T3565 C3875 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10 (1442819692754370560)]} 0 1
: [junit4] 2> 818858 T3565 C3875 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: [junit4] 2> 818865 T3565 C3875 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
: [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b9de351 lockFactory=org.apache
:
: [...truncated too long message...]
:
: .StatementAdapter.evaluate(StatementAdapter.java:36)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
: [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
: [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
: [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
: [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
: [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
: [junit4] 2> at java.lang.Thread.run(Thread.java:724)
: [junit4] 2>
: [junit4] 2> 831031 T3565 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966;done=false>>]
: [junit4] 2> 831031 T3565 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestIndexSearcher-1375980082966
: [junit4] 2> 831032 T3565 oasc.SolrException.log ERROR Error closing directory:java.lang.AssertionError: 3
: [junit4] 2> at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:199)
: [junit4] 2> at org.apache.solr.core.SolrCore.close(SolrCore.java:1041)
: [junit4] 2> at org.apache.solr.core.SolrCores.close(SolrCores.java:120)
: [junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:367)
: [junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:338)
: [junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:535)
: [junit4] 2> at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:130)
: [junit4] 2> at sun.reflect.GeneratedMethodAccessor25.invoke(Unknown Source)
: [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
: [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:491)
: [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
: [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
: [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:700)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
: [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
: [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
: [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
: [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
: [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
: [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
: [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
: [junit4] 2> at java.lang.Thread.run(Thread.java:724)
: [junit4] 2>
: [junit4] 2> 952056 T3565 oas.SolrTestCaseJ4.endTrackingSearchers ERROR ERROR: SolrIndexSearcher opens=56 closes=53
: [junit4] 2> NOTE: test params are: codec=Asserting, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=ga_IE, timezone=America/Costa_Rica
: [junit4] 2> NOTE: Linux 3.2.0-51-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=124186776,total=417333248
: [junit4] 2> NOTE: All tests run in this JVM: [HighlighterConfigTest, RequestHandlersTest, SliceStateTest, UUIDFieldTest, DocValuesMultiTest, XmlUpdateRequestHandlerTest, SuggesterTSTTest, DirectSolrConnectionTest, TestRangeQuery, TestOmitPositions, HighlighterTest, CollectionsAPIDistributedZkTest, TermVectorComponentDistributedTest, SpellingQueryConverterTest, OutputWriterTest, TestFuzzyAnalyzedSuggestions, TestFieldCollectionResource, UniqFieldsUpdateProcessorFactoryTest, TestCloudManagedSchema, PreAnalyzedFieldTest, PrimUtilsTest, TestCodecSupport, HdfsLockFactoryTest, CircularListTest, TestPartialUpdateDeduplication, BadCopyFieldTest, SortByFunctionTest, HdfsRecoveryZkTest, TestSchemaResource, NoCacheHeaderTest, SolrCoreCheckLockOnStartupTest, TestReload, TestIndexingPerformance, TestSchemaSimilarityResource, SolrRequestParserTest, DirectUpdateHandlerTest, SpellCheckComponentTest, TestUtils, SolrPluginUtilsTest, ConvertedLegacyTest, TestRandomFaceting, TestSolr4Spatial, Ope
nCloseCoreStressTest, TestQuerySenderListener, DebugComponentTest, TestSuggestSpellingConverter, TestSolrDeletionPolicy2, LeaderElectionIntegrationTest, TestLazyCores, HardAutoCommitTest, BadIndexSchemaTest, CurrencyFieldXmlFileTest, OpenExchangeRatesOrgProviderTest, TestComponentsName, DeleteShardTest, TestFoldingMultitermQuery, NumericFieldsTest, SpellCheckCollatorTest, TestCSVLoader, PluginInfoTest, HdfsDirectoryTest, CoreAdminCreateDiscoverTest, TestClassNameShortening, TestMultiCoreConfBootstrap, TestFastWriter, RAMDirectoryFactoryTest, TestRecoveryHdfs, TestFiltering, IndexSchemaRuntimeFieldTest, TestAddFieldRealTimeGet, ClusterStateTest, TestCoreDiscovery, ShardRoutingCustomTest, TestUpdate, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, OverseerTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, LeaderElectionTest, ZkSolrClientTest, TestZkChroot, TestRandomDVFaceting, TestRecovery, TestHashPartitioner, TestSt
ressReorder, TestSort, TestIndexSearcher]
: [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestIndexSearcher -Dtests.seed=9C20BA5F97330CB7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ga_IE -Dtests.timezone=America/Costa_Rica -Dtests.file.encoding=UTF-8
: [junit4] ERROR 0.00s J1 | TestIndexSearcher (suite) <<<
: [junit4] > Throwable #1: java.lang.AssertionError: ERROR: SolrIndexSearcher opens=56 closes=53
: [junit4] > at __randomizedtesting.SeedInfo.seed([9C20BA5F97330CB7]:0)
: [junit4] > at org.apache.solr.SolrTestCaseJ4.endTrackingSearchers(SolrTestCaseJ4.java:326)
: [junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:132)
: [junit4] > at java.lang.Thread.run(Thread.java:724)
: [junit4] Completed on J1 in 134.44s, 2 tests, 2 failures <<< FAILURES!
:
: [...truncated 98 lines...]
: BUILD FAILED
: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:395: The following error occurred while executing this line:
: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:375: The following error occurred while executing this line:
: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:181: The following error occurred while executing this line:
: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:449: The following error occurred while executing this line:
: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1233: The following error occurred while executing this line:
: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:876: There were test failures: 319 suites, 1350 tests, 1 suite-level error, 1 failure, 39 ignored (6 assumptions)
:
: Total time: 38 minutes 21 seconds
: Build step 'Invoke Ant' marked build as failure
: Description set: Java: 64bit/jdk1.8.0-ea-b99 -XX:-UseCompressedOops -XX:+UseParallelGC
: Archiving artifacts
: Recording test results
: Email was triggered for: Failure
: Sending email for trigger: Failure
:
:
:
-Hoss
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org