You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/01/25 10:40:30 UTC
[JENKINS] Lucene-Solr-4.x-Linux (64bit/ibm-j9-jdk7) - Build # 9128
- Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/9128/
Java: 64bit/ibm-j9-jdk7 -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([D0E2D4BE718E1C9B:B1770E5E995F166D]: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:88)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
at java.lang.reflect.Method.invoke(Method.java:613)
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:780)
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([D0E2D4BE718E1C9B:8BD22F7672C9BFE7]: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:88)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
at java.lang.reflect.Method.invoke(Method.java:613)
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:780)
Build Log:
[...truncated 10558 lines...]
[junit4] Suite: org.apache.solr.update.processor.SignatureUpdateProcessorFactoryTest
[junit4] 2> 560392 T2420 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-1390642733808
[junit4] 2> 560392 T2420 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> 560393 T2420 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> 560393 T2420 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> 560440 T2420 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 560499 T2420 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 560499 T2420 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
[junit4] 2> 560505 T2420 oass.IndexSchema.readSchema [null] Schema name=test
[junit4] 2> 560864 T2420 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 560867 T2420 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 560868 T2420 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 560873 T2420 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 560877 T2420 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 560880 T2420 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 560881 T2420 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> 560881 T2420 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> 560887 T2420 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 560888 T2420 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> 560888 T2420 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> 560924 T2420 oasc.CoreContainer.<init> New CoreContainer 1381416246
[junit4] 2> 560925 T2420 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> 560926 T2420 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 560926 T2420 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 560926 T2420 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 560927 T2420 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 560927 T2420 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 560927 T2420 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 560928 T2420 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 560928 T2420 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 560928 T2420 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 560931 T2420 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 560931 T2420 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 560932 T2420 oasc.CoreContainer.load Host Name:
[junit4] 2> 560935 T2421 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> 560935 T2421 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> 560935 T2421 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> 560936 T2421 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> 560968 T2421 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 561012 T2421 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 561013 T2421 oass.IndexSchema.readSchema Reading Solr Schema from schema12.xml
[junit4] 2> 561018 T2421 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 561300 T2421 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 561302 T2421 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 561304 T2421 oass.IndexSchema.readSchema WARN Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 561308 T2421 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 561312 T2421 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 561315 T2421 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 561315 T2421 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-1390642733808/
[junit4] 2> 561315 T2421 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@a6ae1304
[junit4] 2> 561316 T2421 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1390642733808
[junit4] 2> 561316 T2421 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-1390642733808/index/
[junit4] 2> 561317 T2421 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-1390642733808/index' doesn't exist. Creating new index...
[junit4] 2> 561317 T2421 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1390642733808/index
[junit4] 2> 561318 T2421 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=45, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.19577976551494905]
[junit4] 2> 561318 T2421 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_1,generation=1}
[junit4] 2> 561318 T2421 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 561319 T2421 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 561321 T2421 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 561321 T2421 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 561321 T2421 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 561321 T2421 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 561322 T2421 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 561322 T2421 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 561322 T2421 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 561323 T2421 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> 561323 T2421 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 561323 T2421 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 561324 T2421 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 561324 T2421 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 561324 T2421 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 561325 T2421 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 561325 T2421 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 561326 T2421 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 561326 T2421 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 561327 T2421 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 561327 T2421 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 561328 T2421 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 561329 T2421 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 561329 T2421 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 561330 T2421 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 561330 T2421 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 561331 T2421 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 561331 T2421 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 561332 T2421 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 561332 T2421 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 561333 T2421 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 561334 T2421 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 561334 T2421 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 561335 T2421 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 561335 T2421 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 561336 T2421 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 561337 T2421 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 561337 T2421 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 561339 T2421 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 561341 T2421 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 561344 T2421 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 561344 T2421 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 561345 T2421 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=43, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.26059076597918046]
[junit4] 2> 561345 T2421 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_1,generation=1}
[junit4] 2> 561346 T2421 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 561346 T2421 oass.SolrIndexSearcher.<init> Opening Searcher@b23e6346 main
[junit4] 2> 561346 T2421 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 561407 T2421 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 561426 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b23e6346 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 561430 T2421 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 561432 T2420 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 561435 T2420 oas.SolrTestCaseJ4.setUp ###Starting testNonStringFieldsValues
[junit4] 2> ASYNC NEW_CORE C1127 name=collection1 org.apache.solr.core.SolrCore@d78ee463
[junit4] 2> 561435 T2420 C1127 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 561436 T2420 C1127 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 561439 T2420 C1127 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561440 T2420 C1127 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_2,generation=2}
[junit4] 2> 561441 T2420 C1127 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 561441 T2420 C1127 oass.SolrIndexSearcher.<init> Opening Searcher@9ac61245 main
[junit4] 2> 561442 T2420 C1127 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561443 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9ac61245 main{StandardDirectoryReader(segments_2:2:nrt)}
[junit4] 2> 561444 T2420 C1127 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 561446 T2420 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 561507 T2420 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561509 T2420 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_3,generation=3}
[junit4] 2> 561510 T2420 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 561511 T2420 oass.SolrIndexSearcher.<init> Opening Searcher@55126bc0 main
[junit4] 2> 561512 T2420 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561513 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@55126bc0 main{StandardDirectoryReader(segments_3:4:nrt _0(4.7):c5/1:delGen=1)}
[junit4] 2> 561514 T2420 oas.SolrTestCaseJ4.tearDown ###Ending testNonStringFieldsValues
[junit4] 2> 561517 T2420 oas.SolrTestCaseJ4.setUp ###Starting testFailNonIndexedSigWithOverwriteDupes
[junit4] 2> 561518 T2420 C1127 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 561518 T2420 C1127 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 561559 T2420 C1127 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561559 T2420 C1127 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_4,generation=4}
[junit4] 2> 561560 T2420 C1127 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 561561 T2420 C1127 oass.SolrIndexSearcher.<init> Opening Searcher@370e02ad main
[junit4] 2> 561561 T2420 C1127 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561563 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@370e02ad main{StandardDirectoryReader(segments_4:5:nrt)}
[junit4] 2> 561575 T2420 C1127 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 16
[junit4] 2> 561577 T2420 oas.SolrTestCaseJ4.tearDown ###Ending testFailNonIndexedSigWithOverwriteDupes
[junit4] 2> 561580 T2420 oas.SolrTestCaseJ4.setUp ###Starting testNonIndexedSignatureField
[junit4] 2> 561581 T2420 C1127 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 561582 T2420 C1127 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 561583 T2420 C1127 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561583 T2420 C1127 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_5,generation=5}
[junit4] 2> 561584 T2420 C1127 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 561585 T2420 C1127 oass.SolrIndexSearcher.<init> Opening Searcher@5a6687e5 main
[junit4] 2> 561585 T2420 C1127 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561586 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5a6687e5 main{StandardDirectoryReader(segments_5:6:nrt)}
[junit4] 2> 561587 T2420 C1127 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
[junit4] 2> 561593 T2420 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561594 T2420 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_6,generation=6}
[junit4] 2> 561595 T2420 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 561596 T2420 oass.SolrIndexSearcher.<init> Opening Searcher@3a659623 main
[junit4] 2> 561596 T2420 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561598 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3a659623 main{StandardDirectoryReader(segments_6:8:nrt _1(4.7):c2)}
[junit4] 2> 561598 T2420 oas.SolrTestCaseJ4.tearDown ###Ending testNonIndexedSignatureField
[junit4] 2> 561601 T2420 oas.SolrTestCaseJ4.setUp ###Starting testMultiThreaded
[junit4] 2> 561602 T2420 C1127 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 561602 T2420 C1127 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 561604 T2420 C1127 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561604 T2420 C1127 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_7,generation=7}
[junit4] 2> 561605 T2420 C1127 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 561606 T2420 C1127 oass.SolrIndexSearcher.<init> Opening Searcher@a5126522 main
[junit4] 2> 561606 T2420 C1127 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561607 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a5126522 main{StandardDirectoryReader(segments_7:9:nrt)}
[junit4] 2> 561608 T2420 C1127 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
[junit4] 2> 561620 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561643 T2432 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_8,generation=8}
[junit4] 2> 561645 T2432 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 561748 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@921d8e2c main
[junit4] 2> 561748 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561749 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561750 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@921d8e2c main{StandardDirectoryReader(segments_8:16:nrt _3(4.7):c63/59:delGen=1)}
[junit4] 2> 561913 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_9,generation=9}
[junit4] 2> 561913 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 561917 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@6a76f924 main
[junit4] 2> 561917 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561918 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561918 T2431 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_a,generation=10}
[junit4] 2> 561919 T2431 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
[junit4] 2> 561918 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6a76f924 main{StandardDirectoryReader(segments_9:21:nrt _4(4.7):c137/134:delGen=2 _5(4.7):c1)}
[junit4] 2> 561920 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@6b738374 main
[junit4] 2> 561921 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561921 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561922 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b738374 main{StandardDirectoryReader(segments_9:21:nrt _4(4.7):c137/134:delGen=2 _5(4.7):c1)}
[junit4] 2> 561923 T2432 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_a,generation=10}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_b,generation=11}
[junit4] 2> 561924 T2432 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
[junit4] 2> 561932 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@c5eea99 main
[junit4] 2> 561933 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561933 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561946 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_b,generation=11}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_c,generation=12}
[junit4] 2> 561947 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
[junit4] 2> 561947 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c5eea99 main{StandardDirectoryReader(segments_b:28:nrt _4(4.7):c137/135:delGen=3 _7(4.7):c1)}
[junit4] 2> 561948 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@c0833704 main
[junit4] 2> 561948 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561949 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561949 T2431 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 561950 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c0833704 main{StandardDirectoryReader(segments_b:28:nrt _4(4.7):c137/135:delGen=3 _7(4.7):c1)}
[junit4] 2> 561957 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@dac7d019 main
[junit4] 2> 561957 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561957 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561959 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@dac7d019 main{StandardDirectoryReader(segments_c:32:nrt _4(4.7):c137/136:delGen=3 _7(4.7):c1 _8(4.7):c1)}
[junit4] 2> 561964 T2432 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_c,generation=12}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_d,generation=13}
[junit4] 2> 561965 T2432 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
[junit4] 2> 561965 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@5de1f955 main
[junit4] 2> 561966 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561966 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561968 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5de1f955 main{StandardDirectoryReader(segments_d:35:nrt _7(4.7):c1 _9(4.7):c1)}
[junit4] 2> 561971 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_d,generation=13}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_e,generation=14}
[junit4] 2> 561972 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
[junit4] 2> 561972 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@1af06642 main
[junit4] 2> 561973 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561973 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561975 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1af06642 main{StandardDirectoryReader(segments_e:39:nrt _a(4.7):c1)}
[junit4] 2> 561977 T2431 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_e,generation=14}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_f,generation=15}
[junit4] 2> 561977 T2431 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
[junit4] 2> 561978 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@adcbb654 main
[junit4] 2> 561979 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561979 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561980 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@adcbb654 main{StandardDirectoryReader(segments_f:41:nrt _a(4.7):c1 _b(4.7):c1)}
[junit4] 2> 561985 T2432 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_f,generation=15}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_g,generation=16}
[junit4] 2> 561986 T2432 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
[junit4] 2> 561996 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@e983f615 main
[junit4] 2> 561997 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 561997 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 561998 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e983f615 main{StandardDirectoryReader(segments_g:49:nrt _a(4.7):c1 _d(4.7):c1)}
[junit4] 2> 561998 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_g,generation=16}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_h,generation=17}
[junit4] 2> 561999 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
[junit4] 2> 561999 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@c346bf9a main
[junit4] 2> 562000 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562000 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562001 T2431 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 562001 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c346bf9a main{StandardDirectoryReader(segments_g:49:nrt _a(4.7):c1 _d(4.7):c1)}
[junit4] 2> 562004 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@8cd46beb main
[junit4] 2> 562005 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562005 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562006 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8cd46beb main{StandardDirectoryReader(segments_h:51:nrt _a(4.7):c1 _d(4.7):c1 _e(4.7):c1)}
[junit4] 2> 562017 T2432 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_h,generation=17}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_i,generation=18}
[junit4] 2> 562017 T2432 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
[junit4] 2> 562018 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@3ff25969 main
[junit4] 2> 562019 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562019 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562020 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3ff25969 main{StandardDirectoryReader(segments_i:55:nrt _a(4.7):c1 _d(4.7):c1 _f(4.7):c1)}
[junit4] 2> 562027 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_i,generation=18}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_j,generation=19}
[junit4] 2> 562028 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
[junit4] 2> 562035 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@f1242236 main
[junit4] 2> 562036 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562037 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562038 T2431 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_j,generation=19}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_k,generation=20}
[junit4] 2> 562038 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f1242236 main{StandardDirectoryReader(segments_j:63:nrt _d(4.7):c1 _g(4.7):c1 _h(4.7):c1)}
[junit4] 2> 562038 T2431 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
[junit4] 2> 562039 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@444df9fd main
[junit4] 2> 562040 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562041 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562041 T2432 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 562043 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@444df9fd main{StandardDirectoryReader(segments_j:63:nrt _d(4.7):c1 _g(4.7):c1 _h(4.7):c1)}
[junit4] 2> 562043 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@da0872bb main
[junit4] 2> 562044 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562045 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@da0872bb main{StandardDirectoryReader(segments_j:63:nrt _d(4.7):c1 _g(4.7):c1 _h(4.7):c1)}
[junit4] 2> 562047 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562060 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_k,generation=20}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_l,generation=21}
[junit4] 2> 562060 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
[junit4] 2> 562068 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@9e37d083 main
[junit4] 2> 562070 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562070 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562071 T2431 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_l,generation=21}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_m,generation=22}
[junit4] 2> 562072 T2431 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
[junit4] 2> 562071 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9e37d083 main{StandardDirectoryReader(segments_l:71:nrt _d(4.7):c1 _i(4.7):c2/1:delGen=1 _j(4.7):c1)}
[junit4] 2> 562072 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@211e0f22 main
[junit4] 2> 562073 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562073 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562074 T2432 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 562074 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@211e0f22 main{StandardDirectoryReader(segments_l:71:nrt _d(4.7):c1 _i(4.7):c2/1:delGen=1 _j(4.7):c1)}
[junit4] 2> 562081 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@4e7c02d4 main
[junit4] 2> 562082 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562082 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562083 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4e7c02d4 main{StandardDirectoryReader(segments_m:76:nrt _d(4.7):c1 _i(4.7):c2/1:delGen=1 _k(4.7):c1)}
[junit4] 2> 562090 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_m,generation=22}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_n,generation=23}
[junit4] 2> 562091 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
[junit4] 2> 562098 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@2b0fd86c main
[junit4] 2> 562099 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562100 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562100 T2431 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_n,generation=23}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_o,generation=24}
[junit4] 2> 562101 T2431 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
[junit4] 2> 562101 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2b0fd86c main{StandardDirectoryReader(segments_n:81:nrt _d(4.7):c1 _i(4.7):c2/1:delGen=1 _l(4.7):c1 _m(4.7):c1)}
[junit4] 2> 562103 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@20b232f4 main
[junit4] 2> 562103 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562104 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562104 T2432 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 562105 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@20b232f4 main{StandardDirectoryReader(segments_n:81:nrt _d(4.7):c1 _i(4.7):c2/1:delGen=1 _l(4.7):c1 _m(4.7):c1)}
[junit4] 2> 562113 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@82be3458 main
[junit4] 2> 562113 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562114 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562115 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@82be3458 main{StandardDirectoryReader(segments_o:86:nrt _i(4.7):c2/1:delGen=1 _l(4.7):c1 _n(4.7):c1)}
[junit4] 2> 562121 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_o,generation=24}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_p,generation=25}
[junit4] 2> 562122 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
[junit4] 2> 562124 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@4f82411e main
[junit4] 2> 562125 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562126 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562127 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f82411e main{StandardDirectoryReader(segments_p:93:nrt _l(4.7):c1 _p(4.7):c1)}
[junit4] 2> 562129 T2431 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_p,generation=25}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_q,generation=26}
[junit4] 2> 562129 T2431 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 26
[junit4] 2> 562130 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@ec386f38 main
[junit4] 2> 562130 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562131 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562133 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ec386f38 main{StandardDirectoryReader(segments_p:93:nrt _l(4.7):c1 _p(4.7):c1)}
[junit4] 2> 562135 T2432 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_q,generation=26}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_r,generation=27}
[junit4] 2> 562135 T2432 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 27
[junit4] 2> 562140 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@153d810e main
[junit4] 2> 562140 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562141 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562141 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_r,generation=27}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_s,generation=28}
[junit4] 2> 562142 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 28
[junit4] 2> 562142 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@153d810e main{StandardDirectoryReader(segments_r:101:nrt _l(4.7):c1 _r(4.7):c1)}
[junit4] 2> 562143 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@795e972e main
[junit4] 2> 562143 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562144 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562144 T2431 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 562145 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@795e972e main{StandardDirectoryReader(segments_r:101:nrt _l(4.7):c1 _r(4.7):c1)}
[junit4] 2> 562150 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@b5fa7bf1 main
[junit4] 2> 562151 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562152 T2432 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562153 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b5fa7bf1 main{StandardDirectoryReader(segments_s:104:nrt _l(4.7):c1 _r(4.7):c1 _s(4.7):c1)}
[junit4] 2> 562157 T2432 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_s,generation=28}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_t,generation=29}
[junit4] 2> 562157 T2432 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 29
[junit4] 2> 562158 T2432 oass.SolrIndexSearcher.<init> Opening Searcher@15ce73d7 main
[junit4] 2> 562158 T2432 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562158 T2433 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562160 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15ce73d7 main{StandardDirectoryReader(segments_t:107:nrt _r(4.7):c1 _t(4.7):c1)}
[junit4] 2> 562160 T2433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_t,generation=29}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_u,generation=30}
[junit4] 2> 562161 T2433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 30
[junit4] 2> 562164 T2433 oass.SolrIndexSearcher.<init> Opening Searcher@13538a9c main
[junit4] 2> 562164 T2433 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562165 T2431 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562165 T2431 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_u,generation=30}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_v,generation=31}
[junit4] 2> 562166 T2431 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 31
[junit4] 2> 562166 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@13538a9c main{StandardDirectoryReader(segments_u:111:nrt _r(4.7):c1 _u(4.7):c1)}
[junit4] 2> 562167 T2431 oass.SolrIndexSearcher.<init> Opening Searcher@bcb63aa6 main
[junit4] 2> 562167 T2431 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562168 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bcb63aa6 main{StandardDirectoryReader(segments_u:111:nrt _r(4.7):c1 _u(4.7):c1)}
[junit4] 2> ASYNC NEW_CORE C1128 name=collection1 org.apache.solr.core.SolrCore@d78ee463
[junit4] 2> 562169 T2420 C1128 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562170 T2420 C1128 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 562170 T2420 C1128 oass.SolrIndexSearcher.<init> Opening Searcher@636be138 main
[junit4] 2> 562171 T2420 C1128 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562172 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@636be138 main{StandardDirectoryReader(segments_u:111:nrt _r(4.7):c1 _u(4.7):c1)}
[junit4] 2> 562172 T2420 C1128 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 3
[junit4] 2> 562174 T2420 oas.SolrTestCaseJ4.tearDown ###Ending testMultiThreaded
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testMultiThreaded -Dtests.seed=D0E2D4BE718E1C9B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_PY -Dtests.timezone=America/Louisville -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.58s J0 | SignatureUpdateProcessorFactoryTest.testMultiThreaded <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<2>
[junit4] > at __randomizedtesting.SeedInfo.seed([D0E2D4BE718E1C9B:B1770E5E995F166D]: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:780)
[junit4] 2> 562181 T2420 oas.SolrTestCaseJ4.setUp ###Starting testDupeDetection
[junit4] 2> 562182 T2420 C1128 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 562182 T2420 C1128 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 562183 T2420 C1128 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562184 T2420 C1128 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_v,generation=31}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_w,generation=32}
[junit4] 2> 562185 T2420 C1128 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 32
[junit4] 2> 562185 T2420 C1128 oass.SolrIndexSearcher.<init> Opening Searcher@ebcc6312 main
[junit4] 2> 562186 T2420 C1128 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562187 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ebcc6312 main{StandardDirectoryReader(segments_w:112:nrt)}
[junit4] 2> 562188 T2420 C1128 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5
[junit4] 2> 562192 T2420 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562196 T2420 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_w,generation=32}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_x,generation=33}
[junit4] 2> 562197 T2420 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 33
[junit4] 2> 562198 T2420 oass.SolrIndexSearcher.<init> Opening Searcher@b11bbe48 main
[junit4] 2> 562198 T2420 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562199 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b11bbe48 main{StandardDirectoryReader(segments_x:114:nrt _v(4.7):c2)}
[junit4] 2> 562202 T2420 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562207 T2420 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_x,generation=33}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_y,generation=34}
[junit4] 2> 562207 T2420 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 34
[junit4] 2> 562208 T2420 oass.SolrIndexSearcher.<init> Opening Searcher@287f09fc main
[junit4] 2> 562208 T2420 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562210 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@287f09fc main{StandardDirectoryReader(segments_y:116:nrt _v(4.7):c2 _w(4.7):c1)}
[junit4] 2> 562210 T2420 oas.SolrTestCaseJ4.tearDown ###Ending testDupeDetection
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SignatureUpdateProcessorFactoryTest -Dtests.method=testDupeDetection -Dtests.seed=D0E2D4BE718E1C9B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_PY -Dtests.timezone=America/Louisville -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.04s J0 | SignatureUpdateProcessorFactoryTest.testDupeDetection <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<1> but was:<3>
[junit4] > at __randomizedtesting.SeedInfo.seed([D0E2D4BE718E1C9B:8BD22F7672C9BFE7]: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:780)
[junit4] 2> 562219 T2420 oas.SolrTestCaseJ4.setUp ###Starting testDupeAllFieldsDetection
[junit4] 2> 562219 T2420 C1128 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 562220 T2420 C1128 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 562223 T2420 C1128 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562224 T2420 C1128 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_y,generation=34}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_z,generation=35}
[junit4] 2> 562224 T2420 C1128 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 35
[junit4] 2> 562225 T2420 C1128 oass.SolrIndexSearcher.<init> Opening Searcher@88b85471 main
[junit4] 2> 562227 T2420 C1128 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562229 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@88b85471 main{StandardDirectoryReader(segments_z:117:nrt)}
[junit4] 2> 562229 T2420 C1128 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7
[junit4] 2> 562242 T2420 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 562245 T2420 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_z,generation=35}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@aa912cfc lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6909172c)),segFN=segments_10,generation=36}
[junit4] 2> 562246 T2420 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 36
[junit4] 2> 562249 T2420 oass.SolrIndexSearcher.<init> Opening Searcher@a10672ff main
[junit4] 2> 562250 T2420 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 562252 T2422 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a10672ff main{StandardDirectoryReader(segments_10:119:nrt _x(4.7):c3)}
[junit4] 2> 562253 T2420 oas.SolrTestCaseJ4.tearDown ###Ending testDupeAllFieldsDetection
[junit4] 2> 562257 T2420 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 562258 T2420 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1381416246
[junit4] 2> 562259 T2420 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@d78ee463
[junit4] 2> 562274 T2420 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> 562274 T2420 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 562275 T2420 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 562275 T2420 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 562276 T2420 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 562277 T2420 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 562277 T2420 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1390642733808/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1390642733808/index;done=false>>]
[junit4] 2> 562278 T2420 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1390642733808/index
[junit4] 2> 562278 T2420 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1390642733808 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1390642733808;done=false>>]
[junit4] 2> 562279 T2420 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./solrtest-SignatureUpdateProcessorFactoryTest-1390642733808
[junit4] 2> NOTE: test params are: codec=Lucene3x, sim=DefaultSimilarity, locale=es_PY, timezone=America/Louisville
[junit4] 2> NOTE: Linux 3.8.0-35-generic amd64/IBM Corporation 1.7.0 (64-bit)/cpus=8,threads=1,free=138425792,total=290848768
[junit4] 2> NOTE: All tests run in this JVM: [TestCustomSort, SampleTest, UpdateRequestProcessorFactoryTest, TestSolrQueryParser, TestGroupingSearch, CachingDirectoryFactoryTest, PrimitiveFieldTypeTest, TestSchemaNameResource, SchemaVersionSpecificBehaviorTest, BadCopyFieldTest, AutoCommitTest, SolrInfoMBeanTest, ZkControllerTest, DocValuesMissingTest, LegacyHTMLStripCharFilterTest, TestSolrXmlPersistor, TestClassNameShortening, AnalysisAfterCoreReloadTest, TestDistribDocBasedVersion, OverseerCollectionProcessorTest, StressHdfsTest, BasicDistributedZkTest, TestReversedWildcardFilterFactory, SolrCoreTest, FieldMutatingUpdateProcessorTest, ConnectionManagerTest, SOLR749Test, TestInfoStreamLogging, QueryEqualityTest, MoreLikeThisHandlerTest, TestSort, LeaderElectionTest, TestSolrQueryParserDefaultOperatorResource, TestImplicitCoreProperties, TestSystemIdResolver, TestFunctionQuery, LukeRequestHandlerTest, TestStressVersions, TestReplicationHandler, TestLFUCache, TestPerFieldSimilarity, TestRemoteStreaming, TestFreeTextSuggestions, TestFieldResource, BasicFunctionalityTest, ChangedSchemaMergeTest, DistribCursorPagingTest, HdfsBasicDistributedZk2Test, DistributedTermsComponentTest, PolyFieldTest, UpdateParamsTest, EchoParamsTest, TestCloudManagedSchemaAddField, PeerSyncTest, TestSearchPerf, BadComponentTest, CacheHeaderTest, TestDefaultSearchFieldResource, SolrIndexSplitterTest, TestCloudManagedSchema, SuggesterFSTTest, TestFaceting, DocumentBuilderTest, WordBreakSolrSpellCheckerTest, LoggingHandlerTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestDynamicFieldResource, CopyFieldTest, TestCoreContainer, BlockDirectoryTest, RegexBoostProcessorTest, DeleteReplicaTest, TestStressUserVersions, DOMUtilTest, SuggesterTest, MBeansHandlerTest, DateMathParserTest, TestBadConfig, SpellPossibilityIteratorTest, BinaryUpdateRequestHandlerTest, TestPHPSerializedResponseWriter, TestJoin, QueryParsingTest, BasicDistributedZk2Test, UnloadDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest, ShardRoutingTest, BasicZkTest, TestRandomDVFaceting, TestRangeQuery, StatsComponentTest, SpellCheckComponentTest, BadIndexSchemaTest, TestFiltering, SimplePostToolTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest]
[junit4] Completed on J0 in 1.91s, 6 tests, 2 failures <<< FAILURES!
[...truncated 436 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:459: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:452: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:491: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1308: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:941: There were test failures: 355 suites, 1547 tests, 2 failures, 68 ignored (7 assumptions)
Total time: 36 minutes 31 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/ibm-j9-jdk7 -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