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/04 01:54:41 UTC

[JENKINS] Lucene-Solr-4.x-Linux (64bit/ibm-j9-jdk6) - Build # 8464 - Still Failing!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/8464/
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([FDC32027E5B05668:9C56FAC70D615C9E]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.checkNumDocs(SignatureUpdateProcessorFactoryTest.java:71)
	at org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testMultiThreaded(SignatureUpdateProcessorFactoryTest.java:222)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:60)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:37)
	at java.lang.reflect.Method.invoke(Method.java:611)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:738)


REGRESSION:  org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest.testDupeDetection

Error Message:
expected:<1> but was:<3>

Stack Trace:
java.lang.AssertionError: expected:<1> but was:<3>
	at __randomizedtesting.SeedInfo.seed([FDC32027E5B05668:A6F3DBEFE6F7F514]: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 9998 lines...]
   [junit4] Suite: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest
   [junit4]   2> 896496 T2275 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-1386118362905
   [junit4]   2> 896497 T2275 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> 896499 T2275 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> 896500 T2275 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> 896563 T2275 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 896619 T2275 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 896620 T2275 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
   [junit4]   2> 896629 T2275 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 896969 T2275 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 896972 T2275 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 896973 T2275 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 896988 T2275 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 896992 T2275 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 896995 T2275 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 896996 T2275 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> 896996 T2275 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> 897006 T2275 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 897007 T2275 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> 897007 T2275 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> 897059 T2275 oasc.CoreContainer.<init> New CoreContainer 327750537
   [junit4]   2> 897059 T2275 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> 897060 T2275 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 897061 T2275 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 897061 T2275 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 897062 T2275 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 897062 T2275 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 897063 T2275 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 897063 T2275 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 897064 T2275 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 897064 T2275 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 897070 T2275 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 897070 T2275 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 897071 T2275 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 897075 T2276 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> 897076 T2276 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> 897077 T2276 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> 897077 T2276 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> 897135 T2276 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 897184 T2276 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 897185 T2276 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
   [junit4]   2> 897191 T2276 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 897549 T2276 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 897560 T2276 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 897561 T2276 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 897576 T2276 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 897579 T2276 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 897583 T2276 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 897584 T2276 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-1386118362905/
   [junit4]   2> 897584 T2276 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ad15ad1
   [junit4]   2> 897585 T2276 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1386118362905
   [junit4]   2> 897586 T2276 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-1386118362905/index/
   [junit4]   2> 897586 T2276 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-1386118362905/index' doesn't exist. Creating new index...
   [junit4]   2> 897587 T2276 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1386118362905/index
   [junit4]   2> 897588 T2276 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=49, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=35.26953125, floorSegmentMB=1.625, forceMergeDeletesPctAllowed=16.483311183496195, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 897588 T2276 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_1,generation=1}
   [junit4]   2> 897589 T2276 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 897590 T2276 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
   [junit4]   2> 897595 T2276 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 897596 T2276 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 897596 T2276 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 897597 T2276 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 897597 T2276 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 897598 T2276 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 897598 T2276 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 897599 T2276 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> 897600 T2276 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
   [junit4]   2> 897600 T2276 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 897601 T2276 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 897601 T2276 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 897602 T2276 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 897602 T2276 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 897603 T2276 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 897603 T2276 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 897604 T2276 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 897605 T2276 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 897605 T2276 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
   [junit4]   2> 897606 T2276 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 897607 T2276 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 897608 T2276 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 897608 T2276 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 897609 T2276 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 897609 T2276 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 897610 T2276 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 897611 T2276 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 897611 T2276 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 897612 T2276 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 897613 T2276 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 897614 T2276 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 897614 T2276 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 897615 T2276 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 897616 T2276 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 897616 T2276 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 897617 T2276 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 897618 T2276 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 897620 T2276 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 897622 T2276 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 897622 T2276 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 897623 T2276 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=79.513671875, floorSegmentMB=1.6572265625, forceMergeDeletesPctAllowed=13.953739632838534, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7417107534794055
   [junit4]   2> 897624 T2276 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_1,generation=1}
   [junit4]   2> 897624 T2276 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 897625 T2276 oass.SolrIndexSearcher.<init> Opening Searcher@410a410a main
   [junit4]   2> 897626 T2276 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 897686 T2276 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 897730 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@410a410a main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 897742 T2276 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 897744 T2275 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 897747 T2275 oas.SolrTestCaseJ4.setUp ###Starting testDupeAllFieldsDetection
   [junit4]   2> ASYNC  NEW_CORE C3917 name=collection1 org.apache.solr.core.SolrCore@32f732f7
   [junit4]   2> 897753 T2275 C3917 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 897753 T2275 C3917 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 897762 T2275 C3917 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 897763 T2275 C3917 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_2,generation=2}
   [junit4]   2> 897764 T2275 C3917 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 897764 T2275 C3917 oass.SolrIndexSearcher.<init> Opening Searcher@43ef43ef main
   [junit4]   2> 897765 T2275 C3917 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 897767 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@43ef43ef main{StandardDirectoryReader(segments_2:2:nrt)}
   [junit4]   2> 897768 T2275 C3917 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 897775 T2275 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 897776 T2275 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_3,generation=3}
   [junit4]   2> 897777 T2275 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 897778 T2275 oass.SolrIndexSearcher.<init> Opening Searcher@31693169 main
   [junit4]   2> 897779 T2275 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 897781 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@31693169 main{StandardDirectoryReader(segments_3:4:nrt _0(4.7):C3)}
   [junit4]   2> 897790 T2275 oas.SolrTestCaseJ4.tearDown ###Ending testDupeAllFieldsDetection
   [junit4]   2> 897798 T2275 oas.SolrTestCaseJ4.setUp ###Starting testFailNonIndexedSigWithOverwriteDupes
   [junit4]   2> ASYNC  NEW_CORE C3918 name=collection1 org.apache.solr.core.SolrCore@32f732f7
   [junit4]   2> 897803 T2275 C3918 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 897804 T2275 C3918 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 897810 T2275 C3918 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 897811 T2275 C3918 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_3,generation=3}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_4,generation=4}
   [junit4]   2> 897812 T2275 C3918 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
   [junit4]   2> 897813 T2275 C3918 oass.SolrIndexSearcher.<init> Opening Searcher@585f585f main
   [junit4]   2> 897814 T2275 C3918 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 897816 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@585f585f main{StandardDirectoryReader(segments_4:5:nrt)}
   [junit4]   2> 897817 T2275 C3918 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 897819 T2275 oas.SolrTestCaseJ4.tearDown ###Ending testFailNonIndexedSigWithOverwriteDupes
   [junit4]   2> 897829 T2275 oas.SolrTestCaseJ4.setUp ###Starting testMultiThreaded
   [junit4]   2> 897836 T2275 C3918 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 897836 T2275 C3918 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 897843 T2275 C3918 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 897844 T2275 C3918 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_4,generation=4}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_5,generation=5}
   [junit4]   2> 897844 T2275 C3918 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 897845 T2275 C3918 oass.SolrIndexSearcher.<init> Opening Searcher@1e0b1e0b main
   [junit4]   2> 897846 T2275 C3918 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 897848 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e0b1e0b main{StandardDirectoryReader(segments_5:6:nrt)}
   [junit4]   2> 897849 T2275 C3918 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 897859 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 897893 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_5,generation=5}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_6,generation=6}
   [junit4]   2> 897894 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
   [junit4]   2> 897925 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@58c558c5 main
   [junit4]   2> 897926 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 897926 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 897929 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@58c558c5 main{StandardDirectoryReader(segments_6:20:nrt _4(4.7):C67/64:delGen=1)}
   [junit4]   2> 898004 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_6,generation=6}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_7,generation=7}
   [junit4]   2> 898005 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
   [junit4]   2> 898018 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@6eee6eee main
   [junit4]   2> 898018 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898019 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898020 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_7,generation=7}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_8,generation=8}
   [junit4]   2> 898021 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
   [junit4]   2> 898022 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6eee6eee main{StandardDirectoryReader(segments_7:30:nrt _7(4.7):C48/44:delGen=1)}
   [junit4]   2> 898023 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@62a362a3 main
   [junit4]   2> 898024 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898025 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898025 T2286 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 898027 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@62a362a3 main{StandardDirectoryReader(segments_7:30:nrt _7(4.7):C48/44:delGen=1)}
   [junit4]   2> 898030 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@74427442 main
   [junit4]   2> 898031 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898032 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898034 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@74427442 main{StandardDirectoryReader(segments_8:34:nrt _7(4.7):C48/45:delGen=1 _9(4.7):C1)}
   [junit4]   2> 898037 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_8,generation=8}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_9,generation=9}
   [junit4]   2> 898037 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
   [junit4]   2> 898040 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@59255925 main
   [junit4]   2> 898041 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898042 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898046 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@59255925 main{StandardDirectoryReader(segments_9:38:nrt _7(4.7):C48/45:delGen=3 _a(4.7):C1)}
   [junit4]   2> 898048 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_9,generation=9}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_a,generation=10}
   [junit4]   2> 898049 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
   [junit4]   2> 898060 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@5ef05ef0 main
   [junit4]   2> 898061 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898062 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898064 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5ef05ef0 main{StandardDirectoryReader(segments_a:40:nrt _7(4.7):C48/46:delGen=3 _a(4.7):C1 _b(4.7):C1)}
   [junit4]   2> 898066 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_a,generation=10}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_b,generation=11}
   [junit4]   2> 898067 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
   [junit4]   2> 898072 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@4820482 main
   [junit4]   2> 898073 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898074 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898075 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_b,generation=11}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_c,generation=12}
   [junit4]   2> 898075 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4820482 main{StandardDirectoryReader(segments_b:48:nrt _7(4.7):C48/47:delGen=4 _a(4.7):C1 _d(4.7):C1)}
   [junit4]   2> 898075 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
   [junit4]   2> 898077 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@b040b04 main
   [junit4]   2> 898077 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898078 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898080 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b040b04 main{StandardDirectoryReader(segments_b:48:nrt _7(4.7):C48/47:delGen=4 _a(4.7):C1 _d(4.7):C1)}
   [junit4]   2> 898080 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_c,generation=12}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_d,generation=13}
   [junit4]   2> 898081 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
   [junit4]   2> 898085 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@32be32be main
   [junit4]   2> 898086 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898086 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898088 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@32be32be main{StandardDirectoryReader(segments_d:54:nrt _a(4.7):C1 _d(4.7):C1 _e(4.7):C1 _f(4.7):C1)}
   [junit4]   2> 898088 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_d,generation=13}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_e,generation=14}
   [junit4]   2> 898089 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
   [junit4]   2> 898091 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@12bb12bb main
   [junit4]   2> 898092 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898093 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898094 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12bb12bb main{StandardDirectoryReader(segments_e:56:nrt _a(4.7):C1 _d(4.7):C1 _f(4.7):C1)}
   [junit4]   2> 898099 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_e,generation=14}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_f,generation=15}
   [junit4]   2> 898100 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
   [junit4]   2> 898104 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@32733273 main
   [junit4]   2> 898105 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898106 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898108 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_f,generation=15}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_g,generation=16}
   [junit4]   2> 898109 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
   [junit4]   2> 898108 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@32733273 main{StandardDirectoryReader(segments_f:64:nrt _d(4.7):C1 _g(4.7):C1 _h(4.7):C1)}
   [junit4]   2> 898110 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@41724172 main
   [junit4]   2> 898111 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898112 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898114 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@41724172 main{StandardDirectoryReader(segments_f:64:nrt _d(4.7):C1 _g(4.7):C1 _h(4.7):C1)}
   [junit4]   2> 898116 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_g,generation=16}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_h,generation=17}
   [junit4]   2> 898117 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
   [junit4]   2> 898120 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@35f035f0 main
   [junit4]   2> 898121 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898130 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898132 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_h,generation=17}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_i,generation=18}
   [junit4]   2> 898132 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
   [junit4]   2> 898132 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@35f035f0 main{StandardDirectoryReader(segments_h:72:nrt _d(4.7):C1 _j(4.7):C1)}
   [junit4]   2> 898134 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@1020102 main
   [junit4]   2> 898135 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898136 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898137 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1020102 main{StandardDirectoryReader(segments_h:72:nrt _d(4.7):C1 _j(4.7):C1)}
   [junit4]   2> 898139 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_i,generation=18}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_j,generation=19}
   [junit4]   2> 898140 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
   [junit4]   2> 898149 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@635e635e main
   [junit4]   2> 898150 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898151 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898152 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_j,generation=19}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_k,generation=20}
   [junit4]   2> 898152 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
   [junit4]   2> 898152 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@635e635e main{StandardDirectoryReader(segments_j:80:nrt _l(4.7):C1)}
   [junit4]   2> 898153 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@8ca08ca main
   [junit4]   2> 898154 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898155 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898155 T2287 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 898156 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8ca08ca main{StandardDirectoryReader(segments_j:80:nrt _l(4.7):C1)}
   [junit4]   2> 898159 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@6a3e6a3e main
   [junit4]   2> 898160 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898161 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898162 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6a3e6a3e main{StandardDirectoryReader(segments_k:85:nrt _m(4.7):C1)}
   [junit4]   2> 898163 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_k,generation=20}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_l,generation=21}
   [junit4]   2> 898164 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
   [junit4]   2> 898168 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@23e323e3 main
   [junit4]   2> 898169 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898170 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898171 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_l,generation=21}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_m,generation=22}
   [junit4]   2> 898172 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@23e323e3 main{StandardDirectoryReader(segments_l:90:nrt _m(4.7):C1 _o(4.7):C1)}
   [junit4]   2> 898172 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
   [junit4]   2> 898174 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@8090809 main
   [junit4]   2> 898174 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898175 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898177 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8090809 main{StandardDirectoryReader(segments_l:90:nrt _m(4.7):C1 _o(4.7):C1)}
   [junit4]   2> 898179 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_m,generation=22}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_n,generation=23}
   [junit4]   2> 898180 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
   [junit4]   2> 898183 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@455e455e main
   [junit4]   2> 898184 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898185 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898186 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_n,generation=23}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_o,generation=24}
   [junit4]   2> 898187 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
   [junit4]   2> 898186 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@455e455e main{StandardDirectoryReader(segments_n:96:nrt _m(4.7):C1 _p(4.7):C1 _q(4.7):C1)}
   [junit4]   2> 898189 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@43df43df main
   [junit4]   2> 898190 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898200 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898202 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@43df43df main{StandardDirectoryReader(segments_n:96:nrt _m(4.7):C1 _p(4.7):C1 _q(4.7):C1)}
   [junit4]   2> 898203 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_o,generation=24}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_p,generation=25}
   [junit4]   2> 898204 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
   [junit4]   2> 898207 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@e260e26 main
   [junit4]   2> 898208 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898209 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898210 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_p,generation=25}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_q,generation=26}
   [junit4]   2> 898211 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 26
   [junit4]   2> 898210 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e260e26 main{StandardDirectoryReader(segments_p:104:nrt _m(4.7):C1 _s(4.7):C1)}
   [junit4]   2> 898213 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@6f0e6f0e main
   [junit4]   2> 898214 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898215 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898217 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6f0e6f0e main{StandardDirectoryReader(segments_p:104:nrt _m(4.7):C1 _s(4.7):C1)}
   [junit4]   2> 898218 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_q,generation=26}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_r,generation=27}
   [junit4]   2> 898219 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 27
   [junit4]   2> 898223 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@21492149 main
   [junit4]   2> 898224 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898225 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898226 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_r,generation=27}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_s,generation=28}
   [junit4]   2> 898227 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 28
   [junit4]   2> 898226 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@21492149 main{StandardDirectoryReader(segments_r:112:nrt _s(4.7):C1 _u(4.7):C1)}
   [junit4]   2> 898229 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@15101510 main
   [junit4]   2> 898230 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898231 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898233 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15101510 main{StandardDirectoryReader(segments_r:112:nrt _s(4.7):C1 _u(4.7):C1)}
   [junit4]   2> 898234 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_s,generation=28}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_t,generation=29}
   [junit4]   2> 898235 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 29
   [junit4]   2> 898238 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@3a903a90 main
   [junit4]   2> 898239 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898240 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898248 T2288 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_t,generation=29}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_u,generation=30}
   [junit4]   2> 898248 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3a903a90 main{StandardDirectoryReader(segments_t:118:nrt _s(4.7):C1 _v(4.7):C1 _w(4.7):C1)}
   [junit4]   2> 898249 T2288 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 30
   [junit4]   2> 898250 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@32323232 main
   [junit4]   2> 898251 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898252 T2286 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898254 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@32323232 main{StandardDirectoryReader(segments_t:118:nrt _s(4.7):C1 _v(4.7):C1 _w(4.7):C1)}
   [junit4]   2> 898255 T2286 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_u,generation=30}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_v,generation=31}
   [junit4]   2> 898256 T2286 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 31
   [junit4]   2> 898310 T2286 oass.SolrIndexSearcher.<init> Opening Searcher@26d326d3 main
   [junit4]   2> 898311 T2286 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898311 T2287 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898313 T2287 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_v,generation=31}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_w,generation=32}
   [junit4]   2> 898329 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@26d326d3 main{StandardDirectoryReader(segments_v:126:nrt _s(4.7):C1 _y(4.7):C1)}
   [junit4]   2> 898329 T2287 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 32
   [junit4]   2> 898330 T2287 oass.SolrIndexSearcher.<init> Opening Searcher@294d294d main
   [junit4]   2> 898331 T2287 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898332 T2288 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898332 T2288 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 898334 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@294d294d main{StandardDirectoryReader(segments_v:126:nrt _s(4.7):C1 _y(4.7):C1)}
   [junit4]   2> 898334 T2288 oass.SolrIndexSearcher.<init> Opening Searcher@4fb94fb9 main
   [junit4]   2> 898335 T2288 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898338 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4fb94fb9 main{StandardDirectoryReader(segments_v:126:nrt _s(4.7):C1 _y(4.7):C1)}
   [junit4]   2> ASYNC  NEW_CORE C3919 name=collection1 org.apache.solr.core.SolrCore@32f732f7
   [junit4]   2> 898343 T2275 C3919 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898344 T2275 C3919 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 898345 T2275 C3919 oass.SolrIndexSearcher.<init> Opening Searcher@39433943 main
   [junit4]   2> 898346 T2275 C3919 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898348 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@39433943 main{StandardDirectoryReader(segments_v:126:nrt _s(4.7):C1 _y(4.7):C1)}
   [junit4]   2> 898349 T2275 C3919 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 898350 T2275 oas.SolrTestCaseJ4.tearDown ###Ending testMultiThreaded
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testMultiThreaded -Dtests.seed=FDC32027E5B05668 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=de_AT_PREEURO -Dtests.timezone=Australia/Lord_Howe -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.54s J1 | SignatureUpdateProcessorFactoryTest.testMultiThreaded <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<1> but was:<2>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([FDC32027E5B05668:9C56FAC70D615C9E]: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> 898366 T2275 oas.SolrTestCaseJ4.setUp ###Starting testNonIndexedSignatureField
   [junit4]   2> 898372 T2275 C3919 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 898372 T2275 C3919 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 898379 T2275 C3919 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898379 T2275 C3919 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_w,generation=32}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_x,generation=33}
   [junit4]   2> 898380 T2275 C3919 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 33
   [junit4]   2> 898381 T2275 C3919 oass.SolrIndexSearcher.<init> Opening Searcher@38f038f main
   [junit4]   2> 898382 T2275 C3919 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898384 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38f038f main{StandardDirectoryReader(segments_x:127:nrt)}
   [junit4]   2> 898385 T2275 C3919 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 898390 T2275 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898391 T2275 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_x,generation=33}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_y,generation=34}
   [junit4]   2> 898392 T2275 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 34
   [junit4]   2> 898393 T2275 oass.SolrIndexSearcher.<init> Opening Searcher@77a577a5 main
   [junit4]   2> 898394 T2275 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898399 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@77a577a5 main{StandardDirectoryReader(segments_y:129:nrt _z(4.7):C2)}
   [junit4]   2> 898400 T2275 oas.SolrTestCaseJ4.tearDown ###Ending testNonIndexedSignatureField
   [junit4]   2> 898409 T2275 oas.SolrTestCaseJ4.setUp ###Starting testDupeDetection
   [junit4]   2> ASYNC  NEW_CORE C3920 name=collection1 org.apache.solr.core.SolrCore@32f732f7
   [junit4]   2> 898426 T2275 C3920 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 898427 T2275 C3920 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 898433 T2275 C3920 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898434 T2275 C3920 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_y,generation=34}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_z,generation=35}
   [junit4]   2> 898435 T2275 C3920 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 35
   [junit4]   2> 898436 T2275 C3920 oass.SolrIndexSearcher.<init> Opening Searcher@40eb40eb main
   [junit4]   2> 898436 T2275 C3920 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898439 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@40eb40eb main{StandardDirectoryReader(segments_z:130:nrt)}
   [junit4]   2> 898439 T2275 C3920 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6
   [junit4]   2> 898444 T2275 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898446 T2275 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_z,generation=35}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_10,generation=36}
   [junit4]   2> 898447 T2275 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 36
   [junit4]   2> 898448 T2275 oass.SolrIndexSearcher.<init> Opening Searcher@66ae66ae main
   [junit4]   2> 898448 T2275 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898452 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@66ae66ae main{StandardDirectoryReader(segments_10:132:nrt _10(4.7):C2)}
   [junit4]   2> 898455 T2275 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898458 T2275 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_10,generation=36}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_11,generation=37}
   [junit4]   2> 898459 T2275 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 37
   [junit4]   2> 898459 T2275 oass.SolrIndexSearcher.<init> Opening Searcher@7f517f51 main
   [junit4]   2> 898460 T2275 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898464 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7f517f51 main{StandardDirectoryReader(segments_11:134:nrt _10(4.7):C2 _11(4.7):C1)}
   [junit4]   2> 898465 T2275 oas.SolrTestCaseJ4.tearDown ###Ending testDupeDetection
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testDupeDetection -Dtests.seed=FDC32027E5B05668 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=de_AT_PREEURO -Dtests.timezone=Australia/Lord_Howe -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.07s J1 | SignatureUpdateProcessorFactoryTest.testDupeDetection <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<1> but was:<3>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([FDC32027E5B05668:A6F3DBEFE6F7F514]: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> 898477 T2275 oas.SolrTestCaseJ4.setUp ###Starting testNonStringFieldsValues
   [junit4]   2> 898485 T2275 C3920 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 898485 T2275 C3920 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 898492 T2275 C3920 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898493 T2275 C3920 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_11,generation=37}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_12,generation=38}
   [junit4]   2> 898494 T2275 C3920 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 38
   [junit4]   2> 898495 T2275 C3920 oass.SolrIndexSearcher.<init> Opening Searcher@71537153 main
   [junit4]   2> 898495 T2275 C3920 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898498 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@71537153 main{StandardDirectoryReader(segments_12:135:nrt)}
   [junit4]   2> 898499 T2275 C3920 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> 898503 T2275 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 898514 T2275 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 898516 T2275 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_12,generation=38}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@6c186c18 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75807580)),segFN=segments_13,generation=39}
   [junit4]   2> 898517 T2275 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 39
   [junit4]   2> 898518 T2275 oass.SolrIndexSearcher.<init> Opening Searcher@57385738 main
   [junit4]   2> 898519 T2275 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 898534 T2277 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@57385738 main{StandardDirectoryReader(segments_13:137:nrt _12(4.7):C5/1:delGen=1)}
   [junit4]   2> 898535 T2275 oas.SolrTestCaseJ4.tearDown ###Ending testNonStringFieldsValues
   [junit4]   2> 898544 T2275 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 898545 T2275 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=327750537
   [junit4]   2> 898545 T2275 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@32f732f7
   [junit4]   2> 898564 T2275 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> 898565 T2275 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 898566 T2275 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 898566 T2275 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 898567 T2275 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 898567 T2275 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 898568 T2275 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1386118362905/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1386118362905/index;done=false>>]
   [junit4]   2> 898568 T2275 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1386118362905/index
   [junit4]   2> 898569 T2275 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1386118362905 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1386118362905;done=false>>]
   [junit4]   2> 898569 T2275 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-SignatureUpdateProcessorFactoryTest-1386118362905
   [junit4]   2> NOTE: test params are: codec=Lucene46: {name=PostingsFormat(name=MockSep), id=PostingsFormat(name=MockSep), v_t=PostingsFormat(name=MockSep), signatureField=MockFixedIntBlock(blockSize=1391), ints_is=PostingsFormat(name=Memory doPackFST= true), weight=PostingsFormat(name=SimpleText)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=de_AT_PREEURO, timezone=Australia/Lord_Howe
   [junit4]   2> NOTE: Linux 3.8.0-34-generic amd64/IBM Corporation 1.6.0 (64-bit)/cpus=8,threads=1,free=6681240,total=79046656
   [junit4]   2> NOTE: All tests run in this JVM: [TestFieldCollectionResource, SolrTestCaseJ4Test, TestAnalyzedSuggestions, DeleteShardTest, FieldAnalysisRequestHandlerTest, TimeZoneUtilsTest, HdfsDirectoryTest, TestFastWriter, ZkSolrClientTest, DocValuesMissingTest, RAMDirectoryFactoryTest, TestZkChroot, SuggesterTSTTest, PreAnalyzedFieldTest, TestMaxScoreQueryParser, TestIndexSearcher, TestSolrXml, NoCacheHeaderTest, TestStressRecovery, StatsComponentTest, TestFuzzyAnalyzedSuggestions, ChangedSchemaMergeTest, TestCSVResponseWriter, XmlUpdateRequestHandlerTest, BasicDistributedZk2Test, MinimalSchemaTest, TestJmxIntegration, SolrCmdDistributorTest, TestWordDelimiterFilterFactory, LeaderElectionIntegrationTest, TestFoldingMultitermQuery, HardAutoCommitTest, DisMaxRequestHandlerTest, TestAddFieldRealTimeGet, TestXIncludeConfig, ZkNodePropsTest, TestNumberUtils, DistributedQueryComponentCustomSortTest, TestFastOutputStream, TestArbitraryIndexDir, TestPhraseSuggestions, TestBinaryResponseWriter, ChaosMonkeyNothingIsSafeTest, TestDefaultSimilarityFactory, TestSweetSpotSimilarityFactory, TestSimpleQParserPlugin, RequestHandlersTest, TestDistributedGrouping, DocumentAnalysisRequestHandlerTest, SolrRequestParserTest, DistributedSuggesterComponentTest, BadIndexSchemaTest, ShardRoutingCustomTest, OpenCloseCoreStressTest, TestInfoStreamLogging, SimplePostToolTest, TestOmitPositions, AliasIntegrationTest, TestDynamicFieldCollectionResource, TestIndexingPerformance, HighlighterConfigTest, CoreAdminCreateDiscoverTest, BadCopyFieldTest, TestSolrJ, TriLevelCompositeIdRoutingTest, SpellCheckCollatorTest, PathHierarchyTokenizerFactoryTest, TestQueryTypes, DirectSolrSpellCheckerTest, AssignTest, TestUpdate, HdfsBasicDistributedZk2Test, CollectionsAPIDistributedZkTest, HdfsSyncSliceTest, MultiTermTest, MigrateRouteKeyTest, TestStressLucene, TestFastLRUCache, TermVectorComponentDistributedTest, SolrPluginUtilsTest, TestRecoveryHdfs, TestRangeQuery, DirectUpdateHandlerTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, SyncSliceTest, ShardRoutingTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, ClusterStateUpdateTest, ZkCLITest, TestDistributedSearch, TestRecovery, TestHashPartitioner, TestRealTimeGet, TestStressReorder, TestMultiCoreConfBootstrap, TestReload, DistributedTermsComponentTest, TestCoreContainer, SimpleFacetsTest, TestSolr4Spatial, SolrCoreTest, ConvertedLegacyTest, TestSort, BasicFunctionalityTest, TestLazyCores, OverseerCollectionProcessorTest, HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest]
   [junit4] Completed on J1 in 2.14s, 6 tests, 2 failures <<< FAILURES!

[...truncated 410 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:426: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:419: 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, 67 ignored (6 assumptions)

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