You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/01/24 00:17:04 UTC
[JENKINS] Lucene-Solr-4.x-Linux (64bit/ibm-j9-jdk6) - Build # 9109
- Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/9109/
Java: 64bit/ibm-j9-jdk6 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
2 tests failed.
REGRESSION: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testMultiThreaded
Error Message:
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
at __randomizedtesting.SeedInfo.seed([B0514931F608FD94:D1C493D11ED9F762]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testMultiThreaded(SignatureUpdateProcessorFactoryTest.java:222)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:60)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
at java.lang.reflect.Method.invoke(Method.java:611)
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:738)
REGRESSION: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection
Error Message:
expected:<1> but was:<3>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<3>
at __randomizedtesting.SeedInfo.seed([B0514931F608FD94:EB61B2F9F54F5EE8]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection(SignatureUpdateProcessorFactoryTest.java:119)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:60)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
at java.lang.reflect.Method.invoke(Method.java:611)
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:738)
Build Log:
[...truncated 9342 lines...]
[junit4] Suite: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest
[junit4] 2> 90844 T283 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441
[junit4] 2> 90845 T283 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> 90847 T283 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> 90847 T283 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> 90893 T283 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 90949 T283 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 90950 T283 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
[junit4] 2> 90958 T283 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 91346 T283 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 91348 T283 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 91350 T283 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 91369 T283 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 91373 T283 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 91395 T283 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 91396 T283 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> 91396 T283 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> 91406 T283 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 91407 T283 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> 91407 T283 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> 91450 T283 oasc.CoreContainer.<init> New CoreContainer 1528060692
[junit4] 2> 91451 T283 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> 91467 T283 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 91467 T283 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 91468 T283 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 91468 T283 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 91469 T283 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 91469 T283 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 91470 T283 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 91470 T283 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 91471 T283 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 91477 T283 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 91478 T283 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 91478 T283 oasc.CoreContainer.load Host Name:
[junit4] 2> 91483 T284 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> 91484 T284 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> 91485 T284 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> 91486 T284 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> 91531 T284 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 91602 T284 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 91603 T284 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
[junit4] 2> 91611 T284 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 91964 T284 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 91967 T284 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 91968 T284 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 92005 T284 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 92009 T284 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 92012 T284 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 92013 T284 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-SignatureUpdateProcessorFactoryTest-1390518236441/
[junit4] 2> 92013 T284 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 92014 T284 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441
[junit4] 2> 92015 T284 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-SignatureUpdateProcessorFactoryTest-1390518236441/index/
[junit4] 2> 92015 T284 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441/index' doesn't exist. Creating new index...
[junit4] 2> 92016 T284 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441/index
[junit4] 2> 92016 T284 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=2.751953125, floorSegmentMB=1.0849609375, forceMergeDeletesPctAllowed=28.342769869663012, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 92017 T284 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_1,generation=1}
[junit4] 2> 92018 T284 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 92018 T284 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 92019 T284 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 92020 T284 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 92020 T284 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 92021 T284 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 92021 T284 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 92022 T284 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 92022 T284 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 92023 T284 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 92023 T284 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 92023 T284 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 92024 T284 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 92024 T284 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 92025 T284 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 92025 T284 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 92026 T284 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 92026 T284 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 92027 T284 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 92027 T284 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 92028 T284 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 92028 T284 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 92029 T284 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 92029 T284 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 92030 T284 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 92031 T284 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 92031 T284 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 92032 T284 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 92033 T284 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 92034 T284 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 92034 T284 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 92035 T284 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 92036 T284 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 92036 T284 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 92037 T284 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 92038 T284 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 92039 T284 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 92039 T284 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 92042 T284 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 92044 T284 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 92046 T284 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 92047 T284 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 92048 T284 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 92049 T284 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_1,generation=1}
[junit4] 2> 92050 T284 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 92051 T284 oass.SolrIndexSearcher.<init> Opening Searcher@7b8b7b8b main
[junit4] 2> 92052 T284 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 92083 T284 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 92129 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7b8b7b8b main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 92129 T284 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 92132 T283 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 92135 T283 oas.SolrTestCaseJ4.setUp ###Starting testMultiThreaded
[junit4] 2> ASYNC NEW_CORE C1967 name=collection1 org.apache.solr.core.SolrCore@66776677
[junit4] 2> 92136 T283 C1967 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92137 T283 C1967 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 92140 T283 C1967 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92141 T283 C1967 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_2,generation=2}
[junit4] 2> 92142 T283 C1967 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 92143 T283 C1967 oass.SolrIndexSearcher.<init> Opening Searcher@37f037f main
[junit4] 2> 92143 T283 C1967 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92143 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@37f037f main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 92145 T283 C1967 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 92155 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92186 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_3,generation=3}
[junit4] 2> 92187 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 92219 T296 oass.SolrIndexSearcher.<init> Opening Searcher@ff60ff6 main
[junit4] 2> 92220 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92220 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ff60ff6 main{StandardDirectoryReader(segments_3:16:nrt _3(4.7):c48/45:delGen=1)}
[junit4] 2> 92220 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92249 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_4,generation=4}
[junit4] 2> 92250 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 92278 T295 oass.SolrIndexSearcher.<init> Opening Searcher@ec40ec4 main
[junit4] 2> 92279 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92279 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ec40ec4 main{StandardDirectoryReader(segments_4:27:nrt _6(4.7):c47/45:delGen=1)}
[junit4] 2> 92280 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92285 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_5,generation=5}
[junit4] 2> 92286 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 92288 T294 oass.SolrIndexSearcher.<init> Opening Searcher@3c493c49 main
[junit4] 2> 92289 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92289 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3c493c49 main{StandardDirectoryReader(segments_5:32:nrt _8(4.7):c4/3:delGen=2 _9(4.7):c1)}
[junit4] 2> 92290 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92291 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_6,generation=6}
[junit4] 2> 92291 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 92295 T296 oass.SolrIndexSearcher.<init> Opening Searcher@7d667d66 main
[junit4] 2> 92296 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92296 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7d667d66 main{StandardDirectoryReader(segments_6:36:nrt _8(4.7):c4/3:delGen=2 _a(4.7):c1)}
[junit4] 2> 92297 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92298 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_7,generation=7}
[junit4] 2> 92298 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 92301 T295 oass.SolrIndexSearcher.<init> Opening Searcher@52bf52bf main
[junit4] 2> 92302 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92302 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@52bf52bf main{StandardDirectoryReader(segments_7:40:nrt _a(4.7):c1 _b(4.7):c1)}
[junit4] 2> 92302 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92303 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_8,generation=8}
[junit4] 2> 92304 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 92307 T294 oass.SolrIndexSearcher.<init> Opening Searcher@46c446c4 main
[junit4] 2> 92307 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92308 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@46c446c4 main{StandardDirectoryReader(segments_8:44:nrt _c(4.7):c1)}
[junit4] 2> 92308 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92309 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_9,generation=9}
[junit4] 2> 92310 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 92313 T296 oass.SolrIndexSearcher.<init> Opening Searcher@67d667d6 main
[junit4] 2> 92313 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92314 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@67d667d6 main{StandardDirectoryReader(segments_9:48:nrt _d(4.7):c1)}
[junit4] 2> 92314 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92315 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_a,generation=10}
[junit4] 2> 92316 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
[junit4] 2> 92318 T295 oass.SolrIndexSearcher.<init> Opening Searcher@66bb66bb main
[junit4] 2> 92319 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92319 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@66bb66bb main{StandardDirectoryReader(segments_a:50:nrt _d(4.7):c1 _e(4.7):c1)}
[junit4] 2> 92320 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92321 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_a,generation=10}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_b,generation=11}
[junit4] 2> 92321 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
[junit4] 2> 92324 T294 oass.SolrIndexSearcher.<init> Opening Searcher@2e242e24 main
[junit4] 2> 92325 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92325 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2e242e24 main{StandardDirectoryReader(segments_b:54:nrt _f(4.7):c1)}
[junit4] 2> 92325 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92332 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_b,generation=11}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_c,generation=12}
[junit4] 2> 92333 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
[junit4] 2> 92335 T296 oass.SolrIndexSearcher.<init> Opening Searcher@37f537f5 main
[junit4] 2> 92336 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92336 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@37f537f5 main{StandardDirectoryReader(segments_c:58:nrt _g(4.7):c1)}
[junit4] 2> 92337 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92338 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_c,generation=12}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_d,generation=13}
[junit4] 2> 92338 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
[junit4] 2> 92341 T295 oass.SolrIndexSearcher.<init> Opening Searcher@518f518f main
[junit4] 2> 92341 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92342 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@518f518f main{StandardDirectoryReader(segments_d:62:nrt _h(4.7):c1)}
[junit4] 2> 92342 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92343 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_d,generation=13}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_e,generation=14}
[junit4] 2> 92344 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
[junit4] 2> 92346 T294 oass.SolrIndexSearcher.<init> Opening Searcher@33f133f1 main
[junit4] 2> 92347 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92347 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@33f133f1 main{StandardDirectoryReader(segments_e:66:nrt _i(4.7):c1)}
[junit4] 2> 92347 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92348 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_e,generation=14}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_f,generation=15}
[junit4] 2> 92349 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
[junit4] 2> 92352 T296 oass.SolrIndexSearcher.<init> Opening Searcher@40154015 main
[junit4] 2> 92352 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92353 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@40154015 main{StandardDirectoryReader(segments_f:70:nrt _j(4.7):c1)}
[junit4] 2> 92353 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92354 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_f,generation=15}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_g,generation=16}
[junit4] 2> 92355 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
[junit4] 2> 92357 T295 oass.SolrIndexSearcher.<init> Opening Searcher@754d754d main
[junit4] 2> 92358 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92358 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@754d754d main{StandardDirectoryReader(segments_g:74:nrt _k(4.7):c1)}
[junit4] 2> 92358 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92359 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_g,generation=16}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_h,generation=17}
[junit4] 2> 92360 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
[junit4] 2> 92362 T294 oass.SolrIndexSearcher.<init> Opening Searcher@335c335c main
[junit4] 2> 92363 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92363 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@335c335c main{StandardDirectoryReader(segments_h:78:nrt _l(4.7):c1)}
[junit4] 2> 92363 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92365 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_h,generation=17}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_i,generation=18}
[junit4] 2> 92365 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
[junit4] 2> 92368 T296 oass.SolrIndexSearcher.<init> Opening Searcher@22bd22bd main
[junit4] 2> 92369 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92369 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@22bd22bd main{StandardDirectoryReader(segments_i:82:nrt _m(4.7):c1)}
[junit4] 2> 92369 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92371 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_i,generation=18}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_j,generation=19}
[junit4] 2> 92371 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
[junit4] 2> 92375 T295 oass.SolrIndexSearcher.<init> Opening Searcher@68366836 main
[junit4] 2> 92376 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92376 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@68366836 main{StandardDirectoryReader(segments_j:86:nrt _n(4.7):c1)}
[junit4] 2> 92377 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92378 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_j,generation=19}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_k,generation=20}
[junit4] 2> 92378 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
[junit4] 2> 92379 T294 oass.SolrIndexSearcher.<init> Opening Searcher@a030a03 main
[junit4] 2> 92380 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92380 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a030a03 main{StandardDirectoryReader(segments_j:86:nrt _n(4.7):c1)}
[junit4] 2> 92383 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92407 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_k,generation=20}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_l,generation=21}
[junit4] 2> 92408 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
[junit4] 2> 92408 T296 oass.SolrIndexSearcher.<init> Opening Searcher@6fda6fda main
[junit4] 2> 92409 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92409 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6fda6fda main{StandardDirectoryReader(segments_l:90:nrt _o(4.7):c2/1:delGen=1)}
[junit4] 2> 92409 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92410 T295 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 92413 T295 oass.SolrIndexSearcher.<init> Opening Searcher@1db31db3 main
[junit4] 2> 92414 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92414 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1db31db3 main{StandardDirectoryReader(segments_l:92:nrt _o(4.7):c2/1:delGen=1 _p(4.7):c1)}
[junit4] 2> 92415 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92417 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_l,generation=21}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_m,generation=22}
[junit4] 2> 92417 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
[junit4] 2> 92420 T294 oass.SolrIndexSearcher.<init> Opening Searcher@3d663d66 main
[junit4] 2> 92421 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92421 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3d663d66 main{StandardDirectoryReader(segments_m:96:nrt _o(4.7):c2/1:delGen=1 _q(4.7):c1)}
[junit4] 2> 92421 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92423 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_m,generation=22}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_n,generation=23}
[junit4] 2> 92424 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
[junit4] 2> 92427 T296 oass.SolrIndexSearcher.<init> Opening Searcher@7980798 main
[junit4] 2> 92428 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92428 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7980798 main{StandardDirectoryReader(segments_n:100:nrt _o(4.7):c2/1:delGen=1 _r(4.7):c1)}
[junit4] 2> 92429 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92430 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_n,generation=23}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_o,generation=24}
[junit4] 2> 92431 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
[junit4] 2> 92434 T295 oass.SolrIndexSearcher.<init> Opening Searcher@46334633 main
[junit4] 2> 92435 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92435 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@46334633 main{StandardDirectoryReader(segments_o:104:nrt _r(4.7):c1 _s(4.7):c1)}
[junit4] 2> 92436 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92437 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_o,generation=24}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_p,generation=25}
[junit4] 2> 92438 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
[junit4] 2> 92440 T294 oass.SolrIndexSearcher.<init> Opening Searcher@46eb46eb main
[junit4] 2> 92441 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92441 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@46eb46eb main{StandardDirectoryReader(segments_p:108:nrt _r(4.7):c1 _t(4.7):c1)}
[junit4] 2> 92442 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92444 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_p,generation=25}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_q,generation=26}
[junit4] 2> 92444 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 26
[junit4] 2> 92448 T296 oass.SolrIndexSearcher.<init> Opening Searcher@46a946a9 main
[junit4] 2> 92448 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92449 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@46a946a9 main{StandardDirectoryReader(segments_q:112:nrt _r(4.7):c1 _u(4.7):c1)}
[junit4] 2> 92449 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92450 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_q,generation=26}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_r,generation=27}
[junit4] 2> 92451 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 27
[junit4] 2> 92455 T295 oass.SolrIndexSearcher.<init> Opening Searcher@2a722a72 main
[junit4] 2> 92456 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92456 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2a722a72 main{StandardDirectoryReader(segments_r:114:nrt _r(4.7):c1 _u(4.7):c1 _v(4.7):c1)}
[junit4] 2> 92456 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92457 T294 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_r,generation=27}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_s,generation=28}
[junit4] 2> 92458 T294 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 28
[junit4] 2> 92460 T294 oass.SolrIndexSearcher.<init> Opening Searcher@7e3a7e3a main
[junit4] 2> 92461 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92461 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7e3a7e3a main{StandardDirectoryReader(segments_s:116:nrt _r(4.7):c1 _u(4.7):c1 _v(4.7):c1 _w(4.7):c1)}
[junit4] 2> 92462 T296 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92470 T296 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_s,generation=28}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_t,generation=29}
[junit4] 2> 92471 T296 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 29
[junit4] 2> 92474 T296 oass.SolrIndexSearcher.<init> Opening Searcher@4e9e4e9e main
[junit4] 2> 92475 T296 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92476 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4e9e4e9e main{StandardDirectoryReader(segments_t:122:nrt _u(4.7):c1 _x(4.7):c1)}
[junit4] 2> 92476 T295 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92477 T295 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_t,generation=29}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_u,generation=30}
[junit4] 2> 92478 T295 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 30
[junit4] 2> 92479 T295 oass.SolrIndexSearcher.<init> Opening Searcher@38113811 main
[junit4] 2> 92479 T295 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92480 T294 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92480 T294 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 92481 T294 oasc.SolrCore.getSearcher WARN [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 92482 T294 oass.SolrIndexSearcher.<init> Opening Searcher@50815081 main
[junit4] 2> 92482 T294 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92482 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38113811 main{StandardDirectoryReader(segments_t:122:nrt _u(4.7):c1 _x(4.7):c1)}
[junit4] 2> 92483 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@50815081 main{StandardDirectoryReader(segments_t:122:nrt _u(4.7):c1 _x(4.7):c1)}
[junit4] 2> ASYNC NEW_CORE C1968 name=collection1 org.apache.solr.core.SolrCore@66776677
[junit4] 2> 92489 T283 C1968 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92489 T283 C1968 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 92490 T283 C1968 oass.SolrIndexSearcher.<init> Opening Searcher@25c525c5 main
[junit4] 2> 92491 T283 C1968 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92491 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@25c525c5 main{StandardDirectoryReader(segments_t:122:nrt _u(4.7):c1 _x(4.7):c1)}
[junit4] 2> 92492 T283 C1968 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 92494 T283 oas.SolrTestCaseJ4.tearDown ###Ending testMultiThreaded
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testMultiThreaded -Dtests.seed=B0514931F608FD94 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=be -Dtests.timezone=America/Regina -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.38s J1 | SignatureUpdateProcessorFactoryTest.testMultiThreaded <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<2>
[junit4] > at __randomizedtesting.SeedInfo.seed([B0514931F608FD94:D1C493D11ED9F762]:0)
[junit4] > at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
[junit4] > at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testMultiThreaded(SignatureUpdateProcessorFactoryTest.java:222)
[junit4] > at java.lang.Thread.run(Thread.java:738)
[junit4] 2> 92512 T283 oas.SolrTestCaseJ4.setUp ###Starting testDupeAllFieldsDetection
[junit4] 2> 92513 T283 C1968 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92513 T283 C1968 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 92515 T283 C1968 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92516 T283 C1968 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_u,generation=30}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_v,generation=31}
[junit4] 2> 92517 T283 C1968 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 31
[junit4] 2> 92517 T283 C1968 oass.SolrIndexSearcher.<init> Opening Searcher@5850585 main
[junit4] 2> 92518 T283 C1968 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92518 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5850585 main{StandardDirectoryReader(segments_v:123:nrt)}
[junit4] 2> 92520 T283 C1968 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 92526 T283 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92528 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_v,generation=31}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_w,generation=32}
[junit4] 2> 92529 T283 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 32
[junit4] 2> 92530 T283 oass.SolrIndexSearcher.<init> Opening Searcher@407c407c main
[junit4] 2> 92531 T283 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92531 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@407c407c main{StandardDirectoryReader(segments_w:125:nrt _y(4.7):c3)}
[junit4] 2> 92532 T283 oas.SolrTestCaseJ4.tearDown ###Ending testDupeAllFieldsDetection
[junit4] 2> 92540 T283 oas.SolrTestCaseJ4.setUp ###Starting testDupeDetection
[junit4] 2> 92541 T283 C1968 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92541 T283 C1968 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 92543 T283 C1968 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92544 T283 C1968 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_w,generation=32}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_x,generation=33}
[junit4] 2> 92545 T283 C1968 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 33
[junit4] 2> ASYNC NEW_CORE C1969 name=collection1 org.apache.solr.core.SolrCore@66776677
[junit4] 2> 92557 T283 C1969 oass.SolrIndexSearcher.<init> Opening Searcher@26ff26ff main
[junit4] 2> 92558 T283 C1969 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92558 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@26ff26ff main{StandardDirectoryReader(segments_x:126:nrt)}
[junit4] 2> 92560 T283 C1969 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 17
[junit4] 2> 92565 T283 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92568 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_x,generation=33}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_y,generation=34}
[junit4] 2> 92569 T283 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 34
[junit4] 2> 92570 T283 oass.SolrIndexSearcher.<init> Opening Searcher@47a347a3 main
[junit4] 2> 92571 T283 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92572 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@47a347a3 main{StandardDirectoryReader(segments_y:128:nrt _z(4.7):c2)}
[junit4] 2> 92576 T283 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92579 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_y,generation=34}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_z,generation=35}
[junit4] 2> 92579 T283 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 35
[junit4] 2> 92580 T283 oass.SolrIndexSearcher.<init> Opening Searcher@1d461d46 main
[junit4] 2> 92581 T283 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92581 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1d461d46 main{StandardDirectoryReader(segments_z:130:nrt _z(4.7):c2 _10(4.7):c1)}
[junit4] 2> 92582 T283 oas.SolrTestCaseJ4.tearDown ###Ending testDupeDetection
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testDupeDetection -Dtests.seed=B0514931F608FD94 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=be -Dtests.timezone=America/Regina -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.05s J1 | SignatureUpdateProcessorFactoryTest.testDupeDetection <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<3>
[junit4] > at __randomizedtesting.SeedInfo.seed([B0514931F608FD94:EB61B2F9F54F5EE8]:0)
[junit4] > at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
[junit4] > at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection(SignatureUpdateProcessorFactoryTest.java:119)
[junit4] > at java.lang.Thread.run(Thread.java:738)
[junit4] 2> 92593 T283 oas.SolrTestCaseJ4.setUp ###Starting testNonIndexedSignatureField
[junit4] 2> 92594 T283 C1969 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92595 T283 C1969 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 92596 T283 C1969 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92597 T283 C1969 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_z,generation=35}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_10,generation=36}
[junit4] 2> 92598 T283 C1969 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 36
[junit4] 2> 92599 T283 C1969 oass.SolrIndexSearcher.<init> Opening Searcher@42c042c main
[junit4] 2> 92600 T283 C1969 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92600 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@42c042c main{StandardDirectoryReader(segments_10:131:nrt)}
[junit4] 2> 92601 T283 C1969 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 92606 T283 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92608 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_10,generation=36}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_11,generation=37}
[junit4] 2> 92609 T283 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 37
[junit4] 2> 92610 T283 oass.SolrIndexSearcher.<init> Opening Searcher@1b031b03 main
[junit4] 2> 92611 T283 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92611 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b031b03 main{StandardDirectoryReader(segments_11:133:nrt _11(4.7):c2)}
[junit4] 2> 92612 T283 oas.SolrTestCaseJ4.tearDown ###Ending testNonIndexedSignatureField
[junit4] 2> 92621 T283 oas.SolrTestCaseJ4.setUp ###Starting testNonStringFieldsValues
[junit4] 2> 92622 T283 C1969 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92623 T283 C1969 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 92624 T283 C1969 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92625 T283 C1969 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_11,generation=37}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_12,generation=38}
[junit4] 2> 92626 T283 C1969 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 38
[junit4] 2> ASYNC NEW_CORE C1970 name=collection1 org.apache.solr.core.SolrCore@66776677
[junit4] 2> 92627 T283 C1970 oass.SolrIndexSearcher.<init> Opening Searcher@4b1b4b1b main
[junit4] 2> 92634 T283 C1970 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92635 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4b1b4b1b main{StandardDirectoryReader(segments_12:134:nrt)}
[junit4] 2> 92636 T283 C1970 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4] 2> 92640 T283 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 92648 T283 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92650 T283 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_12,generation=38}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_13,generation=39}
[junit4] 2> 92650 T283 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 39
[junit4] 2> 92652 T283 oass.SolrIndexSearcher.<init> Opening Searcher@6690669 main
[junit4] 2> 92653 T283 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92653 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6690669 main{StandardDirectoryReader(segments_13:136:nrt _12(4.7):c5/1:delGen=1)}
[junit4] 2> 92654 T283 oas.SolrTestCaseJ4.tearDown ###Ending testNonStringFieldsValues
[junit4] 2> 92662 T283 oas.SolrTestCaseJ4.setUp ###Starting testFailNonIndexedSigWithOverwriteDupes
[junit4] 2> 92663 T283 C1970 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 92663 T283 C1970 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 92665 T283 C1970 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92666 T283 C1970 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_13,generation=39}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@527c527c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c2b5c2b)),segFN=segments_14,generation=40}
[junit4] 2> 92667 T283 C1970 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 40
[junit4] 2> 92667 T283 C1970 oass.SolrIndexSearcher.<init> Opening Searcher@696f696f main
[junit4] 2> 92668 T283 C1970 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92668 T285 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@696f696f main{StandardDirectoryReader(segments_14:137:nrt)}
[junit4] 2> 92670 T283 C1970 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 92671 T283 oas.SolrTestCaseJ4.tearDown ###Ending testFailNonIndexedSigWithOverwriteDupes
[junit4] 2> 92677 T283 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 92677 T283 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1528060692
[junit4] 2> 92678 T283 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@66776677
[junit4] 2> 92679 T283 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=42,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=253,cumulative_deletesById=0,cumulative_deletesByQuery=6,cumulative_errors=0}
[junit4] 2> 92679 T283 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 92680 T283 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 92680 T283 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 92681 T283 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 92681 T283 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 92682 T283 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441;done=false>>]
[junit4] 2> 92682 T283 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441
[junit4] 2> 92683 T283 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441/index;done=false>>]
[junit4] 2> 92683 T283 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1390518236441/index
[junit4] 2> NOTE: test params are: codec=Lucene42, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=be, timezone=America/Regina
[junit4] 2> NOTE: Linux 3.8.0-35-generic amd64/IBM Corporation 1.6.0 (64-bit)/cpus=8,threads=1,free=22647216,total=42765312
[junit4] 2> NOTE: All tests run in this JVM: [StandardRequestHandlerTest, SolrCoreCheckLockOnStartupTest, OpenExchangeRatesOrgProviderTest, TestBinaryField, SpellCheckComponentTest, OpenCloseCoreStressTest, TestFastLRUCache, TestSolrXml, TestUniqueKeyFieldResource, TestDistributedMissingSort, TestFoldingMultitermQuery, TestNRTOpen, TestFuzzyAnalyzedSuggestions, SuggestComponentTest, TestFastWriter, NoCacheHeaderTest, NumericFieldsTest, AddBlockUpdateTest, DefaultValueUpdateProcessorTest, TestRecovery, SignatureUpdateProcessorFactoryTest]
[junit4] Completed on J1 in 1.92s, 6 tests, 2 failures <<< FAILURES!
[...truncated 957 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:459: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:452: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:491: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1308: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:941: There were test failures: 355 suites, 1542 tests, 2 failures, 66 ignored (6 assumptions)
Total time: 39 minutes 15 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/ibm-j9-jdk6 -Xjit:exclude={org/apache/lucene/util/fst/FST.pack(IIF)Lorg/apache/lucene/util/fst/FST;}
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure