lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-4.x-Linux (64bit/ibm-j9-jdk6) - Build # 8759 - Failure!
Date Sat, 28 Dec 2013 12:30:02 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/8759/
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([7C83654153AA2C0F:1D16BFA1BB7B26F9]: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:<2>

Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
	at __randomizedtesting.SeedInfo.seed([7C83654153AA2C0F:27B39E8950ED8F73]: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 10013 lines...]
   [junit4] Suite: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest
   [junit4]   2> 879752 T3101 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841
   [junit4]   2> 879753 T3101 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> 879754 T3101 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> 879755 T3101 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> 879796 T3101 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 879848 T3101 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 879850 T3101 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
   [junit4]   2> 879864 T3101 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 880192 T3101 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 880195 T3101 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 880196 T3101 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 880211 T3101 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 880214 T3101 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 880218 T3101 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 880219 T3101 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> 880219 T3101 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> 880247 T3101 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 880249 T3101 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> 880250 T3101 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> 880293 T3101 oasc.CoreContainer.<init> New CoreContainer 287510819
   [junit4]   2> 880293 T3101 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> 880294 T3101 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 880295 T3101 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 880295 T3101 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 880296 T3101 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 880296 T3101 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 880297 T3101 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 880297 T3101 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 880298 T3101 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 880298 T3101 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 880303 T3101 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 880304 T3101 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 880305 T3101 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 880309 T3102 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> 880310 T3102 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> 880311 T3102 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> 880311 T3102 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> 880355 T3102 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 880417 T3102 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 880418 T3102 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
   [junit4]   2> 880423 T3102 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 880772 T3102 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 880775 T3102 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 880777 T3102 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 880791 T3102 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 880794 T3102 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 880798 T3102 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 880798 T3102 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841/
   [junit4]   2> 880799 T3102 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4b434b43
   [junit4]   2> 880800 T3102 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841
   [junit4]   2> 880800 T3102 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841/index/
   [junit4]   2> 880801 T3102 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841/index' doesn't exist. Creating new index...
   [junit4]   2> 880802 T3102 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841/index
   [junit4]   2> 880803 T3102 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=93.8271484375, floorSegmentMB=0.84375, forceMergeDeletesPctAllowed=4.548143864769726, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.13870999536618855
   [junit4]   2> 880804 T3102 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_1,generation=1}
   [junit4]   2> 880805 T3102 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 880806 T3102 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
   [junit4]   2> 880811 T3102 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 880812 T3102 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 880812 T3102 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 880813 T3102 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 880813 T3102 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 880814 T3102 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 880814 T3102 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 880815 T3102 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> 880815 T3102 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
   [junit4]   2> 880816 T3102 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 880816 T3102 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 880817 T3102 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 880817 T3102 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 880818 T3102 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 880818 T3102 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 880819 T3102 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 880820 T3102 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 880820 T3102 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 880821 T3102 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
   [junit4]   2> 880822 T3102 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 880822 T3102 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 880823 T3102 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 880824 T3102 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 880824 T3102 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 880825 T3102 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 880826 T3102 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 880826 T3102 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 880827 T3102 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 880828 T3102 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 880828 T3102 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 880829 T3102 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 880830 T3102 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 880830 T3102 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 880831 T3102 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 880832 T3102 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 880832 T3102 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 880834 T3102 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 880835 T3102 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 880837 T3102 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 880838 T3102 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 880839 T3102 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=31, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=75.517578125, floorSegmentMB=0.681640625, forceMergeDeletesPctAllowed=25.18271532920881, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.49590222325262245
   [junit4]   2> 880839 T3102 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_1,generation=1}
   [junit4]   2> 880840 T3102 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 880840 T3102 oass.SolrIndexSearcher.<init> Opening Searcher@51f551f5 main
   [junit4]   2> 880841 T3102 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 880848 T3102 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 880896 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@51f551f5 main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 880905 T3102 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 880907 T3101 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 880910 T3101 oas.SolrTestCaseJ4.setUp ###Starting testFailNonIndexedSigWithOverwriteDupes
   [junit4]   2> ASYNC  NEW_CORE C5460 name=collection1 org.apache.solr.core.SolrCore@48404840
   [junit4]   2> 880915 T3101 C5460 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 880916 T3101 C5460 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 880924 T3101 C5460 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 880924 T3101 C5460 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_2,generation=2}
   [junit4]   2> 880925 T3101 C5460 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 880926 T3101 C5460 oass.SolrIndexSearcher.<init> Opening Searcher@40054005 main
   [junit4]   2> 880927 T3101 C5460 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 880930 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@40054005 main{StandardDirectoryReader(segments_2:2:nrt)}
   [junit4]   2> 880931 T3101 C5460 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 880933 T3101 oas.SolrTestCaseJ4.tearDown ###Ending testFailNonIndexedSigWithOverwriteDupes
   [junit4]   2> 880940 T3101 oas.SolrTestCaseJ4.setUp ###Starting testMultiThreaded
   [junit4]   2> 880945 T3101 C5460 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 880946 T3101 C5460 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 880952 T3101 C5460 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 880953 T3101 C5460 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_3,generation=3}
   [junit4]   2> 880954 T3101 C5460 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 880954 T3101 C5460 oass.SolrIndexSearcher.<init> Opening Searcher@1b011b01 main
   [junit4]   2> 880955 T3101 C5460 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 880959 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b011b01 main{StandardDirectoryReader(segments_3:3:nrt)}
   [junit4]   2> 880960 T3101 C5460 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 880990 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 880995 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_3,generation=3}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_4,generation=4}
   [junit4]   2> 880996 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
   [junit4]   2> 881002 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@31b631b6 main
   [junit4]   2> 881004 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881005 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881007 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@31b631b6 main{StandardDirectoryReader(segments_4:16:nrt _2(4.7):C10/8:delGen=1)}
   [junit4]   2> 881011 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_4,generation=4}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_5,generation=5}
   [junit4]   2> 881012 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 881029 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@4f394f39 main
   [junit4]   2> 881030 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881031 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881034 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f394f39 main{StandardDirectoryReader(segments_5:28:nrt _6(4.7):C10/6:delGen=1)}
   [junit4]   2> 881040 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_5,generation=5}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_6,generation=6}
   [junit4]   2> 881041 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
   [junit4]   2> 881058 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@59a959a9 main
   [junit4]   2> 881059 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881060 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881063 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@59a959a9 main{StandardDirectoryReader(segments_6:40:nrt _b(4.7):C18/14:delGen=1)}
   [junit4]   2> 881067 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_6,generation=6}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_7,generation=7}
   [junit4]   2> 881068 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
   [junit4]   2> 881080 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@2dd12dd1 main
   [junit4]   2> 881081 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881082 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881084 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2dd12dd1 main{StandardDirectoryReader(segments_7:51:nrt _e(4.7):C39/35:delGen=1)}
   [junit4]   2> 881086 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_7,generation=7}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_8,generation=8}
   [junit4]   2> 881087 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
   [junit4]   2> 881090 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@3cbe3cbe main
   [junit4]   2> 881091 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881092 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881093 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_8,generation=8}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_9,generation=9}
   [junit4]   2> 881093 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3cbe3cbe main{StandardDirectoryReader(segments_8:56:nrt _g(4.7):C15/13:delGen=2 _h(4.7):C1)}
   [junit4]   2> 881093 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
   [junit4]   2> 881095 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@1bb21bb2 main
   [junit4]   2> 881095 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881096 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881098 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1bb21bb2 main{StandardDirectoryReader(segments_8:56:nrt _g(4.7):C15/13:delGen=2 _h(4.7):C1)}
   [junit4]   2> 881098 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_9,generation=9}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_a,generation=10}
   [junit4]   2> 881099 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
   [junit4]   2> 881109 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@69f069f main
   [junit4]   2> 881110 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881110 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881112 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@69f069f main{StandardDirectoryReader(segments_a:60:nrt _g(4.7):C15/13:delGen=2 _i(4.7):C1)}
   [junit4]   2> 881113 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_a,generation=10}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_b,generation=11}
   [junit4]   2> 881114 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
   [junit4]   2> 881117 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@40034003 main
   [junit4]   2> 881118 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881121 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881122 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_b,generation=11}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_c,generation=12}
   [junit4]   2> 881123 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
   [junit4]   2> 881124 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@40034003 main{StandardDirectoryReader(segments_b:66:nrt _g(4.7):C15/13:delGen=2 _j(4.7):C1 _k(4.7):C1)}
   [junit4]   2> 881125 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@3c4c3c4c main
   [junit4]   2> 881125 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881126 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881129 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3c4c3c4c main{StandardDirectoryReader(segments_b:66:nrt _g(4.7):C15/13:delGen=2 _j(4.7):C1 _k(4.7):C1)}
   [junit4]   2> 881129 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_c,generation=12}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_d,generation=13}
   [junit4]   2> 881130 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
   [junit4]   2> 881131 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@2b712b71 main
   [junit4]   2> 881132 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881133 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881134 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2b712b71 main{StandardDirectoryReader(segments_d:70:nrt _g(4.7):C15/14:delGen=3 _j(4.7):C1 _l(4.7):C1)}
   [junit4]   2> 881135 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_d,generation=13}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_e,generation=14}
   [junit4]   2> 881136 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
   [junit4]   2> 881137 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@65db65db main
   [junit4]   2> 881138 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881139 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881140 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_e,generation=14}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_f,generation=15}
   [junit4]   2> 881140 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
   [junit4]   2> 881140 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@65db65db main{StandardDirectoryReader(segments_e:76:nrt _g(4.7):C15/14:delGen=3 _j(4.7):C1 _m(4.7):C1 _n(4.7):C1)}
   [junit4]   2> 881141 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@13831383 main
   [junit4]   2> 881142 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881143 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881145 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@13831383 main{StandardDirectoryReader(segments_e:76:nrt _g(4.7):C15/14:delGen=3 _j(4.7):C1 _m(4.7):C1 _n(4.7):C1)}
   [junit4]   2> 881146 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_f,generation=15}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_g,generation=16}
   [junit4]   2> 881147 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
   [junit4]   2> 881149 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@7a9f7a9f main
   [junit4]   2> 881149 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881150 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881152 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_g,generation=16}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_h,generation=17}
   [junit4]   2> 881152 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
   [junit4]   2> 881152 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7a9f7a9f main{StandardDirectoryReader(segments_g:84:nrt _g(4.7):C15/14:delGen=3 _m(4.7):C1 _o(4.7):C1 _p(4.7):C1)}
   [junit4]   2> 881153 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@1dd01dd main
   [junit4]   2> 881154 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881155 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881158 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1dd01dd main{StandardDirectoryReader(segments_h:86:nrt _g(4.7):C15/14:delGen=3 _m(4.7):C1 _p(4.7):C1)}
   [junit4]   2> 881158 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_h,generation=17}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_i,generation=18}
   [junit4]   2> 881159 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
   [junit4]   2> 881161 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@b3a0b3a main
   [junit4]   2> 881161 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881162 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881164 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b3a0b3a main{StandardDirectoryReader(segments_i:90:nrt _g(4.7):C15/14:delGen=3 _p(4.7):C1 _q(4.7):C1)}
   [junit4]   2> 881164 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_i,generation=18}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_j,generation=19}
   [junit4]   2> 881165 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
   [junit4]   2> 881166 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@624d624d main
   [junit4]   2> 881167 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881167 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881177 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@624d624d main{StandardDirectoryReader(segments_j:94:nrt _p(4.7):C1 _r(4.7):C1)}
   [junit4]   2> 881227 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_j,generation=19}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_k,generation=20}
   [junit4]   2> 881229 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
   [junit4]   2> 881231 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@29322932 main
   [junit4]   2> 881232 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881232 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881233 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_k,generation=20}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_l,generation=21}
   [junit4]   2> 881234 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
   [junit4]   2> 881235 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@29322932 main{StandardDirectoryReader(segments_k:102:nrt _t(4.7):C1)}
   [junit4]   2> 881235 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@4c6b4c6b main
   [junit4]   2> 881236 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881237 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881238 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4c6b4c6b main{StandardDirectoryReader(segments_k:102:nrt _t(4.7):C1)}
   [junit4]   2> 881239 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_l,generation=21}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_m,generation=22}
   [junit4]   2> 881240 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
   [junit4]   2> 881242 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@5860586 main
   [junit4]   2> 881243 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881243 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881244 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_m,generation=22}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_n,generation=23}
   [junit4]   2> 881245 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5860586 main{StandardDirectoryReader(segments_m:108:nrt _u(4.7):C1 _v(4.7):C1)}
   [junit4]   2> 881245 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
   [junit4]   2> 881246 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@1abc1abc main
   [junit4]   2> 881247 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881248 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881249 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1abc1abc main{StandardDirectoryReader(segments_n:110:nrt _v(4.7):C1)}
   [junit4]   2> 881250 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_n,generation=23}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_o,generation=24}
   [junit4]   2> 881251 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
   [junit4]   2> 881255 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@ccc0ccc main
   [junit4]   2> 881255 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881256 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881256 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_o,generation=24}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_p,generation=25}
   [junit4]   2> 881257 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
   [junit4]   2> 881258 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ccc0ccc main{StandardDirectoryReader(segments_o:118:nrt _x(4.7):C1)}
   [junit4]   2> 881258 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@190a190a main
   [junit4]   2> 881259 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881260 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881262 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@190a190a main{StandardDirectoryReader(segments_o:118:nrt _x(4.7):C1)}
   [junit4]   2> 881262 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_p,generation=25}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_q,generation=26}
   [junit4]   2> 881263 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 26
   [junit4]   2> 881265 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@70ed70ed main
   [junit4]   2> 881265 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881266 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881267 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_q,generation=26}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_r,generation=27}
   [junit4]   2> 881267 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 27
   [junit4]   2> 881268 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@70ed70ed main{StandardDirectoryReader(segments_q:124:nrt _y(4.7):C1 _z(4.7):C1)}
   [junit4]   2> 881268 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@7d457d45 main
   [junit4]   2> 881269 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881270 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881271 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7d457d45 main{StandardDirectoryReader(segments_q:124:nrt _y(4.7):C1 _z(4.7):C1)}
   [junit4]   2> 881272 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_r,generation=27}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_s,generation=28}
   [junit4]   2> 881273 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 28
   [junit4]   2> 881276 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@77277727 main
   [junit4]   2> 881276 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881277 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881278 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_s,generation=28}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_t,generation=29}
   [junit4]   2> 881278 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 29
   [junit4]   2> 881279 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@77277727 main{StandardDirectoryReader(segments_s:132:nrt _y(4.7):C1 _11(4.7):C1)}
   [junit4]   2> 881280 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@51ba51ba main
   [junit4]   2> 881280 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881281 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881283 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@51ba51ba main{StandardDirectoryReader(segments_s:132:nrt _y(4.7):C1 _11(4.7):C1)}
   [junit4]   2> 881283 T3114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_t,generation=29}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_u,generation=30}
   [junit4]   2> 881284 T3114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 30
   [junit4]   2> 881286 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@4f774f77 main
   [junit4]   2> 881287 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881288 T3112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881302 T3112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_u,generation=30}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_v,generation=31}
   [junit4]   2> 881302 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f774f77 main{StandardDirectoryReader(segments_u:138:nrt _y(4.7):C1 _12(4.7):C1 _13(4.7):C1)}
   [junit4]   2> 881303 T3112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 31
   [junit4]   2> 881304 T3112 oass.SolrIndexSearcher.<init> Opening Searcher@316b316b main
   [junit4]   2> 881305 T3112 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881306 T3113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881308 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@316b316b main{StandardDirectoryReader(segments_v:140:nrt _y(4.7):C1 _13(4.7):C1)}
   [junit4]   2> 881309 T3113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_v,generation=31}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_w,generation=32}
   [junit4]   2> 881310 T3113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 32
   [junit4]   2> 881312 T3113 oass.SolrIndexSearcher.<init> Opening Searcher@57a257a2 main
   [junit4]   2> 881312 T3113 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881313 T3114 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881314 T3114 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 881315 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@57a257a2 main{StandardDirectoryReader(segments_w:144:nrt _y(4.7):C1 _14(4.7):C1)}
   [junit4]   2> 881315 T3114 oass.SolrIndexSearcher.<init> Opening Searcher@47b347b3 main
   [junit4]   2> 881316 T3114 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881318 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@47b347b3 main{StandardDirectoryReader(segments_w:144:nrt _y(4.7):C1 _14(4.7):C1)}
   [junit4]   2> ASYNC  NEW_CORE C5461 name=collection1 org.apache.solr.core.SolrCore@48404840
   [junit4]   2> 881324 T3101 C5461 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881325 T3101 C5461 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 881326 T3101 C5461 oass.SolrIndexSearcher.<init> Opening Searcher@6e5b6e5b main
   [junit4]   2> 881327 T3101 C5461 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881329 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6e5b6e5b main{StandardDirectoryReader(segments_w:144:nrt _y(4.7):C1 _14(4.7):C1)}
   [junit4]   2> 881330 T3101 C5461 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 881331 T3101 oas.SolrTestCaseJ4.tearDown ###Ending testMultiThreaded
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testMultiThreaded -Dtests.seed=7C83654153AA2C0F -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_CL -Dtests.timezone=UTC -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 0.41s J0 | SignatureUpdateProcessorFactoryTest.testMultiThreaded <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<1> but was:<2>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([7C83654153AA2C0F:1D16BFA1BB7B26F9]: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> 881348 T3101 oas.SolrTestCaseJ4.setUp ###Starting testDupeDetection
   [junit4]   2> 881354 T3101 C5461 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 881355 T3101 C5461 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 881361 T3101 C5461 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881362 T3101 C5461 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_w,generation=32}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_x,generation=33}
   [junit4]   2> 881363 T3101 C5461 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 33
   [junit4]   2> 881364 T3101 C5461 oass.SolrIndexSearcher.<init> Opening Searcher@1e601e6 main
   [junit4]   2> 881365 T3101 C5461 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881367 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e601e6 main{StandardDirectoryReader(segments_x:145:nrt)}
   [junit4]   2> 881368 T3101 C5461 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 881373 T3101 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881375 T3101 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_x,generation=33}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_y,generation=34}
   [junit4]   2> 881376 T3101 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 34
   [junit4]   2> 881377 T3101 oass.SolrIndexSearcher.<init> Opening Searcher@6e166e16 main
   [junit4]   2> 881378 T3101 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881381 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6e166e16 main{StandardDirectoryReader(segments_y:147:nrt _15(4.7):C2/1:delGen=1)}
   [junit4]   2> 881385 T3101 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881387 T3101 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_y,generation=34}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_z,generation=35}
   [junit4]   2> 881388 T3101 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 35
   [junit4]   2> 881389 T3101 oass.SolrIndexSearcher.<init> Opening Searcher@3ff33ff3 main
   [junit4]   2> 881389 T3101 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881392 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3ff33ff3 main{StandardDirectoryReader(segments_z:149:nrt _15(4.7):C2/1:delGen=1 _16(4.7):C1)}
   [junit4]   2> 881393 T3101 oas.SolrTestCaseJ4.tearDown ###Ending testDupeDetection
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testDupeDetection -Dtests.seed=7C83654153AA2C0F -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_CL -Dtests.timezone=UTC -Dtests.file.encoding=UTF-8
   [junit4] FAILURE 0.06s J0 | SignatureUpdateProcessorFactoryTest.testDupeDetection <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<1> but was:<2>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([7C83654153AA2C0F:27B39E8950ED8F73]: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> 881404 T3101 oas.SolrTestCaseJ4.setUp ###Starting testNonStringFieldsValues
   [junit4]   2> 881410 T3101 C5461 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 881411 T3101 C5461 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 881418 T3101 C5461 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881418 T3101 C5461 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_z,generation=35}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_10,generation=36}
   [junit4]   2> 881419 T3101 C5461 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 36
   [junit4]   2> ASYNC  NEW_CORE C5462 name=collection1 org.apache.solr.core.SolrCore@48404840
   [junit4]   2> 881431 T3101 C5462 oass.SolrIndexSearcher.<init> Opening Searcher@469d469d main
   [junit4]   2> 881432 T3101 C5462 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881435 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@469d469d main{StandardDirectoryReader(segments_10:150:nrt)}
   [junit4]   2> 881435 T3101 C5462 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 18
   [junit4]   2> 881438 T3101 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 881441 T3101 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881442 T3101 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_10,generation=36}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_11,generation=37}
   [junit4]   2> 881443 T3101 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 37
   [junit4]   2> 881444 T3101 oass.SolrIndexSearcher.<init> Opening Searcher@791f791f main
   [junit4]   2> 881445 T3101 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881447 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@791f791f main{StandardDirectoryReader(segments_11:152:nrt _17(4.7):C5/1:delGen=1)}
   [junit4]   2> 881448 T3101 oas.SolrTestCaseJ4.tearDown ###Ending testNonStringFieldsValues
   [junit4]   2> 881456 T3101 oas.SolrTestCaseJ4.setUp ###Starting testNonIndexedSignatureField
   [junit4]   2> 881464 T3101 C5462 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 881465 T3101 C5462 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 2
   [junit4]   2> 881471 T3101 C5462 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881472 T3101 C5462 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_11,generation=37}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_12,generation=38}
   [junit4]   2> 881472 T3101 C5462 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 38
   [junit4]   2> 881473 T3101 C5462 oass.SolrIndexSearcher.<init> Opening Searcher@51b051b0 main
   [junit4]   2> 881474 T3101 C5462 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881476 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@51b051b0 main{StandardDirectoryReader(segments_12:153:nrt)}
   [junit4]   2> 881477 T3101 C5462 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 881481 T3101 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881483 T3101 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_12,generation=38}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_13,generation=39}
   [junit4]   2> 881483 T3101 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 39
   [junit4]   2> 881485 T3101 oass.SolrIndexSearcher.<init> Opening Searcher@708f708f main
   [junit4]   2> 881485 T3101 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881487 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@708f708f main{StandardDirectoryReader(segments_13:155:nrt _18(4.7):C2)}
   [junit4]   2> 881488 T3101 oas.SolrTestCaseJ4.tearDown ###Ending testNonIndexedSignatureField
   [junit4]   2> 881496 T3101 oas.SolrTestCaseJ4.setUp ###Starting testDupeAllFieldsDetection
   [junit4]   2> 881501 T3101 C5462 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 881502 T3101 C5462 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 881508 T3101 C5462 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881509 T3101 C5462 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_13,generation=39}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_14,generation=40}
   [junit4]   2> 881510 T3101 C5462 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 40
   [junit4]   2> 881510 T3101 C5462 oass.SolrIndexSearcher.<init> Opening Searcher@3e823e82 main
   [junit4]   2> 881511 T3101 C5462 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881513 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3e823e82 main{StandardDirectoryReader(segments_14:156:nrt)}
   [junit4]   2> 881514 T3101 C5462 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 881519 T3101 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 881521 T3101 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_14,generation=40}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@44d244d2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4e3a4e3a)),segFN=segments_15,generation=41}
   [junit4]   2> 881521 T3101 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 41
   [junit4]   2> 881523 T3101 oass.SolrIndexSearcher.<init> Opening Searcher@3a8e3a8e main
   [junit4]   2> 881523 T3101 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 881526 T3103 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3a8e3a8e main{StandardDirectoryReader(segments_15:158:nrt _19(4.7):C3)}
   [junit4]   2> 881526 T3101 oas.SolrTestCaseJ4.tearDown ###Ending testDupeAllFieldsDetection
   [junit4]   2> 881532 T3101 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 881532 T3101 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=287510819
   [junit4]   2> 881533 T3101 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@48404840
   [junit4]   2> 881559 T3101 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> 881561 T3101 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 881561 T3101 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 881562 T3101 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 881563 T3101 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 881564 T3101 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 881565 T3101 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841;done=false>>]
   [junit4]   2> 881566 T3101 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841
   [junit4]   2> 881566 T3101 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841/index;done=false>>]
   [junit4]   2> 881567 T3101 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1388233568841/index
   [junit4]   2> NOTE: test params are: codec=Lucene41, sim=DefaultSimilarity, locale=es_CL, timezone=UTC
   [junit4]   2> NOTE: Linux 3.8.0-34-generic amd64/IBM Corporation 1.6.0 (64-bit)/cpus=8,threads=1,free=31438848,total=85961728
   [junit4]   2> NOTE: All tests run in this JVM: [SystemInfoHandlerTest, TestPseudoReturnFields, TestReplicationHandler, SuggesterTest, HdfsSyncSliceTest, HdfsCollectionsAPIDistributedZkTest, EchoParamsTest, StressHdfsTest, IndexSchemaTest, TestSystemIdResolver, TestSerializedLuceneMatchVersion, TermsComponentTest, TestFileDictionaryLookup, QueryParsingTest, TestRealTimeGet, BJQParserTest, SuggestComponentTest, ShardRoutingTest, DOMUtilTest, FastVectorHighlighterTest, TestPHPSerializedResponseWriter, TestBM25SimilarityFactory, SolrInfoMBeanTest, ZkControllerTest, TestCharFilters, DistributedTermsComponentTest, ResourceLoaderTest, TestSimpleQParserPlugin, TestDocSet, OverseerTest, PeerSyncTest, LeaderElectionTest, TestDocumentBuilder, TestLuceneMatchVersion, TestNRTOpen, CSVRequestHandlerTest, SpellPossibilityIteratorTest, TestCoreContainer, FieldMutatingUpdateProcessorTest, TestElisionMultitermQuery, TestSearchPerf, TestLMDirichletSimilarityFactory, InfoHandlerTest, OverseerCollectionProcessorTest, TestSolrXmlPersistor, ResponseLogComponentTest, ReturnFieldsTest, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, AssignTest, SynonymTokenizerTest, BadComponentTest, TestStressVersions, RecoveryZkTest, TestSurroundQueryParser, ExternalFileFieldSortTest, SyncSliceTest, ClusterStateUpdateTest, TestReloadAndDeleteDocs, TestNoOpRegenerator, PolyFieldTest, TestConfig, SliceStateTest, DirectUpdateHandlerOptimizeTest, SolrXmlInZkTest, TestSolrQueryParser, TestQueryUtils, TestCollationFieldDocValues, TestFunctionQuery, UUIDFieldTest, UpdateRequestProcessorFactoryTest, TestMergePolicyConfig, TestSolrXMLSerializer, URLClassifyProcessorTest, TestFaceting, StatelessScriptUpdateProcessorFactoryTest, TestDocBasedVersionConstraints, BinaryUpdateRequestHandlerTest, WordBreakSolrSpellCheckerTest, TestHighFrequencyDictionaryFactory, TestDistributedMissingSort, CopyFieldTest, SuggesterFSTTest, ScriptEngineTest, DeleteReplicaTest, SpatialFilterTest, TestManagedSchema, TestRandomFaceting, ZkCLITest, ShardRoutingCustomTest, SliceStateUpdateTest, TestDistributedSearch, AutoCommitTest, TestDistributedGrouping, TestRecovery, DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, TestStressReorder, TestJoin, TestRangeQuery, SpellCheckComponentTest, SolrCmdDistributorTest, QueryElevationComponentTest, BadIndexSchemaTest, ConvertedLegacyTest, TestSort, DirectUpdateHandlerTest, TestIndexSearcher, SoftAutoCommitTest, SolrIndexSplitterTest, SignatureUpdateProcessorFactoryTest]
   [junit4] Completed on J0 in 1.86s, 6 tests, 2 failures <<< FAILURES!

[...truncated 403 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, 1518 tests, 2 failures, 66 ignored (6 assumptions)

Total time: 42 minutes 0 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



Mime
View raw message