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/11/22 04:27:16 UTC

[JENKINS] Lucene-Solr-trunk-Linux (32bit/jdk1.8.0-ea-b114) - Build # 8413 - Still Failing!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/8413/
Java: 32bit/jdk1.8.0-ea-b114 -client -XX:+UseConcMarkSweepGC

1 tests failed.
REGRESSION:  org.apache.solr.analytics.NoFacetTest.stddevTest

Error Message:
Oops: (double raws) 4631318898052956160 - 4628496337733101339 < 4442235333156365461 Calculated diff 4625071700926640586

Stack Trace:
java.lang.AssertionError: Oops: (double raws) 4631318898052956160 - 4628496337733101339 < 4442235333156365461 Calculated diff 4625071700926640586
	at __randomizedtesting.SeedInfo.seed([A6AAB2F23D736034:A36AF2470D10643B]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.analytics.NoFacetTest.stddevTest(NoFacetTest.java:227)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:483)
	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:744)




Build Log:
[...truncated 10888 lines...]
   [junit4] Suite: org.apache.solr.analytics.NoFacetTest
   [junit4]   2> 1445291 T3785 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307
   [junit4]   2> 1445292 T3785 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 1445292 T3785 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1445293 T3785 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1445322 T3785 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
   [junit4]   2> 1445329 T3785 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 1445330 T3785 oass.IndexSchema.readSchema Reading Solr Schema from schema-analytics.xml
   [junit4]   2> 1445339 T3785 oass.IndexSchema.readSchema [null] Schema name=schema-docValues
   [junit4]   2> 1445349 T3785 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1445354 T3785 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1445354 T3785 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
   [junit4]   2> 1445355 T3785 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
   [junit4]   2> 1445366 T3785 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1445367 T3785 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
   [junit4]   2> 1445367 T3785 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
   [junit4]   2> 1445387 T3785 oasc.CoreContainer.<init> New CoreContainer 5064227
   [junit4]   2> 1445388 T3785 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/]
   [junit4]   2> 1445388 T3785 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 1445388 T3785 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 1445389 T3785 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 1445389 T3785 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1445389 T3785 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1445390 T3785 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1445390 T3785 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1445391 T3785 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1445391 T3785 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1445392 T3785 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1445393 T3785 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1445393 T3785 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 1445394 T3786 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
   [junit4]   2> 1445395 T3786 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 1445395 T3786 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1445395 T3786 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1445422 T3786 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
   [junit4]   2> 1445431 T3786 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 1445431 T3786 oass.IndexSchema.readSchema Reading Solr Schema from schema-analytics.xml
   [junit4]   2> 1445440 T3786 oass.IndexSchema.readSchema [collection1] Schema name=schema-docValues
   [junit4]   2> 1445449 T3786 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1445450 T3786 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1445450 T3786 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307/
   [junit4]   2> 1445451 T3786 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 1445451 T3786 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307
   [junit4]   2> 1445451 T3786 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307/index/
   [junit4]   2> 1445452 T3786 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307/index' doesn't exist. Creating new index...
   [junit4]   2> 1445452 T3786 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307/index
   [junit4]   2> 1445453 T3786 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=51.083984375, floorSegmentMB=1.828125, forceMergeDeletesPctAllowed=20.640710629334674, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3280096761935857
   [junit4]   2> 1445454 T3786 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_1,generation=1}
   [junit4]   2> 1445454 T3786 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1445455 T3786 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1445455 T3786 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 1445456 T3786 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 1445458 T3786 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1445459 T3786 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1445459 T3786 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1445459 T3786 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 1445460 T3786 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_1,generation=1}
   [junit4]   2> 1445460 T3786 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1445460 T3786 oass.SolrIndexSearcher.<init> Opening Searcher@1d162a0 main
   [junit4]   2> 1445461 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1d162a0 main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 1445461 T3786 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1445463 T3785 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> ASYNC  NEW_CORE C14989 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445464 T3785 C14989 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1445464 T3785 C14989 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
   [junit4]   2> 1445467 T3785 C14989 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10000]} 0 1
   [junit4]   2> ASYNC  NEW_CORE C14990 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445473 T3785 C14990 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445478 T3785 C14990 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_2,generation=2}
   [junit4]   2> 1445479 T3785 C14990 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 1445481 T3785 C14990 oass.SolrIndexSearcher.<init> Opening Searcher@1e8ca78 main
   [junit4]   2> 1445481 T3785 C14990 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445481 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e8ca78 main{StandardDirectoryReader(segments_2:4:nrt _0(5.0):c1)}
   [junit4]   2> 1445482 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445485 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10001]} 0 2
   [junit4]   2> 1445487 T3785 C14990 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445491 T3785 C14990 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_3,generation=3}
   [junit4]   2> 1445492 T3785 C14990 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 1445494 T3785 C14990 oass.SolrIndexSearcher.<init> Opening Searcher@905993 main
   [junit4]   2> 1445495 T3785 C14990 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445495 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@905993 main{StandardDirectoryReader(segments_3:6:nrt _0(5.0):c1 _1(5.0):c1)}
   [junit4]   2> 1445496 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445500 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10002]} 0 2
   [junit4]   2> 1445501 T3785 C14990 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445506 T3785 C14990 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_3,generation=3}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_4,generation=4}
   [junit4]   2> 1445507 T3785 C14990 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
   [junit4]   2> 1445509 T3785 C14990 oass.SolrIndexSearcher.<init> Opening Searcher@8380e0 main
   [junit4]   2> 1445510 T3785 C14990 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445510 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8380e0 main{StandardDirectoryReader(segments_4:8:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1)}
   [junit4]   2> 1445510 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445513 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10003]} 0 1
   [junit4]   2> 1445515 T3785 C14990 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445522 T3785 C14990 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_4,generation=4}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_5,generation=5}
   [junit4]   2> 1445523 T3785 C14990 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 1445525 T3785 C14990 oass.SolrIndexSearcher.<init> Opening Searcher@2b6f25 main
   [junit4]   2> 1445525 T3785 C14990 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445525 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2b6f25 main{StandardDirectoryReader(segments_5:10:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1)}
   [junit4]   2> 1445526 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
   [junit4]   2> 1445529 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10004]} 0 2
   [junit4]   2> 1445530 T3785 C14990 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445534 T3785 C14990 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_5,generation=5}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_6,generation=6}
   [junit4]   2> 1445535 T3785 C14990 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
   [junit4]   2> 1445537 T3785 C14990 oass.SolrIndexSearcher.<init> Opening Searcher@edd9ba main
   [junit4]   2> 1445538 T3785 C14990 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445538 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@edd9ba main{StandardDirectoryReader(segments_6:12:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1)}
   [junit4]   2> 1445539 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445542 T3785 C14990 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10005]} 0 2
   [junit4]   2> 1445544 T3785 C14990 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> ASYNC  NEW_CORE C14991 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445551 T3785 C14991 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_6,generation=6}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_7,generation=7}
   [junit4]   2> 1445552 T3785 C14991 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
   [junit4]   2> 1445554 T3785 C14991 oass.SolrIndexSearcher.<init> Opening Searcher@a1f540 main
   [junit4]   2> 1445555 T3785 C14991 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445555 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a1f540 main{StandardDirectoryReader(segments_7:14:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1)}
   [junit4]   2> 1445556 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 13
   [junit4]   2> 1445559 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10006]} 0 2
   [junit4]   2> 1445560 T3785 C14991 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445565 T3785 C14991 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_7,generation=7}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_8,generation=8}
   [junit4]   2> 1445565 T3785 C14991 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
   [junit4]   2> 1445567 T3785 C14991 oass.SolrIndexSearcher.<init> Opening Searcher@1c217e main
   [junit4]   2> 1445568 T3785 C14991 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445568 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c217e main{StandardDirectoryReader(segments_8:16:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1)}
   [junit4]   2> 1445569 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445572 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10007]} 0 2
   [junit4]   2> 1445573 T3785 C14991 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445578 T3785 C14991 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_8,generation=8}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_9,generation=9}
   [junit4]   2> 1445579 T3785 C14991 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
   [junit4]   2> 1445581 T3785 C14991 oass.SolrIndexSearcher.<init> Opening Searcher@5538a0 main
   [junit4]   2> 1445582 T3785 C14991 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445582 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5538a0 main{StandardDirectoryReader(segments_9:18:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1)}
   [junit4]   2> 1445582 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445585 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10008]} 0 1
   [junit4]   2> 1445587 T3785 C14991 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445592 T3785 C14991 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_9,generation=9}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_a,generation=10}
   [junit4]   2> 1445593 T3785 C14991 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
   [junit4]   2> 1445595 T3785 C14991 oass.SolrIndexSearcher.<init> Opening Searcher@dedc5c main
   [junit4]   2> 1445595 T3785 C14991 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445595 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@dedc5c main{StandardDirectoryReader(segments_a:20:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1)}
   [junit4]   2> 1445596 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445599 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10009]} 0 1
   [junit4]   2> 1445601 T3785 C14991 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445606 T3785 C14991 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_a,generation=10}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_b,generation=11}
   [junit4]   2> 1445606 T3785 C14991 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
   [junit4]   2> 1445608 T3785 C14991 oass.SolrIndexSearcher.<init> Opening Searcher@b02009 main
   [junit4]   2> 1445609 T3785 C14991 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445609 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b02009 main{StandardDirectoryReader(segments_b:22:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1)}
   [junit4]   2> 1445610 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445613 T3785 C14991 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100010]} 0 2
   [junit4]   2> ASYNC  NEW_CORE C14992 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445620 T3785 C14992 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445626 T3785 C14992 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_b,generation=11}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_c,generation=12}
   [junit4]   2> 1445626 T3785 C14992 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
   [junit4]   2> 1445628 T3785 C14992 oass.SolrIndexSearcher.<init> Opening Searcher@1b4f8d4 main
   [junit4]   2> 1445629 T3785 C14992 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445629 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b4f8d4 main{StandardDirectoryReader(segments_c:24:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1)}
   [junit4]   2> 1445630 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1445633 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100011]} 0 2
   [junit4]   2> 1445635 T3785 C14992 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445640 T3785 C14992 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_c,generation=12}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_d,generation=13}
   [junit4]   2> 1445640 T3785 C14992 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
   [junit4]   2> 1445643 T3785 C14992 oass.SolrIndexSearcher.<init> Opening Searcher@2b6807 main
   [junit4]   2> 1445644 T3785 C14992 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445644 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2b6807 main{StandardDirectoryReader(segments_d:26:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1)}
   [junit4]   2> 1445644 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1445647 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100012]} 0 1
   [junit4]   2> 1445649 T3785 C14992 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445654 T3785 C14992 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_d,generation=13}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_e,generation=14}
   [junit4]   2> 1445655 T3785 C14992 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
   [junit4]   2> 1445657 T3785 C14992 oass.SolrIndexSearcher.<init> Opening Searcher@910ad6 main
   [junit4]   2> 1445657 T3785 C14992 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445657 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@910ad6 main{StandardDirectoryReader(segments_e:28:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1)}
   [junit4]   2> 1445658 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445661 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100013]} 0 2
   [junit4]   2> 1445663 T3785 C14992 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445667 T3785 C14992 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_e,generation=14}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_f,generation=15}
   [junit4]   2> 1445668 T3785 C14992 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
   [junit4]   2> 1445670 T3785 C14992 oass.SolrIndexSearcher.<init> Opening Searcher@192b0ad main
   [junit4]   2> 1445671 T3785 C14992 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445671 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@192b0ad main{StandardDirectoryReader(segments_f:30:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1)}
   [junit4]   2> 1445671 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445674 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100014]} 0 1
   [junit4]   2> 1445676 T3785 C14992 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445681 T3785 C14992 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_f,generation=15}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_g,generation=16}
   [junit4]   2> 1445681 T3785 C14992 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
   [junit4]   2> 1445685 T3785 C14992 oass.SolrIndexSearcher.<init> Opening Searcher@12b6649 main
   [junit4]   2> 1445686 T3785 C14992 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445686 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12b6649 main{StandardDirectoryReader(segments_g:32:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1)}
   [junit4]   2> 1445687 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
   [junit4]   2> 1445690 T3785 C14992 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100015]} 0 2
   [junit4]   2> ASYNC  NEW_CORE C14993 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445694 T3785 C14993 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445700 T3785 C14993 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_g,generation=16}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_h,generation=17}
   [junit4]   2> 1445701 T3785 C14993 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
   [junit4]   2> 1445703 T3785 C14993 oass.SolrIndexSearcher.<init> Opening Searcher@bb48c7 main
   [junit4]   2> 1445703 T3785 C14993 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445703 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bb48c7 main{StandardDirectoryReader(segments_h:34:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1)}
   [junit4]   2> 1445704 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1445707 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100016]} 0 1
   [junit4]   2> 1445709 T3785 C14993 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445715 T3785 C14993 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_h,generation=17}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_i,generation=18}
   [junit4]   2> 1445715 T3785 C14993 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
   [junit4]   2> 1445717 T3785 C14993 oass.SolrIndexSearcher.<init> Opening Searcher@156aa06 main
   [junit4]   2> 1445718 T3785 C14993 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445718 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@156aa06 main{StandardDirectoryReader(segments_i:36:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1)}
   [junit4]   2> 1445719 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1445722 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100017]} 0 2
   [junit4]   2> 1445723 T3785 C14993 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445729 T3785 C14993 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_i,generation=18}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_j,generation=19}
   [junit4]   2> 1445730 T3785 C14993 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
   [junit4]   2> 1445732 T3785 C14993 oass.SolrIndexSearcher.<init> Opening Searcher@14fca57 main
   [junit4]   2> 1445733 T3785 C14993 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445733 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14fca57 main{StandardDirectoryReader(segments_j:38:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1)}
   [junit4]   2> 1445734 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1445737 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100018]} 0 2
   [junit4]   2> 1445739 T3785 C14993 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445745 T3785 C14993 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_j,generation=19}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_k,generation=20}
   [junit4]   2> 1445745 T3785 C14993 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
   [junit4]   2> 1445747 T3785 C14993 oass.SolrIndexSearcher.<init> Opening Searcher@177698d main
   [junit4]   2> 1445748 T3785 C14993 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445748 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@177698d main{StandardDirectoryReader(segments_k:40:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1)}
   [junit4]   2> 1445749 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1445752 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100019]} 0 2
   [junit4]   2> 1445753 T3785 C14993 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445759 T3785 C14993 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_k,generation=20}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_l,generation=21}
   [junit4]   2> 1445759 T3785 C14993 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
   [junit4]   2> 1445761 T3785 C14993 oass.SolrIndexSearcher.<init> Opening Searcher@a5c8ee main
   [junit4]   2> 1445762 T3785 C14993 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445762 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a5c8ee main{StandardDirectoryReader(segments_l:42:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1)}
   [junit4]   2> 1445763 T3785 C14993 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> ASYNC  NEW_CORE C14994 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445769 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100020]} 0 1
   [junit4]   2> 1445771 T3785 C14994 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445779 T3785 C14994 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_l,generation=21}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_m,generation=22}
   [junit4]   2> 1445779 T3785 C14994 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
   [junit4]   2> 1445782 T3785 C14994 oass.SolrIndexSearcher.<init> Opening Searcher@18f20f0 main
   [junit4]   2> 1445783 T3785 C14994 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445783 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@18f20f0 main{StandardDirectoryReader(segments_m:44:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1)}
   [junit4]   2> 1445784 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 13
   [junit4]   2> 1445788 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100021]} 0 2
   [junit4]   2> 1445791 T3785 C14994 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445799 T3785 C14994 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_m,generation=22}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_n,generation=23}
   [junit4]   2> 1445800 T3785 C14994 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
   [junit4]   2> 1445803 T3785 C14994 oass.SolrIndexSearcher.<init> Opening Searcher@791826 main
   [junit4]   2> 1445803 T3785 C14994 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445804 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@791826 main{StandardDirectoryReader(segments_n:46:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1)}
   [junit4]   2> 1445804 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 13
   [junit4]   2> 1445808 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100022]} 0 1
   [junit4]   2> 1445810 T3785 C14994 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445816 T3785 C14994 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_n,generation=23}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_o,generation=24}
   [junit4]   2> 1445816 T3785 C14994 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
   [junit4]   2> 1445818 T3785 C14994 oass.SolrIndexSearcher.<init> Opening Searcher@12619d7 main
   [junit4]   2> 1445819 T3785 C14994 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445819 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12619d7 main{StandardDirectoryReader(segments_o:48:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1)}
   [junit4]   2> 1445820 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1445823 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100023]} 0 2
   [junit4]   2> 1445824 T3785 C14994 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445829 T3785 C14994 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_o,generation=24}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_p,generation=25}
   [junit4]   2> 1445830 T3785 C14994 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
   [junit4]   2> 1445832 T3785 C14994 oass.SolrIndexSearcher.<init> Opening Searcher@16db8c0 main
   [junit4]   2> 1445832 T3785 C14994 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445832 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16db8c0 main{StandardDirectoryReader(segments_p:50:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1)}
   [junit4]   2> 1445833 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1445836 T3785 C14994 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100024]} 0 2
   [junit4]   2> 1445837 T3785 C14994 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> ASYNC  NEW_CORE C14995 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445846 T3785 C14995 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_p,generation=25}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_q,generation=26}
   [junit4]   2> 1445847 T3785 C14995 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 26
   [junit4]   2> 1445849 T3785 C14995 oass.SolrIndexSearcher.<init> Opening Searcher@d7945d main
   [junit4]   2> 1445850 T3785 C14995 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445850 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d7945d main{StandardDirectoryReader(segments_q:52:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1)}
   [junit4]   2> 1445850 T3785 C14995 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 13
   [junit4]   2> 1445853 T3785 C14995 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100025]} 0 1
   [junit4]   2> 1445855 T3785 C14995 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445860 T3785 C14995 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_q,generation=26}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_r,generation=27}
   [junit4]   2> 1445861 T3785 C14995 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 27
   [junit4]   2> 1445863 T3785 C14995 oass.SolrIndexSearcher.<init> Opening Searcher@1c5473d main
   [junit4]   2> 1445864 T3785 C14995 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445864 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c5473d main{StandardDirectoryReader(segments_r:55:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1)}
   [junit4]   2> 1445865 T3785 C14995 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1445869 T3785 C14995 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100026]} 0 2
   [junit4]   2> 1445871 T3785 C14995 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445882 T3785 C14995 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_r,generation=27}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_s,generation=28}
   [junit4]   2> 1445883 T3785 C14995 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 28
   [junit4]   2> 1445886 T3785 C14995 oass.SolrIndexSearcher.<init> Opening Searcher@4f471 main
   [junit4]   2> 1445887 T3785 C14995 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445887 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f471 main{StandardDirectoryReader(segments_s:57:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _r(5.0):c1)}
   [junit4]   2> 1445888 T3785 C14995 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 17
   [junit4]   2> 1445892 T3785 C14995 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100027]} 0 2
   [junit4]   2> 1445894 T3785 C14995 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445902 T3785 C14995 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_s,generation=28}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_t,generation=29}
   [junit4]   2> 1445903 T3785 C14995 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 29
   [junit4]   2> 1445906 T3785 C14995 oass.SolrIndexSearcher.<init> Opening Searcher@ca4588 main
   [junit4]   2> 1445907 T3785 C14995 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445907 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ca4588 main{StandardDirectoryReader(segments_t:59:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _r(5.0):c1 _s(5.0):c1)}
   [junit4]   2> 1445908 T3785 C14995 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 14
   [junit4]   2> 1445911 T3785 C14995 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100028]} 0 1
   [junit4]   2> 1445912 T3785 C14995 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> ASYNC  NEW_CORE C14996 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445922 T3785 C14996 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_t,generation=29}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_u,generation=30}
   [junit4]   2> 1445923 T3785 C14996 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 30
   [junit4]   2> 1445927 T3785 C14996 oass.SolrIndexSearcher.<init> Opening Searcher@1be0cf7 main
   [junit4]   2> 1445927 T3785 C14996 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445927 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1be0cf7 main{StandardDirectoryReader(segments_u:62:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1)}
   [junit4]   2> 1445929 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 17
   [junit4]   2> 1445933 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100029]} 0 1
   [junit4]   2> 1445935 T3785 C14996 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445939 T3785 C14996 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_u,generation=30}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_v,generation=31}
   [junit4]   2> 1445940 T3785 C14996 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 31
   [junit4]   2> 1445942 T3785 C14996 oass.SolrIndexSearcher.<init> Opening Searcher@1d684e2 main
   [junit4]   2> 1445943 T3785 C14996 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445943 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1d684e2 main{StandardDirectoryReader(segments_v:64:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1)}
   [junit4]   2> 1445943 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1445947 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100030]} 0 2
   [junit4]   2> 1445948 T3785 C14996 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445954 T3785 C14996 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_v,generation=31}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_w,generation=32}
   [junit4]   2> 1445955 T3785 C14996 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 32
   [junit4]   2> 1445958 T3785 C14996 oass.SolrIndexSearcher.<init> Opening Searcher@1df6d4f main
   [junit4]   2> 1445958 T3785 C14996 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445959 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1df6d4f main{StandardDirectoryReader(segments_w:66:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1)}
   [junit4]   2> 1445959 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
   [junit4]   2> 1445963 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100031]} 0 2
   [junit4]   2> 1445966 T3785 C14996 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445971 T3785 C14996 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_w,generation=32}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_x,generation=33}
   [junit4]   2> 1445972 T3785 C14996 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 33
   [junit4]   2> 1445974 T3785 C14996 oass.SolrIndexSearcher.<init> Opening Searcher@16812cd main
   [junit4]   2> 1445975 T3785 C14996 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445975 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16812cd main{StandardDirectoryReader(segments_x:68:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1)}
   [junit4]   2> 1445976 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
   [junit4]   2> 1445979 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100032]} 0 2
   [junit4]   2> 1445980 T3785 C14996 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1445984 T3785 C14996 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_x,generation=33}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_y,generation=34}
   [junit4]   2> 1445985 T3785 C14996 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 34
   [junit4]   2> 1445987 T3785 C14996 oass.SolrIndexSearcher.<init> Opening Searcher@1cb86b3 main
   [junit4]   2> 1445987 T3785 C14996 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1445987 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1cb86b3 main{StandardDirectoryReader(segments_y:70:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1)}
   [junit4]   2> 1445988 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1445991 T3785 C14996 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100033]} 0 1
   [junit4]   2> ASYNC  NEW_CORE C14997 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1445999 T3785 C14997 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446003 T3785 C14997 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_y,generation=34}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_z,generation=35}
   [junit4]   2> 1446004 T3785 C14997 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 35
   [junit4]   2> 1446006 T3785 C14997 oass.SolrIndexSearcher.<init> Opening Searcher@19585a2 main
   [junit4]   2> 1446008 T3785 C14997 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446008 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@19585a2 main{StandardDirectoryReader(segments_z:72:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1)}
   [junit4]   2> 1446009 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
   [junit4]   2> 1446012 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100034]} 0 2
   [junit4]   2> 1446013 T3785 C14997 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446017 T3785 C14997 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_z,generation=35}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_10,generation=36}
   [junit4]   2> 1446017 T3785 C14997 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 36
   [junit4]   2> 1446019 T3785 C14997 oass.SolrIndexSearcher.<init> Opening Searcher@355615 main
   [junit4]   2> 1446020 T3785 C14997 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446020 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@355615 main{StandardDirectoryReader(segments_10:74:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1)}
   [junit4]   2> 1446021 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1446024 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100035]} 0 1
   [junit4]   2> 1446025 T3785 C14997 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446029 T3785 C14997 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_10,generation=36}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_11,generation=37}
   [junit4]   2> 1446030 T3785 C14997 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 37
   [junit4]   2> 1446031 T3785 C14997 oass.SolrIndexSearcher.<init> Opening Searcher@e55128 main
   [junit4]   2> 1446032 T3785 C14997 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446032 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e55128 main{StandardDirectoryReader(segments_11:76:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1)}
   [junit4]   2> 1446033 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1446035 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100036]} 0 1
   [junit4]   2> 1446038 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100037]} 0 1
   [junit4]   2> 1446039 T3785 C14997 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446044 T3785 C14997 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_11,generation=37}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_12,generation=38}
   [junit4]   2> 1446044 T3785 C14997 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 38
   [junit4]   2> 1446046 T3785 C14997 oass.SolrIndexSearcher.<init> Opening Searcher@14e190b main
   [junit4]   2> 1446046 T3785 C14997 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446046 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14e190b main{StandardDirectoryReader(segments_12:78:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2)}
   [junit4]   2> 1446047 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1446050 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100038]} 0 2
   [junit4]   2> 1446051 T3785 C14997 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446055 T3785 C14997 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_12,generation=38}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_13,generation=39}
   [junit4]   2> 1446055 T3785 C14997 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 39
   [junit4]   2> 1446057 T3785 C14997 oass.SolrIndexSearcher.<init> Opening Searcher@bd67dd main
   [junit4]   2> 1446058 T3785 C14997 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446058 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bd67dd main{StandardDirectoryReader(segments_13:80:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1)}
   [junit4]   2> 1446058 T3785 C14997 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7
   [junit4]   2> ASYNC  NEW_CORE C14998 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1446063 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100039]} 0 1
   [junit4]   2> 1446065 T3785 C14998 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446069 T3785 C14998 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_13,generation=39}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_14,generation=40}
   [junit4]   2> 1446070 T3785 C14998 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 40
   [junit4]   2> 1446072 T3785 C14998 oass.SolrIndexSearcher.<init> Opening Searcher@1f494e main
   [junit4]   2> 1446073 T3785 C14998 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446073 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f494e main{StandardDirectoryReader(segments_14:82:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1)}
   [junit4]   2> 1446074 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1446077 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100040]} 0 2
   [junit4]   2> 1446078 T3785 C14998 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446083 T3785 C14998 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_14,generation=40}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_15,generation=41}
   [junit4]   2> 1446083 T3785 C14998 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 41
   [junit4]   2> 1446086 T3785 C14998 oass.SolrIndexSearcher.<init> Opening Searcher@1c42ba3 main
   [junit4]   2> 1446087 T3785 C14998 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446087 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c42ba3 main{StandardDirectoryReader(segments_15:84:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1 _14(5.0):c1)}
   [junit4]   2> 1446087 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1446091 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100041]} 0 2
   [junit4]   2> 1446093 T3785 C14998 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446100 T3785 C14998 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_15,generation=41}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_16,generation=42}
   [junit4]   2> 1446100 T3785 C14998 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 42
   [junit4]   2> 1446103 T3785 C14998 oass.SolrIndexSearcher.<init> Opening Searcher@3faad7 main
   [junit4]   2> 1446104 T3785 C14998 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446104 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3faad7 main{StandardDirectoryReader(segments_16:86:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1 _14(5.0):c1 _15(5.0):c1)}
   [junit4]   2> 1446105 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 12
   [junit4]   2> 1446108 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100042]} 0 2
   [junit4]   2> 1446109 T3785 C14998 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446113 T3785 C14998 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_16,generation=42}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_17,generation=43}
   [junit4]   2> 1446114 T3785 C14998 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 43
   [junit4]   2> 1446115 T3785 C14998 oass.SolrIndexSearcher.<init> Opening Searcher@1ea8fcc main
   [junit4]   2> 1446116 T3785 C14998 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446116 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1ea8fcc main{StandardDirectoryReader(segments_17:88:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1 _14(5.0):c1 _15(5.0):c1 _16(5.0):c1)}
   [junit4]   2> 1446117 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1446119 T3785 C14998 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100043]} 0 1
   [junit4]   2> 1446121 T3785 C14998 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446126 T3785 C14998 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_17,generation=43}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_18,generation=44}
   [junit4]   2> 1446127 T3785 C14998 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 44
   [junit4]   2> ASYNC  NEW_CORE C14999 name=collection1 org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1446134 T3785 C14999 oass.SolrIndexSearcher.<init> Opening Searcher@d33bbe main
   [junit4]   2> 1446135 T3785 C14999 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446135 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d33bbe main{StandardDirectoryReader(segments_18:90:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1 _14(5.0):c1 _15(5.0):c1 _16(5.0):c1 _17(5.0):c1)}
   [junit4]   2> 1446136 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 15
   [junit4]   2> 1446139 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100044]} 0 1
   [junit4]   2> 1446142 T3785 C14999 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446147 T3785 C14999 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_18,generation=44}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_19,generation=45}
   [junit4]   2> 1446148 T3785 C14999 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 45
   [junit4]   2> 1446150 T3785 C14999 oass.SolrIndexSearcher.<init> Opening Searcher@17fc1ae main
   [junit4]   2> 1446150 T3785 C14999 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446150 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@17fc1ae main{StandardDirectoryReader(segments_19:92:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1 _14(5.0):c1 _15(5.0):c1 _16(5.0):c1 _17(5.0):c1 _18(5.0):c1)}
   [junit4]   2> 1446151 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1446154 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100045]} 0 1
   [junit4]   2> 1446156 T3785 C14999 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446160 T3785 C14999 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_19,generation=45}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_1a,generation=46}
   [junit4]   2> 1446161 T3785 C14999 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 46
   [junit4]   2> 1446163 T3785 C14999 oass.SolrIndexSearcher.<init> Opening Searcher@748d77 main
   [junit4]   2> 1446163 T3785 C14999 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446163 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@748d77 main{StandardDirectoryReader(segments_1a:94:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1 _14(5.0):c1 _15(5.0):c1 _16(5.0):c1 _17(5.0):c1 _18(5.0):c1 _19(5.0):c1)}
   [junit4]   2> 1446164 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
   [junit4]   2> 1446167 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100046]} 0 1
   [junit4]   2> 1446168 T3785 C14999 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446172 T3785 C14999 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_1a,generation=46}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_1b,generation=47}
   [junit4]   2> 1446173 T3785 C14999 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 47
   [junit4]   2> 1446175 T3785 C14999 oass.SolrIndexSearcher.<init> Opening Searcher@149ebf0 main
   [junit4]   2> 1446175 T3785 C14999 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446175 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@149ebf0 main{StandardDirectoryReader(segments_1b:96:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1 _14(5.0):c1 _15(5.0):c1 _16(5.0):c1 _17(5.0):c1 _18(5.0):c1 _19(5.0):c1 _1a(5.0):c1)}
   [junit4]   2> 1446176 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1446179 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100047]} 0 1
   [junit4]   2> 1446181 T3785 C14999 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1446185 T3785 C14999 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_1b,generation=47}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@887d39 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ef8b1e),segFN=segments_1c,generation=48}
   [junit4]   2> 1446185 T3785 C14999 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 48
   [junit4]   2> 1446187 T3785 C14999 oass.SolrIndexSearcher.<init> Opening Searcher@16aca75 main
   [junit4]   2> 1446188 T3785 C14999 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1446188 T3787 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16aca75 main{StandardDirectoryReader(segments_1c:98:nrt _q(5.0):c26 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1 _y(5.0):c1 _z(5.0):c1 _10(5.0):c1 _11(5.0):c2 _12(5.0):c1 _13(5.0):c1 _14(5.0):c1 _15(5.0):c1 _16(5.0):c1 _17(5.0):c1 _18(5.0):c1 _19(5.0):c1 _1a(5.0):c1 _1b(5.0):c1)}
   [junit4]   2> 1446189 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 1446193 T3785 C14999 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null para

