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/12/17 07:32:52 UTC
[JENKINS] Lucene-Solr-4.x-Linux (64bit/ibm-j9-jdk6) - Build # 8620
- Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/8620/
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.testDupeDetection
Error Message:
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
at __randomizedtesting.SeedInfo.seed([A689C19F8AE0C19B:FDB93A5789A762E7]: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)
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([A689C19F8AE0C19B:C71C1B7F6231CB6D]: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)
Build Log:
[...truncated 9884 lines...]
[junit4] Suite: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest
[junit4] 2> 470652 T688 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-1387261461323
[junit4] 2> 470653 T688 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> 470654 T688 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> 470655 T688 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> 470697 T688 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 470756 T688 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 470757 T688 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
[junit4] 2> 470764 T688 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 471112 T688 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 471115 T688 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 471117 T688 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 471136 T688 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 471140 T688 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 471143 T688 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 471144 T688 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> 471145 T688 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> 471154 T688 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 471155 T688 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> 471155 T688 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> 471194 T688 oasc.CoreContainer.<init> New CoreContainer 1663656745
[junit4] 2> 471194 T688 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> 471195 T688 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 471196 T688 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 471196 T688 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 471197 T688 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 471197 T688 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 471198 T688 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 471198 T688 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 471199 T688 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 471199 T688 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 471204 T688 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 471204 T688 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 471205 T688 oasc.CoreContainer.load Host Name:
[junit4] 2> 471217 T689 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> 471218 T689 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> 471220 T689 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> 471221 T689 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> 471276 T689 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 471319 T689 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 471320 T689 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
[junit4] 2> 471326 T689 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 471653 T689 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 471656 T689 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 471657 T689 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 471672 T689 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 471676 T689 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 471687 T689 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 471688 T689 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-1387261461323/
[junit4] 2> 471688 T689 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@39f339f3
[junit4] 2> 471689 T689 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1387261461323
[junit4] 2> 471690 T689 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-1387261461323/index/
[junit4] 2> 471690 T689 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-1387261461323/index' doesn't exist. Creating new index...
[junit4] 2> 471691 T689 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1387261461323/index
[junit4] 2> 471692 T689 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=49, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=59.072265625, floorSegmentMB=0.7001953125, forceMergeDeletesPctAllowed=15.940723498534009, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.868501017258465
[junit4] 2> 471692 T689 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_1,generation=1}
[junit4] 2> 471693 T689 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 471694 T689 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 471700 T689 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 471701 T689 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 471701 T689 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 471702 T689 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 471702 T689 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 471703 T689 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 471703 T689 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 471704 T689 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> 471704 T689 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 471705 T689 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 471705 T689 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 471706 T689 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 471706 T689 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 471707 T689 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 471707 T689 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 471708 T689 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 471708 T689 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 471709 T689 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 471710 T689 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 471711 T689 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 471711 T689 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 471712 T689 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 471713 T689 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 471713 T689 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 471714 T689 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 471714 T689 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 471715 T689 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 471716 T689 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 471716 T689 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 471717 T689 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 471718 T689 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 471719 T689 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 471719 T689 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 471720 T689 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 471721 T689 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 471721 T689 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 471723 T689 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 471724 T689 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 471726 T689 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 471726 T689 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 471727 T689 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=18, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=80.1220703125, floorSegmentMB=0.3515625, forceMergeDeletesPctAllowed=2.8209064340413748, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 471728 T689 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_1,generation=1}
[junit4] 2> 471728 T689 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 471729 T689 oass.SolrIndexSearcher.<init> Opening Searcher@58dd58dd main
[junit4] 2> 471730 T689 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 471799 T689 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 471839 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@58dd58dd main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 471856 T689 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 471858 T688 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 471861 T688 oas.SolrTestCaseJ4.setUp ###Starting testFailNonIndexedSigWithOverwriteDupes
[junit4] 2> ASYNC NEW_CORE C3834 name=collection1 org.apache.solr.core.SolrCore@6f366f36
[junit4] 2> 471866 T688 C3834 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 471867 T688 C3834 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 471874 T688 C3834 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 471875 T688 C3834 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_2,generation=2}
[junit4] 2> 471876 T688 C3834 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 471877 T688 C3834 oass.SolrIndexSearcher.<init> Opening Searcher@199b199b main
[junit4] 2> 471878 T688 C3834 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 471881 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@199b199b main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 471882 T688 C3834 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 471884 T688 oas.SolrTestCaseJ4.tearDown ###Ending testFailNonIndexedSigWithOverwriteDupes
[junit4] 2> 471892 T688 oas.SolrTestCaseJ4.setUp ###Starting testDupeDetection
[junit4] 2> 471897 T688 C3834 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 471898 T688 C3834 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 471904 T688 C3834 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 471905 T688 C3834 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_3,generation=3}
[junit4] 2> 471906 T688 C3834 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 471906 T688 C3834 oass.SolrIndexSearcher.<init> Opening Searcher@61eb61eb main
[junit4] 2> 471907 T688 C3834 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 471911 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@61eb61eb main{StandardDirectoryReader(segments_3:3:nrt)}
[junit4] 2> 471912 T688 C3834 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 471923 T688 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 471926 T688 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_4,generation=4}
[junit4] 2> 471927 T688 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 471928 T688 oass.SolrIndexSearcher.<init> Opening Searcher@6f926f92 main
[junit4] 2> 471929 T688 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 471932 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6f926f92 main{StandardDirectoryReader(segments_4:5:nrt _0(4.7):C2)}
[junit4] 2> 471936 T688 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 471938 T688 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_5,generation=5}
[junit4] 2> 471939 T688 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 471940 T688 oass.SolrIndexSearcher.<init> Opening Searcher@4b964b96 main
[junit4] 2> 471941 T688 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 471944 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4b964b96 main{StandardDirectoryReader(segments_5:8:nrt _0(4.7):C2/1:delGen=1 _1(4.7):C1)}
[junit4] 2> 471945 T688 oas.SolrTestCaseJ4.tearDown ###Ending testDupeDetection
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testDupeDetection -Dtests.seed=A689C19F8AE0C19B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_UY -Dtests.timezone=Asia/Dili -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.07s J1 | SignatureUpdateProcessorFactoryTest.testDupeDetection <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<2>
[junit4] > at __randomizedtesting.SeedInfo.seed([A689C19F8AE0C19B:FDB93A5789A762E7]: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> 471960 T688 oas.SolrTestCaseJ4.setUp ###Starting testNonStringFieldsValues
[junit4] 2> 471968 T688 C3834 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 471969 T688 C3834 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 2
[junit4] 2> ASYNC NEW_CORE C3835 name=collection1 org.apache.solr.core.SolrCore@6f366f36
[junit4] 2> 471988 T688 C3835 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 471989 T688 C3835 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_6,generation=6}
[junit4] 2> 471989 T688 C3835 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 471990 T688 C3835 oass.SolrIndexSearcher.<init> Opening Searcher@6aa86aa8 main
[junit4] 2> 471991 T688 C3835 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 471993 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6aa86aa8 main{StandardDirectoryReader(segments_6:9:nrt)}
[junit4] 2> 471994 T688 C3835 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 471999 T688 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 472008 T688 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472010 T688 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_7,generation=7}
[junit4] 2> 472011 T688 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 472012 T688 oass.SolrIndexSearcher.<init> Opening Searcher@ba60ba6 main
[junit4] 2> 472013 T688 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472015 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ba60ba6 main{StandardDirectoryReader(segments_7:11:nrt _2(4.7):C5/1:delGen=1)}
[junit4] 2> 472016 T688 oas.SolrTestCaseJ4.tearDown ###Ending testNonStringFieldsValues
[junit4] 2> 472024 T688 oas.SolrTestCaseJ4.setUp ###Starting testMultiThreaded
[junit4] 2> 472029 T688 C3835 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 472030 T688 C3835 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 472036 T688 C3835 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472037 T688 C3835 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_8,generation=8}
[junit4] 2> 472037 T688 C3835 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 472038 T688 C3835 oass.SolrIndexSearcher.<init> Opening Searcher@16801680 main
[junit4] 2> 472039 T688 C3835 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472041 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16801680 main{StandardDirectoryReader(segments_8:12:nrt)}
[junit4] 2> 472042 T688 C3835 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> 472048 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472115 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_9,generation=9}
[junit4] 2> 472116 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 472134 T699 oass.SolrIndexSearcher.<init> Opening Searcher@41c241c2 main
[junit4] 2> 472135 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472136 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472140 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@41c241c2 main{StandardDirectoryReader(segments_9:29:nrt _7(4.7):C90/87:delGen=1)}
[junit4] 2> 472142 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_a,generation=10}
[junit4] 2> 472143 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
[junit4] 2> 472145 T700 oass.SolrIndexSearcher.<init> Opening Searcher@11031103 main
[junit4] 2> 472146 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472147 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472160 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@11031103 main{StandardDirectoryReader(segments_a:38:nrt _b(4.7):C7/3:delGen=2)}
[junit4] 2> 472160 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_a,generation=10}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_b,generation=11}
[junit4] 2> 472161 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
[junit4] 2> 472163 T701 oass.SolrIndexSearcher.<init> Opening Searcher@59845984 main
[junit4] 2> 472164 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472165 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472166 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_b,generation=11}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_c,generation=12}
[junit4] 2> 472167 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
[junit4] 2> 472166 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@59845984 main{StandardDirectoryReader(segments_b:45:nrt _b(4.7):C7/5:delGen=3 _d(4.7):C3/1:delGen=1)}
[junit4] 2> 472168 T699 oass.SolrIndexSearcher.<init> Opening Searcher@e3f0e3f main
[junit4] 2> 472169 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472169 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472171 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_c,generation=12}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_d,generation=13}
[junit4] 2> 472172 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
[junit4] 2> 472172 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e3f0e3f main{StandardDirectoryReader(segments_c:47:nrt _b(4.7):C7/6:delGen=3 _d(4.7):C3/1:delGen=1 _e(4.7):C1)}
[junit4] 2> 472173 T700 oass.SolrIndexSearcher.<init> Opening Searcher@850085 main
[junit4] 2> 472174 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472175 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472177 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@850085 main{StandardDirectoryReader(segments_d:53:nrt _d(4.7):C3/1:delGen=1 _f(4.7):C1)}
[junit4] 2> 472178 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_d,generation=13}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_e,generation=14}
[junit4] 2> 472179 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
[junit4] 2> 472180 T701 oass.SolrIndexSearcher.<init> Opening Searcher@3820382 main
[junit4] 2> 472180 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472181 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472183 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3820382 main{StandardDirectoryReader(segments_e:57:nrt _d(4.7):C3/1:delGen=1 _g(4.7):C1)}
[junit4] 2> 472233 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_e,generation=14}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_f,generation=15}
[junit4] 2> 472234 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
[junit4] 2> 472236 T699 oass.SolrIndexSearcher.<init> Opening Searcher@33b533b5 main
[junit4] 2> 472236 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472237 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472238 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_f,generation=15}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_g,generation=16}
[junit4] 2> 472239 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
[junit4] 2> 472239 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@33b533b5 main{StandardDirectoryReader(segments_f:65:nrt _d(4.7):C3/2:delGen=2 _i(4.7):C1)}
[junit4] 2> 472240 T700 oass.SolrIndexSearcher.<init> Opening Searcher@248a248a main
[junit4] 2> 472241 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472241 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472243 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_g,generation=16}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_h,generation=17}
[junit4] 2> 472243 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
[junit4] 2> 472244 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@248a248a main{StandardDirectoryReader(segments_f:65:nrt _d(4.7):C3/2:delGen=2 _i(4.7):C1)}
[junit4] 2> 472245 T701 oass.SolrIndexSearcher.<init> Opening Searcher@4d574d57 main
[junit4] 2> 472246 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472246 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472249 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_h,generation=17}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_i,generation=18}
[junit4] 2> 472249 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
[junit4] 2> 472249 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4d574d57 main{StandardDirectoryReader(segments_h:67:nrt _d(4.7):C3/2:delGen=2 _i(4.7):C1 _j(4.7):C1)}
[junit4] 2> 472251 T699 oass.SolrIndexSearcher.<init> Opening Searcher@732c732c main
[junit4] 2> 472252 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472252 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472254 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@732c732c main{StandardDirectoryReader(segments_i:71:nrt _i(4.7):C1 _k(4.7):C1)}
[junit4] 2> 472255 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_i,generation=18}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_j,generation=19}
[junit4] 2> 472255 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
[junit4] 2> 472256 T700 oass.SolrIndexSearcher.<init> Opening Searcher@40c340c3 main
[junit4] 2> 472257 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472257 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472259 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_j,generation=19}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_k,generation=20}
[junit4] 2> 472268 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
[junit4] 2> 472268 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@40c340c3 main{StandardDirectoryReader(segments_j:75:nrt _l(4.7):C1)}
[junit4] 2> 472269 T701 oass.SolrIndexSearcher.<init> Opening Searcher@239b239b main
[junit4] 2> 472270 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472270 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472273 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_k,generation=20}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_l,generation=21}
[junit4] 2> 472274 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
[junit4] 2> 472273 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@239b239b main{StandardDirectoryReader(segments_k:79:nrt _m(4.7):C1)}
[junit4] 2> 472275 T699 oass.SolrIndexSearcher.<init> Opening Searcher@69326932 main
[junit4] 2> 472276 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472277 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472279 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@69326932 main{StandardDirectoryReader(segments_l:83:nrt _n(4.7):C1)}
[junit4] 2> 472280 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_l,generation=21}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_m,generation=22}
[junit4] 2> 472281 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
[junit4] 2> 472282 T700 oass.SolrIndexSearcher.<init> Opening Searcher@347e347e main
[junit4] 2> 472282 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472283 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472285 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@347e347e main{StandardDirectoryReader(segments_m:87:nrt _o(4.7):C1)}
[junit4] 2> 472285 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_m,generation=22}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_n,generation=23}
[junit4] 2> 472286 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
[junit4] 2> 472287 T701 oass.SolrIndexSearcher.<init> Opening Searcher@c150c15 main
[junit4] 2> 472288 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472289 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472291 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c150c15 main{StandardDirectoryReader(segments_n:89:nrt _o(4.7):C1 _p(4.7):C1)}
[junit4] 2> 472291 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_n,generation=23}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_o,generation=24}
[junit4] 2> 472293 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
[junit4] 2> 472294 T699 oass.SolrIndexSearcher.<init> Opening Searcher@ee00ee main
[junit4] 2> 472295 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472296 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472298 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ee00ee main{StandardDirectoryReader(segments_o:93:nrt _q(4.7):C1)}
[junit4] 2> 472298 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_o,generation=24}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_p,generation=25}
[junit4] 2> 472299 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
[junit4] 2> 472300 T700 oass.SolrIndexSearcher.<init> Opening Searcher@3270327 main
[junit4] 2> 472301 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472302 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472303 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3270327 main{StandardDirectoryReader(segments_p:97:nrt _r(4.7):C1)}
[junit4] 2> 472304 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_p,generation=25}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_q,generation=26}
[junit4] 2> 472305 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 26
[junit4] 2> 472306 T701 oass.SolrIndexSearcher.<init> Opening Searcher@1e471e47 main
[junit4] 2> 472307 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472308 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472310 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e471e47 main{StandardDirectoryReader(segments_q:99:nrt _r(4.7):C1 _s(4.7):C1)}
[junit4] 2> 472310 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_q,generation=26}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_r,generation=27}
[junit4] 2> 472311 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 27
[junit4] 2> 472312 T699 oass.SolrIndexSearcher.<init> Opening Searcher@782d782d main
[junit4] 2> 472313 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472314 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472316 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@782d782d main{StandardDirectoryReader(segments_r:103:nrt _r(4.7):C1 _t(4.7):C1)}
[junit4] 2> 472317 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_r,generation=27}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_s,generation=28}
[junit4] 2> 472318 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 28
[junit4] 2> 472319 T700 oass.SolrIndexSearcher.<init> Opening Searcher@1b801b80 main
[junit4] 2> 472319 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472320 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472322 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b801b80 main{StandardDirectoryReader(segments_s:107:nrt _r(4.7):C1 _u(4.7):C1)}
[junit4] 2> 472323 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_s,generation=28}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_t,generation=29}
[junit4] 2> 472324 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 29
[junit4] 2> 472324 T701 oass.SolrIndexSearcher.<init> Opening Searcher@36c536c5 main
[junit4] 2> 472325 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472326 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472336 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@36c536c5 main{StandardDirectoryReader(segments_t:111:nrt _u(4.7):C1 _v(4.7):C1)}
[junit4] 2> 472336 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_t,generation=29}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_u,generation=30}
[junit4] 2> 472337 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 30
[junit4] 2> 472338 T699 oass.SolrIndexSearcher.<init> Opening Searcher@4bc44bc4 main
[junit4] 2> 472339 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472340 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472342 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4bc44bc4 main{StandardDirectoryReader(segments_u:115:nrt _w(4.7):C1)}
[junit4] 2> 472343 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_u,generation=30}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_v,generation=31}
[junit4] 2> 472344 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 31
[junit4] 2> 472345 T700 oass.SolrIndexSearcher.<init> Opening Searcher@2c342c34 main
[junit4] 2> 472346 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472347 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472348 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2c342c34 main{StandardDirectoryReader(segments_v:119:nrt _x(4.7):C1)}
[junit4] 2> 472349 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_v,generation=31}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_w,generation=32}
[junit4] 2> 472350 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 32
[junit4] 2> 472351 T701 oass.SolrIndexSearcher.<init> Opening Searcher@88e088e main
[junit4] 2> 472352 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472353 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472354 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@88e088e main{StandardDirectoryReader(segments_w:121:nrt _x(4.7):C1 _y(4.7):C1)}
[junit4] 2> 472355 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_w,generation=32}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_x,generation=33}
[junit4] 2> 472356 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 33
[junit4] 2> 472358 T699 oass.SolrIndexSearcher.<init> Opening Searcher@49ac49ac main
[junit4] 2> 472359 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472360 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472361 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_x,generation=33}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_y,generation=34}
[junit4] 2> 472361 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@49ac49ac main{StandardDirectoryReader(segments_x:129:nrt _10(4.7):C1)}
[junit4] 2> 472361 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 34
[junit4] 2> 472363 T700 oass.SolrIndexSearcher.<init> Opening Searcher@25a425a4 main
[junit4] 2> 472363 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472364 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472365 T701 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_y,generation=34}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_z,generation=35}
[junit4] 2> 472366 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@25a425a4 main{StandardDirectoryReader(segments_x:129:nrt _10(4.7):C1)}
[junit4] 2> 472366 T701 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 35
[junit4] 2> 472367 T701 oass.SolrIndexSearcher.<init> Opening Searcher@3bd53bd5 main
[junit4] 2> 472368 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472369 T700 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472371 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3bd53bd5 main{StandardDirectoryReader(segments_z:131:nrt _10(4.7):C1 _11(4.7):C1)}
[junit4] 2> 472371 T700 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_z,generation=35}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_10,generation=36}
[junit4] 2> 472372 T700 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 36
[junit4] 2> 472373 T700 oass.SolrIndexSearcher.<init> Opening Searcher@2eb22eb2 main
[junit4] 2> 472373 T700 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472374 T699 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472376 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2eb22eb2 main{StandardDirectoryReader(segments_10:135:nrt _10(4.7):C1 _12(4.7):C1)}
[junit4] 2> 472377 T699 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_10,generation=36}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_11,generation=37}
[junit4] 2> 472378 T699 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 37
[junit4] 2> 472379 T699 oass.SolrIndexSearcher.<init> Opening Searcher@5370537 main
[junit4] 2> 472380 T699 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472381 T701 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472381 T701 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 472382 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5370537 main{StandardDirectoryReader(segments_11:139:nrt _10(4.7):C1 _13(4.7):C1)}
[junit4] 2> 472383 T701 oass.SolrIndexSearcher.<init> Opening Searcher@1af31af3 main
[junit4] 2> 472383 T701 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472386 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1af31af3 main{StandardDirectoryReader(segments_11:139:nrt _10(4.7):C1 _13(4.7):C1)}
[junit4] 2> ASYNC NEW_CORE C3836 name=collection1 org.apache.solr.core.SolrCore@6f366f36
[junit4] 2> 472391 T688 C3836 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472392 T688 C3836 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 472393 T688 C3836 oass.SolrIndexSearcher.<init> Opening Searcher@34383438 main
[junit4] 2> 472394 T688 C3836 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472405 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@34383438 main{StandardDirectoryReader(segments_11:139:nrt _10(4.7):C1 _13(4.7):C1)}
[junit4] 2> ASYNC NEW_CORE C3837 name=collection1 org.apache.solr.core.SolrCore@6f366f36
[junit4] 2> 472406 T688 C3837 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 15
[junit4] 2> 472407 T688 oas.SolrTestCaseJ4.tearDown ###Ending testMultiThreaded
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testMultiThreaded -Dtests.seed=A689C19F8AE0C19B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_UY -Dtests.timezone=Asia/Dili -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.39s J1 | SignatureUpdateProcessorFactoryTest.testMultiThreaded <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<2>
[junit4] > at __randomizedtesting.SeedInfo.seed([A689C19F8AE0C19B:C71C1B7F6231CB6D]: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> 472417 T688 oas.SolrTestCaseJ4.setUp ###Starting testDupeAllFieldsDetection
[junit4] 2> 472423 T688 C3837 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 472424 T688 C3837 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 472430 T688 C3837 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472431 T688 C3837 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_11,generation=37}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_12,generation=38}
[junit4] 2> 472431 T688 C3837 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 38
[junit4] 2> 472432 T688 C3837 oass.SolrIndexSearcher.<init> Opening Searcher@16b916b9 main
[junit4] 2> 472433 T688 C3837 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472436 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16b916b9 main{StandardDirectoryReader(segments_12:140:nrt)}
[junit4] 2> 472437 T688 C3837 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7
[junit4] 2> 472442 T688 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472443 T688 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_12,generation=38}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_13,generation=39}
[junit4] 2> 472444 T688 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 39
[junit4] 2> 472445 T688 oass.SolrIndexSearcher.<init> Opening Searcher@56825682 main
[junit4] 2> 472445 T688 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472448 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@56825682 main{StandardDirectoryReader(segments_13:142:nrt _14(4.7):C3)}
[junit4] 2> 472449 T688 oas.SolrTestCaseJ4.tearDown ###Ending testDupeAllFieldsDetection
[junit4] 2> 472456 T688 oas.SolrTestCaseJ4.setUp ###Starting testNonIndexedSignatureField
[junit4] 2> 472463 T688 C3837 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 472464 T688 C3837 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 472471 T688 C3837 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472471 T688 C3837 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_13,generation=39}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_14,generation=40}
[junit4] 2> 472472 T688 C3837 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 40
[junit4] 2> 472473 T688 C3837 oass.SolrIndexSearcher.<init> Opening Searcher@255b255b main
[junit4] 2> 472474 T688 C3837 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472476 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@255b255b main{StandardDirectoryReader(segments_14:143:nrt)}
[junit4] 2> 472477 T688 C3837 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7
[junit4] 2> 472481 T688 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 472483 T688 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_14,generation=40}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@73407340 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ca67ca6)),segFN=segments_15,generation=41}
[junit4] 2> 472483 T688 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 41
[junit4] 2> 472484 T688 oass.SolrIndexSearcher.<init> Opening Searcher@16281628 main
[junit4] 2> 472485 T688 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 472488 T690 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16281628 main{StandardDirectoryReader(segments_15:145:nrt _15(4.7):C2)}
[junit4] 2> 472489 T688 oas.SolrTestCaseJ4.tearDown ###Ending testNonIndexedSignatureField
[junit4] 2> 472494 T688 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 472495 T688 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1663656745
[junit4] 2> 472495 T688 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6f366f36
[junit4] 2> 472522 T688 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> 472522 T688 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 472523 T688 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 472523 T688 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 472524 T688 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 472525 T688 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 472525 T688 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1387261461323/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1387261461323/index;done=false>>]
[junit4] 2> 472526 T688 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1387261461323/index
[junit4] 2> 472526 T688 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1387261461323 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1387261461323;done=false>>]
[junit4] 2> 472527 T688 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1387261461323
[junit4] 2> NOTE: test params are: codec=Lucene45, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=es_UY, timezone=Asia/Dili
[junit4] 2> NOTE: Linux 3.8.0-34-generic amd64/IBM Corporation 1.6.0 (64-bit)/cpus=8,threads=1,free=22544472,total=79042560
[junit4] 2> NOTE: All tests run in this JVM: [TestDynamicFieldCollectionResource, CollectionsAPIDistributedZkTest, TestReload, RAMDirectoryFactoryTest, BadIndexSchemaTest, TestRandomFaceting, XsltUpdateRequestHandlerTest, TestDefaultSearchFieldResource, BlockDirectoryTest, TestCodecSupport, HdfsDirectoryTest, TestMaxScoreQueryParser, StatsComponentTest, ZkNodePropsTest, DocValuesMultiTest, PathHierarchyTokenizerFactoryTest, TestArbitraryIndexDir, OpenCloseCoreStressTest, TestCloudManagedSchemaAddField, TestBinaryResponseWriter, TestSimpleQParserPlugin, RequestHandlersTest, AssignTest, TestIndexingPerformance, TestQuerySenderListener, TestStressRecovery, PrimUtilsTest, SimplePostToolTest, TestCSVLoader, TestIBSimilarityFactory, TestFoldingMultitermQuery, NotRequiredUniqueKeyTest, SolrTestCaseJ4Test, DistanceFunctionTest, PingRequestHandlerTest, TestMultiCoreConfBootstrap, DocumentAnalysisRequestHandlerTest, SuggesterTSTTest, TestCopyFieldCollectionResource, SolrIndexConfigTest, JSONWriterTest, HdfsBasicDistributedZk2Test, SolrPluginUtilsTest, TestHashPartitioner, TestSolrCoreProperties, TestSolr4Spatial, TestQueryTypes, DateFieldTest, TestCloudManagedSchema, BadCopyFieldTest, TestFuzzyAnalyzedSuggestions, TestCollationField, TestJmxIntegration, SolrCmdDistributorTest, FieldAnalysisRequestHandlerTest, DirectUpdateHandlerTest, TestCustomSort, NoCacheHeaderTest, TestSolrXmlPersistor, DebugComponentTest, SolrCoreCheckLockOnStartupTest, CoreAdminCreateDiscoverTest, TestNumberUtils, PluginInfoTest, TestUtils, MultiTermTest, TestRangeQuery, TestManagedSchema, DistributedSuggesterComponentTest, TestFastOutputStream, TestFieldTypeResource, ChaosMonkeySafeLeaderTest, CoreContainerCoreInitFailuresTest, SignatureUpdateProcessorFactoryTest]
[junit4] Completed on J1 in 1.91s, 6 tests, 2 failures <<< FAILURES!
[...truncated 552 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:1307: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:940: There were test failures: 347 suites, 1516 tests, 2 failures, 66 ignored (6 assumptions)
Total time: 42 minutes 19 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