[...truncated too long message...]

t.stddevTest(NoFacetTest.java:227)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:744)
   [junit4]   2> 1447090 T3785 oas.SolrTestCaseJ4.setUp ###Starting missingDefaultTest
   [junit4]   2> 1447090 T3785 oas.SolrTestCaseJ4.tearDown ###Ending missingDefaultTest
   [junit4]   2> 1447095 T3785 oas.SolrTestCaseJ4.setUp ###Starting perc60Test
   [junit4]   2> 1447096 T3785 oas.SolrTestCaseJ4.tearDown ###Ending perc60Test
   [junit4]   2> 1447102 T3785 oas.SolrTestCaseJ4.setUp ###Starting sumOfSquaresTest
   [junit4]   2> 1447102 T3785 oas.SolrTestCaseJ4.tearDown ###Ending sumOfSquaresTest
   [junit4]   2> 1447108 T3785 oas.SolrTestCaseJ4.setUp ###Starting minTest
   [junit4]   2> 1447109 T3785 oas.SolrTestCaseJ4.tearDown ###Ending minTest
   [junit4]   2> 1447115 T3785 oas.SolrTestCaseJ4.setUp ###Starting perc20Test
   [junit4]   2> 1447116 T3785 oas.SolrTestCaseJ4.tearDown ###Ending perc20Test
   [junit4]   2> 1447121 T3785 oas.SolrTestCaseJ4.setUp ###Starting maxTest
   [junit4]   2> 1447122 T3785 oas.SolrTestCaseJ4.tearDown ###Ending maxTest
   [junit4]   2> 1447127 T3785 oas.SolrTestCaseJ4.setUp ###Starting meanTest
   [junit4]   2> 1447127 T3785 oas.SolrTestCaseJ4.tearDown ###Ending meanTest
   [junit4]   2> 1447132 T3785 oas.SolrTestCaseJ4.setUp ###Starting sumTest
   [junit4]   2> 1447132 T3785 oas.SolrTestCaseJ4.tearDown ###Ending sumTest
   [junit4]   2> 1447134 T3785 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 1447134 T3785 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=5064227
   [junit4]   2> 1447135 T3785 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@624dd5
   [junit4]   2> 1447135 T3785 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=100,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=100,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 1447135 T3785 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 1447136 T3785 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1447136 T3785 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1447137 T3785 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 1447138 T3785 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1447138 T3785 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307/index;done=false>>]
   [junit4]   2> 1447138 T3785 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307/index
   [junit4]   2> 1447139 T3785 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307;done=false>>]
   [junit4]   2> 1447139 T3785 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-NoFacetTest-1385090661307
   [junit4]   2> NOTE: test params are: codec=Lucene46: {double_d=MockVariableIntBlock(baseBlockSize=20), float_f=Pulsing41(freqCutoff=4 minBlockSize=31 maxBlockSize=148), int_i=PostingsFormat(name=Lucene41WithOrds), long_l=PostingsFormat(name=Lucene41WithOrds), long_ld=Pulsing41(freqCutoff=4 minBlockSize=31 maxBlockSize=148), date_dtd=Pulsing41(freqCutoff=4 minBlockSize=31 maxBlockSize=148), string_sd=Pulsing41(freqCutoff=4 minBlockSize=31 maxBlockSize=148), int_id=Pulsing41(freqCutoff=4 minBlockSize=31 maxBlockSize=148), id=Pulsing41(freqCutoff=4 minBlockSize=31 maxBlockSize=148), double_dd=TestBloomFilteredLucene41Postings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), float_fd=PostingsFormat(name=Lucene41WithOrds)}, docValues:{date_dtd=DocValuesFormat(name=Lucene45), doubledv=DocValuesFormat(name=Lucene45), string_sd=DocValuesFormat(name=Lucene45), float_fd=DocValuesFormat(name=SimpleText), datedv=DocValuesFormat(name=Memory), long_ld=DocValuesFormat(name=Lucene45), longdv=DocValuesFormat(name=Disk), intdv=DocValuesFormat(name=SimpleText), int_id=DocValuesFormat(name=Lucene45), stringdvm=DocValuesFormat(name=Disk), double_dd=DocValuesFormat(name=Disk), stringdv=DocValuesFormat(name=Lucene45), floatdv=DocValuesFormat(name=Disk)}, sim=DefaultSimilarity, locale=sk, timezone=America/Port_of_Spain
   [junit4]   2> NOTE: Linux 3.8.0-32-generic i386/Oracle Corporation 1.8.0-ea (32-bit)/cpus=8,threads=1,free=77144896,total=182988800
   [junit4]   2> NOTE: All tests run in this JVM: [TestFaceting, TestSurroundQueryParser, HdfsUnloadDistributedZkTest, ResourceLoaderTest, EchoParamsTest, SolrCoreTest, ZkCLITest, ReturnFieldsTest, SchemaVersionSpecificBehaviorTest, WordBreakSolrSpellCheckerTest, TestReversedWildcardFilterFactory, CoreAdminHandlerTest, TestCollapseQParserPlugin, StatelessScriptUpdateProcessorFactoryTest, TestDocumentBuilder, TestRemoteStreaming, TestReplicationHandler, TestExtendedDismaxParser, SOLR749Test, CacheHeaderTest, TestBM25SimilarityFactory, MoreLikeThisHandlerTest, FieldMutatingUpdateProcessorTest, PolyFieldTest, CSVRequestHandlerTest, DistributedQueryElevationComponentTest, AnalysisAfterCoreReloadTest, TestTrie, UUIDFieldTest, AutoCommitTest, ClusterStateTest, TestRandomDVFaceting, TestPerFieldSimilarity, TestSystemIdResolver, TestQueryUtils, TestDocBasedVersionConstraints, HdfsRecoveryZkTest, DeleteReplicaTest, TestSolrDeletionPolicy1, CopyFieldTest, TestJoin, SystemInfoHandlerTest, HdfsChaosMonkeySafeLeaderTest, IndexSchemaTest, TestFunctionQuery, TestWriterPerf, SpatialFilterTest, ShowFileRequestHandlerTest, BinaryUpdateRequestHandlerTest, TestLuceneMatchVersion, CachingDirectoryFactoryTest, BJQParserTest, SampleTest, RegexBoostProcessorTest, TestFieldCollectionResource, AddBlockUpdateTest, SuggesterTest, ParsingFieldUpdateProcessorsTest, TestJmxMonitoredMap, SliceStateUpdateTest, TestSort, MBeansHandlerTest, SolrIndexSplitterTest, TestPseudoReturnFields, CircularListTest, DistributedTermsComponentTest, TestAddFieldRealTimeGet, FieldFacetTest, BadCopyFieldTest, BadComponentTest, URLClassifyProcessorTest, AssignTest, QueryElevationComponentTest, HdfsBasicDistributedZkTest, CoreAdminCreateDiscoverTest, TestCoreContainer, QueryEqualityTest, TestLMDirichletSimilarityFactory, TestStressVersions, DOMUtilTest, TestNoOpRegenerator, TestSolrIndexConfig, BasicDistributedZkTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, SyncSliceTest, OverseerTest, LeaderElectionIntegrationTest, RecoveryZkTest, TestZkChroot, TestRealTimeGet, TestStressReorder, SolrCmdDistributorTest, PeerSyncTest, BadIndexSchemaTest, TestFiltering, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, TestFoldingMultitermQuery, DocValuesTest, SuggesterTSTTest, TestStressLucene, TestCSVLoader, NoCacheHeaderTest, SolrCoreCheckLockOnStartupTest, TestUpdate, DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest, SolrInfoMBeanTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, DisMaxRequestHandlerTest, TestQueryTypes, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, DocumentBuilderTest, TestIndexingPerformance, TestSolrQueryParser, FastVectorHighlighterTest, LoggingHandlerTest, TestCollationField, UpdateRequestProcessorFactoryTest, QueryParsingTest, JsonLoaderTest, TestComponentsName, TestBinaryResponseWriter, HighlighterConfigTest, TestQuerySenderNoQuery, SolrIndexConfigTest, TestMergePolicyConfig, TestBinaryField, TestElisionMultitermQuery, TestConfig, ExternalFileFieldSortTest, TestPostingsSolrHighlighter, SpellPossibilityIteratorTest, TestCodecSupport, TestXIncludeConfig, TestNumberUtils, TestDefaultSimilarityFactory, LegacyHTMLStripCharFilterTest, ScriptEngineTest, DateMathParserTest, TestSuggestSpellingConverter, TestLRUCache, SliceStateTest, TestRTGBase, NoFacetTest]
   [junit4] Completed on J0 in 1.88s, 12 tests, 1 failure <<< FAILURES!

[...truncated 140 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:420: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:400: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:489: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1272: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:908: There were test failures: 349 suites, 1551 tests, 1 failure, 38 ignored (6 assumptions)

Total time: 54 minutes 12 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.8.0-ea-b114 -client -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure