lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.6.0_35) - Build # 757 - Failure!
Date Thu, 13 Sep 2012 19:30:05 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Windows/757/
Java: 64bit/jdk1.6.0_35 -XX:+UseParallelGC

4 tests failed.
REGRESSION:  org.apache.solr.search.TestRecovery.testCorruptLog

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

Stack Trace:
java.lang.AssertionError: expected:<0> but was:<1>
	at __randomizedtesting.SeedInfo.seed([44882BE7997A7A9F:B6559F3463422B43]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.search.TestRecovery.deleteLogs(TestRecovery.java:1046)
	at org.apache.solr.search.TestRecovery.testCorruptLog(TestRecovery.java:920)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	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:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	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:45)
	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:662)


REGRESSION:  org.apache.solr.search.TestRecovery.testTruncatedLog

Error Message:


Stack Trace:
java.lang.NullPointerException
	at __randomizedtesting.SeedInfo.seed([44882BE7997A7A9F:20B2D39F904307EC]:0)
	at org.apache.solr.util.TestHarness.getCore(TestHarness.java:212)
	at org.apache.solr.search.TestRecovery.testTruncatedLog(TestRecovery.java:822)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	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:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	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:45)
	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:662)


REGRESSION:  org.apache.solr.search.TestRecovery.testRemoveOldLogs

Error Message:
java.lang.NullPointerException

Stack Trace:
java.lang.RuntimeException: java.lang.NullPointerException
	at __randomizedtesting.SeedInfo.seed([44882BE7997A7A9F:6514EA4C5140F367]:0)
	at org.apache.solr.search.TestRecovery.clearIndex(TestRecovery.java:80)
	at org.apache.solr.search.TestRecovery.testRemoveOldLogs(TestRecovery.java:709)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	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:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	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:45)
	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:662)
Caused by: java.lang.NullPointerException
	at org.apache.solr.util.TestHarness.getCore(TestHarness.java:212)
	at org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:797)
	at org.apache.solr.SolrTestCaseJ4.deleteByQueryAndGetVersion(SolrTestCaseJ4.java:947)
	at org.apache.solr.search.TestRecovery.clearIndex(TestRecovery.java:78)
	... 41 more


REGRESSION:  org.apache.solr.search.TestRecovery.testVersionsOnRestart

Error Message:
java.lang.NullPointerException

Stack Trace:
java.lang.RuntimeException: java.lang.NullPointerException
	at __randomizedtesting.SeedInfo.seed([44882BE7997A7A9F:24260B99E624AA10]:0)
	at org.apache.solr.search.TestRecovery.clearIndex(TestRecovery.java:80)
	at org.apache.solr.search.TestRecovery.testVersionsOnRestart(TestRecovery.java:594)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	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:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	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:45)
	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:662)
Caused by: java.lang.NullPointerException
	at org.apache.solr.util.TestHarness.getCore(TestHarness.java:212)
	at org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:797)
	at org.apache.solr.SolrTestCaseJ4.deleteByQueryAndGetVersion(SolrTestCaseJ4.java:947)
	at org.apache.solr.search.TestRecovery.clearIndex(TestRecovery.java:78)
	... 41 more




Build Log:
[...truncated 7342 lines...]
[junit4:junit4] Suite: org.apache.solr.search.TestRecovery
[junit4:junit4]   2> 4 T3057 oas.SolrTestCaseJ4.initCore ####initCore
[junit4:junit4]   2> Creating dataDir: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172
[junit4:junit4]   2> 8 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 9 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 10 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 73 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 133 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 133 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 139 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 751 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 755 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 766 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 766 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 766 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 780 T3057 oasc.CoreContainer.<init> New CoreContainer 298793309
[junit4:junit4]   2> 781 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 781 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 781 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 782 T3057 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index' doesn't exist. Creating new index...
[junit4:junit4]   2> 782 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 791 T3057 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7d29c85f),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 791 T3057 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 793 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 793 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 793 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 793 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 797 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 806 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@6b74de61 main
[junit4:junit4]   2> 807 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 809 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 809 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 810 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 810 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 810 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 810 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 810 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 811 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 811 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 811 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 812 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 812 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 821 T3058 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b74de61 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 821 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 824 T3057 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4:junit4]   2> 826 T3057 oas.SolrTestCaseJ4.setUp ###Starting testRecoveryMultipleLogs
[junit4:junit4]   2> ASYNC  NEW_CORE C218 name=collection1 org.apache.solr.core.SolrCore@18c8f7e2
[junit4:junit4]   2> 835 T3057 C218 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 839 T3057 C218 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7d29c85f),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 839 T3057 C218 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 841 T3057 C218 oass.SolrIndexSearcher.<init> Opening Searcher@46b6d2eb realtime
[junit4:junit4]   2> 841 T3057 C218 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 842 T3057 C218 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=7 
[junit4:junit4]   2> 847 T3057 C218 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 850 T3057 C218 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7d29c85f),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7d29c85f),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 851 T3057 C218 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 853 T3057 C218 oass.SolrIndexSearcher.<init> Opening Searcher@2a777b5f main
[junit4:junit4]   2> 854 T3057 C218 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 855 T3058 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2a777b5f main{StandardDirectoryReader(segments_1:2:nrt)}
[junit4:junit4]   2> 854 T3057 C218 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 856 T3057 C218 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 10
[junit4:junit4]   2> 881 T3057 C218 UPDATE [collection1] webapp=null path=null params={} {add=[AAAAAA (1413023598164049920)]} 0 3
[junit4:junit4]   2> 889 T3057 C218 UPDATE [collection1] webapp=null path=null params={} {add=[BBBBBB (1413023598175584256)]} 0 0
[junit4:junit4]   2> 898 T3057 C218 UPDATE [collection1] webapp=null path=null params={} {add=[CCCCCC (1413023598185021440)]} 0 0
[junit4:junit4]   2> 901 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=298793309
[junit4:junit4]   2> 901 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@18c8f7e2
[junit4:junit4]   2> 902 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 903 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=3,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=1}
[junit4:junit4]   2> 903 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 909 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 913 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 915 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 916 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 979 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 1053 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 1053 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1059 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1679 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1682 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1693 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1693 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 1693 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 1706 T3057 oasc.CoreContainer.<init> New CoreContainer 1890127339
[junit4:junit4]   2> 1706 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 1706 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 1707 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 1710 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1710 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1711 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1711 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1714 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1717 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 1719 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@15bd3714 main
[junit4:junit4]   2> 1719 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1720 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1720 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1720 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 1721 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 1722 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 1722 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 1722 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 1723 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 1723 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 1723 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 1723 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 1723 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 1733 T3059 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15bd3714 main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 1733 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C219 name=collection1 org.apache.solr.core.SolrCore@591ad965
[junit4:junit4]   2> 1735 T3060 C219 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000001 refcount=2} active=false starting pos=0
[junit4:junit4]   2> 1742 T3060 C219 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c1eba43),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 1742 T3060 C219 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 1743 T3060 C219 oasc.SolrException.log Ignoring exception matching OutOfBoundsException
[junit4:junit4]   2> 1744 T3060 C219 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1751 T3060 C219 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c1eba43),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c1eba43),segFN=segments_3,generation=3,filenames=[_0.fnm, _0_Memory_0.ram, _0_SimpleText_0.pst, _0.fdx, _0.si, _0.fdt, segments_3]
[junit4:junit4]   2> 1751 T3060 C219 oasc.SolrDeletionPolicy.updateCommits newest commit = 3
[junit4:junit4]   2> 1759 T3060 C219 oass.SolrIndexSearcher.<init> Opening Searcher@115a52b4 main
[junit4:junit4]   2> 1759 T3060 C219 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1759 T3060 C219 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1760 T3059 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@115a52b4 main{StandardDirectoryReader(segments_3:4 _0(5.0):C3)}
[junit4:junit4]   2> 1760 T3060 C219 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000002 refcount=2} active=false starting pos=0
[junit4:junit4]   2> 1762 T3060 C219 oasc.SolrException.log Ignoring exception matching OutOfBoundsException
[junit4:junit4]   2> 1762 T3060 C219 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1770 T3060 C219 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c1eba43),segFN=segments_3,generation=3,filenames=[_0.fnm, _0_Memory_0.ram, _0_SimpleText_0.pst, _0.fdx, _0.si, _0.fdt, segments_3]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c1eba43),segFN=segments_4,generation=4,filenames=[_0.fnm, _0_Memory_0.ram, _1.fnm, _1.fdx, _1_Memory_0.ram, _1.fdt, _1.si, _0_SimpleText_0.pst, _0.fdx, _0.si, _0.fdt, segments_4, _1_SimpleText_0.pst]
[junit4:junit4]   2> 1770 T3060 C219 oasc.SolrDeletionPolicy.updateCommits newest commit = 4
[junit4:junit4]   2> 1779 T3060 C219 oass.SolrIndexSearcher.<init> Opening Searcher@6e8eac5 main
[junit4:junit4]   2> 1780 T3060 C219 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1780 T3060 C219 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1780 T3059 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6e8eac5 main{StandardDirectoryReader(segments_4:6 _0(5.0):C3 _1(5.0):C3)}
[junit4:junit4]   2> 1780 T3060 C219 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=6 deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4:junit4]   2> 1781 T3057 C219 REQ [collection1] webapp=null path=null params={q=*:*} hits=6 status=0 QTime=0 
[junit4:junit4]   2> 1781 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testRecoveryMultipleLogs
[junit4:junit4]   2> 1785 T3057 oas.SolrTestCaseJ4.setUp ###Starting testLogReplay
[junit4:junit4]   2> 1796 T3057 C219 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 1800 T3057 C219 oass.SolrIndexSearcher.<init> Opening Searcher@2b5e29d8 realtime
[junit4:junit4]   2> 1800 T3057 C219 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1800 T3057 C219 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=4 
[junit4:junit4]   2> 1804 T3057 C219 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1808 T3057 C219 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c1eba43),segFN=segments_4,generation=4,filenames=[_0.fnm, _0_Memory_0.ram, _1.fnm, _1.fdx, _1_Memory_0.ram, _1.fdt, _1.si, _0_SimpleText_0.pst, _0.fdx, _0.si, _0.fdt, segments_4, _1_SimpleText_0.pst]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7c1eba43),segFN=segments_5,generation=5,filenames=[segments_5]
[junit4:junit4]   2> 1808 T3057 C219 oasc.SolrDeletionPolicy.updateCommits newest commit = 5
[junit4:junit4]   2> 1816 T3057 C219 oass.SolrIndexSearcher.<init> Opening Searcher@4f2d8623 main
[junit4:junit4]   2> 1816 T3057 C219 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1818 T3059 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f2d8623 main{StandardDirectoryReader(segments_4:7:nrt)}
[junit4:junit4]   2> 1816 T3057 C219 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1819 T3057 C219 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 15
[junit4:junit4]   2> 1841 T3057 C219 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {add=[A1 (1413023599171731456)]} 0 3
[junit4:junit4]   2> 1847 T3057 C219 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {add=[A11 (1413023599180120064)]} 0 0
[junit4:junit4]   2> 1851 T3057 C219 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {add=[A12 (1413023599184314368)]} 0 0
[junit4:junit4]   2> 1869 T3057 C219 oass.SolrIndexSearcher.<init> Opening Searcher@1c16a37b realtime
[junit4:junit4]   2> 1870 T3057 C219 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1870 T3057 C219 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {deleteByQuery=id:A11 (-1413023599190605824)} 0 13
[junit4:junit4]   2> 1881 T3057 C219 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {add=[A13 (1413023599214723072)]} 0 1
[junit4:junit4]   2> 1882 T3057 C219 REQ [collection1] webapp=null path=null params={q=*:*} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1882 T3057 C219 REQ [collection1] webapp=null path=null params={getVersions=5&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 1883 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1890127339
[junit4:junit4]   2> 1883 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@591ad965
[junit4:junit4]   2> 1883 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 1884 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=4,adds=4,deletesById=0,deletesByQuery=1,errors=1,cumulative_adds=10,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=1}
[junit4:junit4]   2> 1884 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 1895 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 1897 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 1899 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1900 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 1960 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 2020 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 2020 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2026 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2627 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2631 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2641 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2641 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 2642 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 2654 T3057 oasc.CoreContainer.<init> New CoreContainer 1558591786
[junit4:junit4]   2> 2654 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 2655 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 2655 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 2659 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2659 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2659 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2659 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2661 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2665 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 2666 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@26fb33d main
[junit4:junit4]   2> 2666 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 2670 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2670 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2670 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2671 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2671 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2672 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2672 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2672 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2672 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2672 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2672 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2673 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2683 T3061 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@26fb33d main{StandardDirectoryReader(segments_5:7)}
[junit4:junit4]   2> 2683 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C220 name=collection1 org.apache.solr.core.SolrCore@59ebd4ef
[junit4:junit4]   2> 2684 T3062 C220 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000006 refcount=2} active=false starting pos=0
[junit4:junit4]   2> 2685 T3057 C220 REQ [collection1] webapp=null path=null params={q=*:*} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 2685 T3057 C220 REQ [collection1] webapp=null path=null params={getVersions=5&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 2685 T3057 C220 REQ [collection1] webapp=null path=null params={getVersions=5&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 2690 T3062 C220 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3500623),segFN=segments_5,generation=5,filenames=[segments_5]
[junit4:junit4]   2> 2690 T3062 C220 oasc.SolrDeletionPolicy.updateCommits newest commit = 5
[junit4:junit4]   2> 2690 T3062 C220 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=10,_version_=1413023599171731456,id=A1} DBQs=[DBQ{version=1413023599190605824,q=id:A11}]
[junit4:junit4]   2> 2696 T3062 C220 oass.SolrIndexSearcher.<init> Opening Searcher@150e7312 realtime
[junit4:junit4]   2> 2696 T3062 C220 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 2696 T3062 C220 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=10,_version_=1413023599180120064,id=A11} DBQs=[DBQ{version=1413023599190605824,q=id:A11}]
[junit4:junit4]   2> 2706 T3062 C220 oass.SolrIndexSearcher.<init> Opening Searcher@6a3d10f realtime
[junit4:junit4]   2> 2706 T3062 C220 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 2706 T3062 C220 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=10,_version_=1413023599184314368,id=A12} DBQs=[DBQ{version=1413023599190605824,q=id:A11}]
[junit4:junit4]   2> 2715 T3062 C220 oass.SolrIndexSearcher.<init> Opening Searcher@53c6c6e2 realtime
[junit4:junit4]   2> 2715 T3062 C220 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 2719 T3062 C220 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 2745 T3062 C220 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3500623),segFN=segments_5,generation=5,filenames=[segments_5]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3500623),segFN=segments_6,generation=6,filenames=[_2.si, _5_Memory_0.ram, _5.fdt, _5.fnm, _2_SimpleText_0.pst, _2.fdt, _4.fnm, _4.fdt, _4.si, _2.fdx, _2.fnm, _5.si, _4.fdx, _4_SimpleText_0.pst, _4_Memory_0.ram, _5.fdx, _2_Memory_0.ram, segments_6, _5_SimpleText_0.pst]
[junit4:junit4]   2> 2747 T3062 C220 oasc.SolrDeletionPolicy.updateCommits newest commit = 6
[junit4:junit4]   2> 2750 T3062 C220 oass.SolrIndexSearcher.<init> Opening Searcher@914da00 main
[junit4:junit4]   2> 2750 T3062 C220 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 2751 T3062 C220 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 2751 T3061 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@914da00 main{StandardDirectoryReader(segments_6:17:nrt _2(5.0):C1 _4(5.0):C1 _5(5.0):C1)}
[junit4:junit4]   2> 2751 T3062 C220 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=4 deletes=0 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4:junit4]   2> 2752 T3057 C220 REQ [collection1] webapp=null path=null params={q=*:*} hits=3 status=0 QTime=0 
[junit4:junit4]   2> 2752 T3057 C220 REQ [collection1] webapp=null path=null params={getVersions=5&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 2762 T3057 C220 UPDATE [collection1] webapp=null path=null params={} {add=[A2 (1413023600136421376)]} 0 3
[junit4:junit4]   2> 2780 T3057 C220 UPDATE [collection1] webapp=null path=null params={} {add=[A3 (1413023600158441472)]} 0 0
[junit4:junit4]   2> 2787 T3057 C220 UPDATE [collection1] webapp=null path=null params={} {delete=[A2 (-1413023600163684352)]} 0 2
[junit4:junit4]   2> 2792 T3057 C220 UPDATE [collection1] webapp=null path=null params={} {add=[A4 (1413023600171024384)]} 0 1
[junit4:junit4]   2> 2794 T3057 C220 REQ [collection1] webapp=null path=null params={q=*:*} hits=3 status=0 QTime=0 
[junit4:junit4]   2> 2795 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1558591786
[junit4:junit4]   2> 2795 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@59ebd4ef
[junit4:junit4]   2> 2797 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 2797 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=3,deletesById=1,deletesByQuery=0,errors=0,cumulative_adds=7,cumulative_deletesById=1,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4:junit4]   2> 2797 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 2818 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 2818 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 2820 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2821 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 2879 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 2936 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 2937 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2941 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3530 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3534 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3544 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3545 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 3545 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 3558 T3057 oasc.CoreContainer.<init> New CoreContainer 960608367
[junit4:junit4]   2> 3558 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 3559 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 3559 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 3561 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3562 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 3562 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3562 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 3564 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3569 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 3574 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@361cd0c5 main
[junit4:junit4]   2> 3574 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 3578 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3579 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3579 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3579 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3579 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3579 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3579 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3580 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3580 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3580 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3581 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3581 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3591 T3063 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@361cd0c5 main{StandardDirectoryReader(segments_6:17 _2(5.0):C1 _4(5.0):C1 _5(5.0):C1)}
[junit4:junit4]   2> 3591 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C221 name=collection1 org.apache.solr.core.SolrCore@77bf8259
[junit4:junit4]   2> 3592 T3064 C221 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000008 refcount=2} active=false starting pos=0
[junit4:junit4]   2> 3600 T3064 C221 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@67ffbd00),segFN=segments_6,generation=6,filenames=[_2.si, _5_Memory_0.ram, _5.fnm, _5.fdt, _2_SimpleText_0.pst, _2.fdt, _4.fnm, _4.si, _4.fdt, _2.fdx, _2.fnm, _5.si, _4.fdx, _4_SimpleText_0.pst, _4_Memory_0.ram, _5.fdx, _2_Memory_0.ram, segments_6, _5_SimpleText_0.pst]
[junit4:junit4]   2> 3600 T3064 C221 oasc.SolrDeletionPolicy.updateCommits newest commit = 6
[junit4:junit4]   2> 3601 T3064 C221 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 3612 T3064 C221 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@67ffbd00),segFN=segments_6,generation=6,filenames=[_2.si, _5_Memory_0.ram, _5.fnm, _5.fdt, _2_SimpleText_0.pst, _2.fdt, _4.fnm, _4.si, _4.fdt, _2.fdx, _2.fnm, _5.si, _4.fdx, _4_SimpleText_0.pst, _4_Memory_0.ram, _5.fdx, _2_Memory_0.ram, segments_6, _5_SimpleText_0.pst]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@67ffbd00),segFN=segments_7,generation=7,filenames=[_2.si, _6_Memory_0.ram, _5_Memory_0.ram, _5.fdt, _2_SimpleText_0.pst, _6.fdx, _4.fnm, _4.fdx, _2_Memory_0.ram, _5_SimpleText_0.pst, _5.fnm, _2.fdt, _4.fdt, _4.si, _6_SimpleText_0.pst, _2.fdx, _2.fnm, _5.si, _4_SimpleText_0.pst, segments_7, _4_Memory_0.ram, _5.fdx, _6.fnm, _6.si, _6.fdt]
[junit4:junit4]   2> 3613 T3064 C221 oasc.SolrDeletionPolicy.updateCommits newest commit = 7
[junit4:junit4]   2> 3623 T3064 C221 oass.SolrIndexSearcher.<init> Opening Searcher@22809d4 main
[junit4:junit4]   2> 3623 T3064 C221 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 3624 T3064 C221 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 3624 T3063 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@22809d4 main{StandardDirectoryReader(segments_7:19 _2(5.0):C1 _4(5.0):C1 _5(5.0):C1 _6(5.0):C2)}
[junit4:junit4]   2> 3624 T3064 C221 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=3 deletes=1 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4:junit4]   2> 3624 T3057 C221 REQ [collection1] webapp=null path=null params={q=*:*} hits=5 status=0 QTime=0 
[junit4:junit4]   2> 3625 T3057 C221 REQ [collection1] webapp=null path=null params={q=id:A2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3627 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=960608367
[junit4:junit4]   2> 3627 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@77bf8259
[junit4:junit4]   2> 3627 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 3627 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 3629 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 3648 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 3649 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 3651 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 3651 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 3713 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 3772 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 3772 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3779 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4436 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 4442 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4453 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 4453 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 4453 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 4468 T3057 oasc.CoreContainer.<init> New CoreContainer 1039737741
[junit4:junit4]   2> 4468 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 4468 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 4471 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 4473 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4473 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 4474 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4474 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 4478 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4482 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 4491 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@6d3a17b7 main
[junit4:junit4]   2> 4491 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 4493 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4494 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4495 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 4495 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 4495 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 4496 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 4496 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 4498 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 4498 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 4498 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 4498 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 4498 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 4510 T3065 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d3a17b7 main{StandardDirectoryReader(segments_7:19 _2(5.0):C1 _4(5.0):C1 _5(5.0):C1 _6(5.0):C2)}
[junit4:junit4]   2> 4510 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C222 name=collection1 org.apache.solr.core.SolrCore@6b2bf631
[junit4:junit4]   2> 4512 T3057 C222 REQ [collection1] webapp=null path=null params={q=*:*} hits=5 status=0 QTime=0 
[junit4:junit4]   2> 4627 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testLogReplay
[junit4:junit4]   2> 4636 T3057 oas.SolrTestCaseJ4.setUp ###Starting testCleanShutdown
[junit4:junit4]   2> 4648 T3057 C222 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 4656 T3057 C222 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@6e5be0a1),segFN=segments_7,generation=7,filenames=[_2.si, _6_Memory_0.ram, _5_Memory_0.ram, _5.fdt, _2_SimpleText_0.pst, _6.fdx, _4.fnm, _4.fdx, _2_Memory_0.ram, _5_SimpleText_0.pst, _5.fnm, _2.fdt, _4.fdt, _4.si, _6_SimpleText_0.pst, _2.fdx, _2.fnm, _5.si, _4_SimpleText_0.pst, segments_7, _4_Memory_0.ram, _5.fdx, _6.si, _6.fnm, _6.fdt]
[junit4:junit4]   2> 4656 T3057 C222 oasc.SolrDeletionPolicy.updateCommits newest commit = 7
[junit4:junit4]   2> 4659 T3057 C222 oass.SolrIndexSearcher.<init> Opening Searcher@1a7d2212 realtime
[junit4:junit4]   2> 4659 T3057 C222 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 4659 T3057 C222 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=11 
[junit4:junit4]   2> 4662 T3057 C222 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 4666 T3057 C222 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@6e5be0a1),segFN=segments_7,generation=7,filenames=[_2.si, _6_Memory_0.ram, _5_Memory_0.ram, _5.fdt, _2_SimpleText_0.pst, _6.fdx, _4.fnm, _4.fdx, _2_Memory_0.ram, _5_SimpleText_0.pst, _5.fnm, _2.fdt, _4.fdt, _4.si, _6_SimpleText_0.pst, _2.fdx, _2.fnm, _5.si, _4_SimpleText_0.pst, segments_7, _4_Memory_0.ram, _5.fdx, _6.si, _6.fnm, _6.fdt]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@6e5be0a1),segFN=segments_8,generation=8,filenames=[segments_8]
[junit4:junit4]   2> 4666 T3057 C222 oasc.SolrDeletionPolicy.updateCommits newest commit = 8
[junit4:junit4]   2> 4679 T3057 C222 oass.SolrIndexSearcher.<init> Opening Searcher@6d0099da main
[junit4:junit4]   2> 4679 T3057 C222 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 4679 T3065 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d0099da main{StandardDirectoryReader(segments_7:20:nrt)}
[junit4:junit4]   2> 4679 T3057 C222 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 4681 T3057 C222 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 19
[junit4:junit4]   2> 4700 T3057 C222 UPDATE [collection1] webapp=null path=null params={} {add=[E1 (1413023602169610240)]} 0 2
[junit4:junit4]   2> 4706 T3057 C222 UPDATE [collection1] webapp=null path=null params={} {add=[E2 (1413023602177998848)]} 0 0
[junit4:junit4]   2> 4708 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1039737741
[junit4:junit4]   2> 4708 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6b2bf631
[junit4:junit4]   2> 4709 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 4717 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=2,adds=2,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=1}
[junit4:junit4]   2> 4717 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 4725 T3057 C222 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@6e5be0a1),segFN=segments_8,generation=8,filenames=[segments_8]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@6e5be0a1),segFN=segments_9,generation=9,filenames=[segments_9, _7_SimpleText_0.pst, _7.fnm, _7.si, _7.fdx, _7.fdt, _7_Memory_0.ram]
[junit4:junit4]   2> 4725 T3057 C222 oasc.SolrDeletionPolicy.updateCommits newest commit = 9
[junit4:junit4]   2> 4733 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 4733 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 4736 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 4737 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 4794 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 4849 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 4850 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 4855 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 5433 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 5437 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5448 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5448 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 5449 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 5461 T3057 oasc.CoreContainer.<init> New CoreContainer 2062630658
[junit4:junit4]   2> 5461 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 5463 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 5464 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 5465 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 5466 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 5466 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5466 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 5470 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5474 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 5477 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@8544fc main
[junit4:junit4]   2> 5477 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5480 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 5480 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 5481 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5481 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5481 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5482 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5482 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5484 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5484 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5484 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5485 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5485 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 5495 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8544fc main{StandardDirectoryReader(segments_9:22 _7(5.0):C2)}
[junit4:junit4]   2> 5495 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C223 name=collection1 org.apache.solr.core.SolrCore@131640b3
[junit4:junit4]   2> 5496 T3057 C223 REQ [collection1] webapp=null path=null params={q=*:*} hits=2 status=0 QTime=0 
[junit4:junit4]   2> 5497 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testCleanShutdown
[junit4:junit4]   2> 5502 T3057 oas.SolrTestCaseJ4.setUp ###Starting testBuffering
[junit4:junit4]   2> 5509 T3057 C223 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 5514 T3057 C223 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_9,generation=9,filenames=[segments_9, _7.fnm, _7_SimpleText_0.pst, _7.si, _7.fdx, _7.fdt, _7_Memory_0.ram]
[junit4:junit4]   2> 5514 T3057 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 9
[junit4:junit4]   2> 5515 T3057 C223 oass.SolrIndexSearcher.<init> Opening Searcher@4f7db349 realtime
[junit4:junit4]   2> 5517 T3057 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5517 T3057 C223 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=9 
[junit4:junit4]   2> 5521 T3057 C223 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5524 T3057 C223 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_9,generation=9,filenames=[segments_9, _7.fnm, _7_SimpleText_0.pst, _7.si, _7.fdx, _7.fdt, _7_Memory_0.ram]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_a,generation=10,filenames=[segments_a]
[junit4:junit4]   2> 5524 T3057 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 10
[junit4:junit4]   2> 5530 T3057 C223 oass.SolrIndexSearcher.<init> Opening Searcher@60193a84 main
[junit4:junit4]   2> 5530 T3057 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5531 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@60193a84 main{StandardDirectoryReader(segments_9:23:nrt)}
[junit4:junit4]   2> 5531 T3057 C223 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5532 T3057 C223 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 11
[junit4:junit4]   2> 5542 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 5542 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 5552 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 
[junit4:junit4]   2> 5556 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5561 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-1017&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5567 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5572 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=2 
[junit4:junit4]   2> 5577 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-2010&versions=true&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5578 T3057 C223 REQ [collection1] webapp=null path=null params={getVersions=6&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 5583 T3057 C223 oasup.DistributedUpdateProcessor.processCommit Ignoring commit while not ACTIVE - state: BUFFERING replay:0
[junit4:junit4]   2> 5583 T3057 C223 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 0
[junit4:junit4]   2> 5585 T3057 C223 REQ [collection1] webapp=null path=null params={getVersions=6&qt=/get} status=0 QTime=1 
[junit4:junit4]   2> 5585 T3057 C223 REQ [collection1] webapp=null path=null params={q=*:*} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 5585 T3057 C223 REQ [collection1] webapp=null path=null params={id=B3&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 5588 T3067 C223 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000012 refcount=2} active=true starting pos=0
[junit4:junit4]   2> 5606 T3067 C223 oass.SolrIndexSearcher.<init> Opening Searcher@f27a351 realtime
[junit4:junit4]   2> 5606 T3067 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5608 T3067 C223 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5616 T3067 C223 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_a,generation=10,filenames=[segments_a]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_b,generation=11,filenames=[segments_b, _9_Memory_0.ram, _9.fnm, _9.fdt, _9.si, _9.fdx, _9_SimpleText_0.pst]
[junit4:junit4]   2> 5617 T3067 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 11
[junit4:junit4]   2> 5621 T3067 C223 oass.SolrIndexSearcher.<init> Opening Searcher@26633ba5 main
[junit4:junit4]   2> 5621 T3067 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5622 T3067 C223 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5622 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@26633ba5 main{StandardDirectoryReader(segments_b:29:nrt _9(5.0):C2)}
[junit4:junit4]   2> 5622 T3067 C223 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=4 deletes=1 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4:junit4]   2> 5623 T3057 C223 REQ [collection1] webapp=null path=null params={getVersions=6&qt=/get} status=0 QTime=1 
[junit4:junit4]   2> 5623 T3057 C223 REQ [collection1] webapp=null path=null params={q=*:*} hits=2 status=0 QTime=0 
[junit4:junit4]   2> 5623 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 5623 T3057 C223 REQ [collection1] webapp=null path=null params={id=B3&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 5636 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=2 
[junit4:junit4]   2> 5641 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5646 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-940&versions=true&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5651 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5656 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5662 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5667 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-3000&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5668 T3057 C223 REQ [collection1] webapp=null path=null params={getVersions=13&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 5670 T3067 C223 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000013 refcount=2} active=true starting pos=0
[junit4:junit4]   2> 5673 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5678 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-950&versions=true&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5684 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-2060&versions=true&wt=json&indent=true} status=0 QTime=1 
[junit4:junit4]   2> 5693 T3067 C223 oass.SolrIndexSearcher.<init> Opening Searcher@1bf595ed realtime
[junit4:junit4]   2> 5693 T3067 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5693 T3067 C223 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=10,_version_=1070,id=B7} DBQs=[DBQ{version=3000,q=id:B2 OR id:B8}]
[junit4:junit4]   2> 5699 T3067 C223 oass.SolrIndexSearcher.<init> Opening Searcher@4be33b72 realtime
[junit4:junit4]   2> 5699 T3067 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5699 T3067 C223 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5704 T3067 C223 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_b,generation=11,filenames=[segments_b, _9_Memory_0.ram, _9.fnm, _9.fdt, _9.si, _9.fdx, _9_SimpleText_0.pst]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_c,generation=12,filenames=[segments_c, _a_SimpleText_0.pst, _b_SimpleText_0.pst, _9.fnm, _9_Memory_0.ram, _a_1.del, _a_Memory_0.ram, _9.fdt, _a.fdt, _a.si, _9.fdx, _a.fdx, _9_SimpleText_0.pst, _b.si, _b_Memory_0.ram, _9_1.del, _b.fnm, _b.fdt, _9.si, _b.fdx, _a.fnm]
[junit4:junit4]   2> 5705 T3067 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 12
[junit4:junit4]   2> 5707 T3067 C223 oass.SolrIndexSearcher.<init> Opening Searcher@6b7f5689 main
[junit4:junit4]   2> 5707 T3067 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5709 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b7f5689 main{StandardDirectoryReader(segments_c:35:nrt _9(5.0):C2/1 _a(5.0):C4/2 _b(5.0):C1)}
[junit4:junit4]   2> 5709 T3067 C223 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5709 T3067 C223 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=6 deletes=3 deleteByQuery=1 errors=0 positionOfStart=0}
[junit4:junit4]   2> 5709 T3057 C223 REQ [collection1] webapp=null path=null params={fl=id,_version_&sort=id+asc&q=*:*} hits=4 status=0 QTime=0 
[junit4:junit4]   2> 5709 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testBuffering
[junit4:junit4]   2> 5716 T3057 oas.SolrTestCaseJ4.setUp ###Starting testDropBuffered
[junit4:junit4]   2> 5739 T3057 C223 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 5744 T3057 C223 oass.SolrIndexSearcher.<init> Opening Searcher@614195f6 realtime
[junit4:junit4]   2> 5744 T3057 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5745 T3057 C223 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=6 
[junit4:junit4]   2> 5753 T3057 C223 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5755 T3057 C223 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_c,generation=12,filenames=[segments_c, _a_SimpleText_0.pst, _b_SimpleText_0.pst, _9.fnm, _9_Memory_0.ram, _a_1.del, _a_Memory_0.ram, _9.fdt, _a.fdt, _a.si, _9.fdx, _a.fdx, _9_SimpleText_0.pst, _b.si, _b_Memory_0.ram, _9_1.del, _b.fnm, _b.fdt, _9.si, _b.fdx, _a.fnm]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_d,generation=13,filenames=[segments_d]
[junit4:junit4]   2> 5755 T3057 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 13
[junit4:junit4]   2> 5772 T3057 C223 oass.SolrIndexSearcher.<init> Opening Searcher@77536a4b main
[junit4:junit4]   2> 5772 T3057 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5775 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@77536a4b main{StandardDirectoryReader(segments_c:36:nrt)}
[junit4:junit4]   2> 5774 T3057 C223 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5782 T3057 C223 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 29
[junit4:junit4]   2> 5788 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 5789 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 5803 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=3 
[junit4:junit4]   2> 5811 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5816 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5818 T3057 oasu.UpdateLog.dropBufferedUpdates Dropping buffered updates FSUpdateLog{state=BUFFERING, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000015 refcount=1}}
[junit4:junit4]   2> 5818 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000015 refcount=1}}
[junit4:junit4]   2> 5824 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5830 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5830 T3067 C223 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000015 refcount=2} active=true starting pos=0
[junit4:junit4]   2> 5833 T3067 C223 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5842 T3067 C223 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_d,generation=13,filenames=[segments_d]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_e,generation=14,filenames=[_c.fdt, _c_SimpleText_0.pst, segments_e, _c.si, _c.fnm, _c.fdx, _c_Memory_0.ram]
[junit4:junit4]   2> 5842 T3067 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 14
[junit4:junit4]   2> 5847 T3067 C223 oass.SolrIndexSearcher.<init> Opening Searcher@258c65e2 main
[junit4:junit4]   2> 5847 T3067 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5847 T3067 C223 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5847 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@258c65e2 main{StandardDirectoryReader(segments_e:38:nrt _c(5.0):C2)}
[junit4:junit4]   2> 5848 T3067 C223 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=2 deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4:junit4]   2> 5848 T3057 C223 REQ [collection1] webapp=null path=null params={getVersions=2&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 5867 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=3 
[junit4:junit4]   2> 5873 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5874 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000016 refcount=1}}
[junit4:junit4]   2> 5880 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5886 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5886 T3057 oasu.UpdateLog.dropBufferedUpdates Dropping buffered updates FSUpdateLog{state=BUFFERING, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000016 refcount=1}}
[junit4:junit4]   2> 5886 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000016 refcount=1}}
[junit4:junit4]   2> 5892 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5897 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5898 T3067 C223 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000016 refcount=2} active=true starting pos=92
[junit4:junit4]   2> 5900 T3067 C223 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5911 T3067 C223 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_e,generation=14,filenames=[_c.fdt, _c_SimpleText_0.pst, segments_e, _c.si, _c.fnm, _c.fdx, _c_Memory_0.ram]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_f,generation=15,filenames=[_c_SimpleText_0.pst, segments_f, _d_Memory_0.ram, _d.fnm, _c_Memory_0.ram, _c.fdx, _d.fdx, _c.fdt, _c.si, _d_SimpleText_0.pst, _d.fdt, _d.si, _c.fnm]
[junit4:junit4]   2> 5911 T3067 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 15
[junit4:junit4]   2> 5917 T3067 C223 oass.SolrIndexSearcher.<init> Opening Searcher@786299dc main
[junit4:junit4]   2> 5917 T3067 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5917 T3067 C223 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5917 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@786299dc main{StandardDirectoryReader(segments_f:40:nrt _c(5.0):C2 _d(5.0):C4)}
[junit4:junit4]   2> 5918 T3067 C223 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=2 deletes=0 deleteByQuery=0 errors=0 positionOfStart=92}
[junit4:junit4]   2> 5919 T3057 C223 REQ [collection1] webapp=null path=null params={fl=id,_version_&sort=_version_+asc&q=*:*} hits=6 status=0 QTime=1 
[junit4:junit4]   2> 5919 T3057 C223 REQ [collection1] webapp=null path=null params={getVersions=6&qt=/get} status=0 QTime=0 
[junit4:junit4]   2> 5920 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 5934 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 
[junit4:junit4]   2> 5940 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5941 T3057 oasu.UpdateLog.dropBufferedUpdates Dropping buffered updates FSUpdateLog{state=BUFFERING, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000017 refcount=1}}
[junit4:junit4]   2> 5950 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=3 
[junit4:junit4]   2> 5956 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 5962 T3057 C223 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5972 T3057 C223 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_f,generation=15,filenames=[_c_SimpleText_0.pst, segments_f, _d_Memory_0.ram, _d.fnm, _c_Memory_0.ram, _c.fdx, _d.fdx, _c.fdt, _c.si, _d_SimpleText_0.pst, _d.fdt, _d.si, _c.fnm]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_g,generation=16,filenames=[_c_SimpleText_0.pst, _d_Memory_0.ram, _d.fnm, _e.fdx, _c_Memory_0.ram, _c.fdx, segments_g, _d.fdx, _c.fdt, _e_SimpleText_0.pst, _c.si, _d_SimpleText_0.pst, _d.fdt, _e.si, _e.fdt, _e_Memory_0.ram, _d.si, _c.fnm, _e.fnm]
[junit4:junit4]   2> 5972 T3057 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 16
[junit4:junit4]   2> 5978 T3057 C223 oass.SolrIndexSearcher.<init> Opening Searcher@661c65a5 main
[junit4:junit4]   2> 5979 T3057 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5979 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@661c65a5 main{StandardDirectoryReader(segments_g:42:nrt _c(5.0):C2 _d(5.0):C4 _e(5.0):C2)}
[junit4:junit4]   2> 5979 T3057 C223 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5980 T3057 C223 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 18
[junit4:junit4]   2> 5990 T3057 C223 REQ [collection1] webapp=null path=null params={getVersions=2&qt=/get} status=0 QTime=1 
[junit4:junit4]   2> 5991 T3057 C223 REQ [collection1] webapp=null path=null params={fl=id,_version_&sort=_version_+desc&q=*:*&rows=2} hits=8 status=0 QTime=1 
[junit4:junit4]   2> 6002 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=2 
[junit4:junit4]   2> 6002 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testDropBuffered
[junit4:junit4]   2> 6008 T3057 oas.SolrTestCaseJ4.setUp ###Starting testBufferingFlags
[junit4:junit4]   2> 6015 T3057 C223 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 6022 T3057 C223 oass.SolrIndexSearcher.<init> Opening Searcher@2a3efb56 realtime
[junit4:junit4]   2> 6022 T3057 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 6023 T3057 C223 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=8 
[junit4:junit4]   2> 6031 T3057 C223 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 6037 T3057 C223 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_g,generation=16,filenames=[_c_SimpleText_0.pst, _d_Memory_0.ram, _d.fnm, _e.fdx, _c_Memory_0.ram, _c.fdx, segments_g, _d.fdx, _c.fdt, _e_SimpleText_0.pst, _c.si, _d_SimpleText_0.pst, _d.fdt, _e.si, _e.fdt, _e_Memory_0.ram, _d.si, _c.fnm, _e.fnm]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f9b4667),segFN=segments_h,generation=17,filenames=[segments_h]
[junit4:junit4]   2> 6038 T3057 C223 oasc.SolrDeletionPolicy.updateCommits newest commit = 17
[junit4:junit4]   2> 6049 T3057 C223 oass.SolrIndexSearcher.<init> Opening Searcher@254b8f12 main
[junit4:junit4]   2> 6050 T3057 C223 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 6053 T3066 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@254b8f12 main{StandardDirectoryReader(segments_g:44:nrt)}
[junit4:junit4]   2> 6054 T3057 C223 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 6065 T3057 C223 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 34
[junit4:junit4]   2> 6072 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> 6090 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 
[junit4:junit4]   2> 6097 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 6103 T3057 C223 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 
[junit4:junit4]   2> 6103 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=2062630658
[junit4:junit4]   2> 6103 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@131640b3
[junit4:junit4]   2> 6104 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 6104 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=8,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=3,cumulative_adds=18,cumulative_deletesById=2,cumulative_deletesByQuery=5,cumulative_errors=3}
[junit4:junit4]   2> 6104 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 6111 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 6111 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 6115 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 6116 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 6180 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 6243 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 6245 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 6252 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 6976 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 6981 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 6990 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 6990 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 6990 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 7006 T3057 oasc.CoreContainer.<init> New CoreContainer 464904582
[junit4:junit4]   2> 7007 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 7007 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 7008 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 7011 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 7012 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 7012 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 7012 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 7016 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 7019 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 7022 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@2b8bf709 main
[junit4:junit4]   2> 7022 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 7027 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 7027 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 7028 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 7028 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 7028 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 7028 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 7029 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 7029 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 7029 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 7029 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 7029 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 7030 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 7040 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C224 name=collection1 org.apache.solr.core.SolrCore@7a4149e1
[junit4:junit4]   2> 7041 T3069 C224 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000019 refcount=2} active=false starting pos=0
[junit4:junit4]   2> 7045 T3068 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2b8bf709 main{StandardDirectoryReader(segments_h:44)}
[junit4:junit4]   2> 7050 T3069 C224 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17a3d63b),segFN=segments_h,generation=17,filenames=[segments_h]
[junit4:junit4]   2> 7050 T3069 C224 oasc.SolrDeletionPolicy.updateCommits newest commit = 17
[junit4:junit4]   2> 7050 T3069 C224 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=10,_version_=101,id=Q1} DBQs=[DBQ{version=1413023599190605824,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 7057 T3069 C224 oass.SolrIndexSearcher.<init> Opening Searcher@fe7827c realtime
[junit4:junit4]   2> 7057 T3069 C224 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 7057 T3069 C224 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=10,_version_=102,id=Q2} DBQs=[DBQ{version=1413023599190605824,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 7063 T3069 C224 oass.SolrIndexSearcher.<init> Opening Searcher@48b07e1a realtime
[junit4:junit4]   2> 7063 T3069 C224 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 7063 T3069 C224 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=10,_version_=103,id=Q3} DBQs=[DBQ{version=1413023599190605824,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 7071 T3069 C224 oass.SolrIndexSearcher.<init> Opening Searcher@45e43a25 realtime
[junit4:junit4]   2> 7071 T3069 C224 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 7071 T3069 C224 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 7076 T3069 C224 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17a3d63b),segFN=segments_h,generation=17,filenames=[segments_h]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17a3d63b),segFN=segments_i,generation=18,filenames=[_g.fdt, _g.si, _h.fnm, _g_Memory_0.ram, _g.fdx, _h_Memory_0.ram, _h_SimpleText_0.pst, _i_SimpleText_0.pst, _i_Memory_0.ram, segments_i, _i.si, _g.fnm, _h.fdt, _h.fdx, _h.si, _i.fdx, _g_SimpleText_0.pst, _i.fnm, _i.fdt]
[junit4:junit4]   2> 7076 T3069 C224 oasc.SolrDeletionPolicy.updateCommits newest commit = 18
[junit4:junit4]   2> 7077 T3069 C224 oass.SolrIndexSearcher.<init> Opening Searcher@48628bc9 main
[junit4:junit4]   2> 7078 T3069 C224 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 7078 T3069 C224 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 7079 T3068 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@48628bc9 main{StandardDirectoryReader(segments_h:50:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1)}
[junit4:junit4]   2> 7079 T3069 C224 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=3 deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4:junit4]   2> 7079 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=464904582
[junit4:junit4]   2> 7080 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7a4149e1
[junit4:junit4]   2> 7080 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 7080 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 7082 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 7105 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 7105 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 7107 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 7110 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 7180 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 7246 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 7247 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 7253 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 7928 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 7933 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 7944 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 7946 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 7946 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 7960 T3057 oasc.CoreContainer.<init> New CoreContainer 490700092
[junit4:junit4]   2> 7960 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 7960 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 7964 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 7965 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 7965 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 7966 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 7966 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 7969 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 7974 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 7980 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@22a94d4f main
[junit4:junit4]   2> 7980 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 7986 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 7986 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 7986 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 7987 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 7987 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 7987 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 7987 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 7988 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 7988 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 7988 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 7988 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 7990 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 7999 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C225 name=collection1 org.apache.solr.core.SolrCore@501de29
[junit4:junit4]   2> 8013 T3057 C225 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2bc016e),segFN=segments_i,generation=18,filenames=[_g.fdt, _g.si, _h.fnm, _g.fdx, _g_Memory_0.ram, _h_SimpleText_0.pst, _h_Memory_0.ram, _i_Memory_0.ram, _i_SimpleText_0.pst, segments_i, _i.si, _g.fnm, _h.fdt, _h.si, _h.fdx, _i.fdx, _g_SimpleText_0.pst, _i.fnm, _i.fdt]
[junit4:junit4]   2> 8013 T3057 C225 oasc.SolrDeletionPolicy.updateCommits newest commit = 18
[junit4:junit4]   2> 8014 T3057 C225 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=0,_version_=114,id=Q4} DBQs=[DBQ{version=1413023599190605824,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 8026 T3070 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@22a94d4f main{StandardDirectoryReader(segments_i:50 _g(5.0):C1 _h(5.0):C1 _i(5.0):C1)}
[junit4:junit4]   2> 8028 T3057 C225 oass.SolrIndexSearcher.<init> Opening Searcher@15ef026d realtime
[junit4:junit4]   2> 8028 T3057 C225 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 8029 T3057 C225 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=23 
[junit4:junit4]   2> 8034 T3057 C225 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=0,_version_=115,id=Q5} DBQs=[DBQ{version=1413023599190605824,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 8042 T3057 C225 oass.SolrIndexSearcher.<init> Opening Searcher@284259a4 realtime
[junit4:junit4]   2> 8042 T3057 C225 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 8043 T3057 C225 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=9 
[junit4:junit4]   2> 8052 T3057 C225 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=0,_version_=116,id=Q6} DBQs=[DBQ{version=1413023599190605824,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 8058 T3057 C225 oass.SolrIndexSearcher.<init> Opening Searcher@c48c30f realtime
[junit4:junit4]   2> 8058 T3057 C225 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 8059 T3057 C225 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=7 
[junit4:junit4]   2> 8068 T3057 C225 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 8075 T3057 C225 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2bc016e),segFN=segments_i,generation=18,filenames=[_g.fdt, _g.si, _h.fnm, _g.fdx, _g_Memory_0.ram, _h_SimpleText_0.pst, _h_Memory_0.ram, _i_Memory_0.ram, _i_SimpleText_0.pst, segments_i, _i.si, _g.fnm, _h.fdt, _h.si, _h.fdx, _i.fdx, _g_SimpleText_0.pst, _i.fnm, _i.fdt]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2bc016e),segFN=segments_j,generation=19,filenames=[_j.fdx, _g.si, _l.fnm, _g_Memory_0.ram, _j.fdt, _l.si, _k.fdt, _h_Memory_0.ram, _h_SimpleText_0.pst, _k.fdx, _i_SimpleText_0.pst, _k.fnm, _i.si, _l_SimpleText_0.pst, _k_SimpleText_0.pst, _g.fnm, _h.fdt, _h.fdx, _h.si, _k_Memory_0.ram, _i.fdx, _k.si, _i.fdt, _g.fdt, _h.fnm, _j_Memory_0.ram, _j.si, _g.fdx, _i_Memory_0.ram, segments_j, _j.fnm, _j_SimpleText_0.pst, _l.fdx, _l.fdt, _g_SimpleText_0.pst, _i.fnm, _l_Memory_0.ram]
[junit4:junit4]   2> 8078 T3057 C225 oasc.SolrDeletionPolicy.updateCommits newest commit = 19
[junit4:junit4]   2> 8080 T3057 C225 oass.SolrIndexSearcher.<init> Opening Searcher@42520ce7 main
[junit4:junit4]   2> 8080 T3057 C225 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 8083 T3057 C225 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 8084 T3070 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@42520ce7 main{StandardDirectoryReader(segments_i:56:nrt _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:junit4]   2> 8085 T3057 C225 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 17
[junit4:junit4]   2> 8099 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=490700092
[junit4:junit4]   2> 8099 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@501de29
[junit4:junit4]   2> 8100 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 8101 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 8101 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 8134 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 8135 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 8139 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 8139 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 8210 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 8282 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 8282 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 8288 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 8938 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 8942 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 8954 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 8954 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 8954 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 8967 T3057 oasc.CoreContainer.<init> New CoreContainer 1246869263
[junit4:junit4]   2> 8967 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 8969 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 8970 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 8972 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 8972 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 8972 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 8973 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 8975 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 8981 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 8994 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@7c127e17 main
[junit4:junit4]   2> 8994 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 9002 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 9002 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 9003 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 9003 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 9004 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 9004 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 9004 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 9005 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 9007 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 9007 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 9007 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 9007 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 9018 T3071 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7c127e17 main{StandardDirectoryReader(segments_j:56 _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:junit4]   2> 9018 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 9020 T3057 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4:junit4]   2> ASYNC  NEW_CORE C226 name=collection1 org.apache.solr.core.SolrCore@7f009ad7
[junit4:junit4]   2> 9038 T3057 C226 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3d60535b),segFN=segments_j,generation=19,filenames=[_j.fdx, _g.si, _l.fnm, _g_Memory_0.ram, _j.fdt, _l.si, _k.fdt, _h_Memory_0.ram, _h_SimpleText_0.pst, _k.fdx, _i_SimpleText_0.pst, _k.fnm, _i.si, _l_SimpleText_0.pst, _k_SimpleText_0.pst, _g.fnm, _h.fdt, _h.fdx, _h.si, _k_Memory_0.ram, _i.fdx, _k.si, _i.fdt, _g.fdt, _h.fnm, _j_Memory_0.ram, _j.si, _g.fdx, _i_Memory_0.ram, segments_j, _j_SimpleText_0.pst, _j.fnm, _l.fdx, _l.fdt, _g_SimpleText_0.pst, _i.fnm, _l_Memory_0.ram]
[junit4:junit4]   2> 9040 T3057 C226 oasc.SolrDeletionPolicy.updateCommits newest commit = 19
[junit4:junit4]   2> 9040 T3057 C226 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=0,_version_=117,id=Q7} DBQs=[DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 9068 T3057 C226 oass.SolrIndexSearcher.<init> Opening Searcher@e837c2c realtime
[junit4:junit4]   2> 9068 T3057 C226 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 9068 T3057 C226 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=42 
[junit4:junit4]   2> 9069 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1246869263
[junit4:junit4]   2> 9069 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7f009ad7
[junit4:junit4]   2> 9070 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 9070 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=1,adds=1,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 9070 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 9113 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 9113 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 9119 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 9120 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 9193 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 9255 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 9255 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 9261 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 9907 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 9912 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 9922 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 9923 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 9923 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 9937 T3057 oasc.CoreContainer.<init> New CoreContainer 291998913
[junit4:junit4]   2> 9941 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 9943 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 9944 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 9945 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 9945 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 9946 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 9946 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 9949 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 9954 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 9963 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@913ebdd main
[junit4:junit4]   2> 9965 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 9970 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 9970 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 9971 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 9971 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 9971 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 9972 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 9972 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 9972 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 9973 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 9973 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 9973 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 9974 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 9983 T3072 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@913ebdd main{StandardDirectoryReader(segments_j:56 _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:junit4]   2> 9983 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C227 name=collection1 org.apache.solr.core.SolrCore@4d587dc1
[junit4:junit4]   2> 9984 T3073 C227 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000021 refcount=2} active=false starting pos=0
[junit4:junit4]   2> 9997 T3073 C227 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@339231d7),segFN=segments_j,generation=19,filenames=[_j.fdx, _g.si, _l.fnm, _g_Memory_0.ram, _j.fdt, _l.si, _k.fdt, _h_Memory_0.ram, _h_SimpleText_0.pst, _k.fdx, _i_SimpleText_0.pst, _k.fnm, _i.si, _l_SimpleText_0.pst, _k_SimpleText_0.pst, _g.fnm, _h.fdt, _h.fdx, _h.si, _k_Memory_0.ram, _i.fdx, _k.si, _i.fdt, _g.fdt, _h.fnm, _j_Memory_0.ram, _j.si, _g.fdx, _i_Memory_0.ram, segments_j, _j_SimpleText_0.pst, _j.fnm, _l.fdx, _l.fdt, _g_SimpleText_0.pst, _i.fnm, _l_Memory_0.ram]
[junit4:junit4]   2> 9997 T3073 C227 oasc.SolrDeletionPolicy.updateCommits newest commit = 19
[junit4:junit4]   2> 9997 T3073 C227 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=10,_version_=117,id=Q7} DBQs=[DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 10012 T3073 C227 oass.SolrIndexSearcher.<init> Opening Searcher@2240cddd realtime
[junit4:junit4]   2> 10012 T3073 C227 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 10012 T3073 C227 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 10021 T3073 C227 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@339231d7),segFN=segments_j,generation=19,filenames=[_j.fdx, _g.si, _l.fnm, _g_Memory_0.ram, _j.fdt, _l.si, _k.fdt, _h_Memory_0.ram, _h_SimpleText_0.pst, _k.fdx, _i_SimpleText_0.pst, _k.fnm, _i.si, _l_SimpleText_0.pst, _k_SimpleText_0.pst, _g.fnm, _h.fdt, _h.fdx, _h.si, _k_Memory_0.ram, _i.fdx, _k.si, _i.fdt, _g.fdt, _h.fnm, _j_Memory_0.ram, _j.si, _g.fdx, _i_Memory_0.ram, segments_j, _j_SimpleText_0.pst, _j.fnm, _l.fdx, _l.fdt, _g_SimpleText_0.pst, _i.fnm, _l_Memory_0.ram]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@339231d7),segFN=segments_k,generation=20,filenames=[_j.fdx, _g.si, _l.fnm, _g_Memory_0.ram, _j.fdt, _l.si, _k.fdt, _h_Memory_0.ram, _h_SimpleText_0.pst, _k.fdx, _i_SimpleText_0.pst, _k.fnm, _i.si, _m_SimpleText_0.pst, _l_SimpleText_0.pst, _m.si, _k_SimpleText_0.pst, _g.fnm, _h.fdt, _h.fdx, _h.si, _k_Memory_0.ram, _i.fdx, _m_Memory_0.ram, _m.fnm, _k.si, _i.fdt, _g.fdt, _h.fnm, _j_Memory_0.ram, _j.si, _g.fdx, segments_k, _i_Memory_0.ram, _m.fdt, _j_SimpleText_0.pst, _j.fnm, _l.fdx, _m.fdx, _l.fdt, _g_SimpleText_0.pst, _i.fnm, _l_Memory_0.ram]
[junit4:junit4]   2> 10021 T3073 C227 oasc.SolrDeletionPolicy.updateCommits newest commit = 20
[junit4:junit4]   2> 10023 T3073 C227 oass.SolrIndexSearcher.<init> Opening Searcher@573ef26e main
[junit4:junit4]   2> 10023 T3073 C227 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 10023 T3073 C227 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 10025 T3072 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@573ef26e main{StandardDirectoryReader(segments_j:58:nrt _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:junit4]   2> 10025 T3073 C227 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=1 deletes=0 deleteByQuery=0 errors=0 positionOfStart=0}
[junit4:junit4]   2> 10025 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testBufferingFlags
[junit4:junit4]   2> 10031 T3057 oas.SolrTestCaseJ4.setUp ###Starting testCorruptLog
[junit4:junit4]   2> 10044 T3057 C227 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 10053 T3057 C227 oass.SolrIndexSearcher.<init> Opening Searcher@323ac0f2 realtime
[junit4:junit4]   2> 10054 T3057 C227 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 10054 T3057 C227 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=11 
[junit4:junit4]   2> 10060 T3057 C227 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 10064 T3057 C227 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@339231d7),segFN=segments_k,generation=20,filenames=[_j.fdx, _g.si, _l.fnm, _g_Memory_0.ram, _j.fdt, _l.si, _k.fdt, _h_Memory_0.ram, _h_SimpleText_0.pst, _k.fdx, _i_SimpleText_0.pst, _k.fnm, _i.si, _m_SimpleText_0.pst, _l_SimpleText_0.pst, _m.si, _k_SimpleText_0.pst, _g.fnm, _h.fdt, _h.fdx, _h.si, _k_Memory_0.ram, _i.fdx, _m_Memory_0.ram, _m.fnm, _k.si, _i.fdt, _g.fdt, _h.fnm, _j_Memory_0.ram, _j.si, _g.fdx, segments_k, _i_Memory_0.ram, _m.fdt, _j_SimpleText_0.pst, _j.fnm, _l.fdx, _m.fdx, _l.fdt, _g_SimpleText_0.pst, _i.fnm, _l_Memory_0.ram]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@339231d7),segFN=segments_l,generation=21,filenames=[segments_l]
[junit4:junit4]   2> 10065 T3057 C227 oasc.SolrDeletionPolicy.updateCommits newest commit = 21
[junit4:junit4]   2> 10088 T3057 C227 oass.SolrIndexSearcher.<init> Opening Searcher@52d7b1e5 main
[junit4:junit4]   2> 10088 T3057 C227 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 10090 T3072 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@52d7b1e5 main{StandardDirectoryReader(segments_k:59:nrt)}
[junit4:junit4]   2> 10090 T3057 C227 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 10104 T3057 C227 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 44
[junit4:junit4]   2> 10127 T3057 C227 UPDATE [collection1] webapp=null path=null params={} {add=[G1 (1413023607859183616)]} 0 3
[junit4:junit4]   2> 10134 T3057 C227 UPDATE [collection1] webapp=null path=null params={} {add=[G2 (1413023607869669376)]} 0 0
[junit4:junit4]   2> 10141 T3057 C227 UPDATE [collection1] webapp=null path=null params={} {add=[G3 (1413023607875960832)]} 0 1
[junit4:junit4]   2> 10142 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=291998913
[junit4:junit4]   2> 10142 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4d587dc1
[junit4:junit4]   2> 10143 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 10143 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=3,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=1}
[junit4:junit4]   2> 10143 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 10152 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 10154 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4:junit4]   2> 10157 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 10158 T3057 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 10220 T3057 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 10283 T3057 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 10284 T3057 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 10290 T3057 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 10941 T3057 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 10947 T3057 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 10958 T3057 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 10958 T3057 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4:junit4]   2> 10958 T3057 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4:junit4]   2> 10974 T3057 oasc.CoreContainer.<init> New CoreContainer 1259545862
[junit4:junit4]   2> 10974 T3057 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\
[junit4:junit4]   2> 10975 T3057 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 10977 T3057 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index/
[junit4:junit4]   2> 10978 T3057 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 10978 T3057 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 10979 T3057 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 10980 T3057 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 10983 T3057 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 10988 T3057 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\index forceNew:false
[junit4:junit4]   2> 10989 T3057 oass.SolrIndexSearcher.<init> Opening Searcher@bef7004 main
[junit4:junit4]   2> 10989 T3057 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 10994 T3057 oasc.SolrException.log Ignoring exception matching Failure to open existing log file
[junit4:junit4]   2> 10994 T3057 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 10994 T3057 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 10995 T3057 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 10995 T3057 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 10995 T3057 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 10996 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 10996 T3057 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 10997 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 10997 T3057 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 10997 T3057 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 10999 T3057 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 10999 T3057 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 11010 T3074 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bef7004 main{StandardDirectoryReader(segments_l:59)}
[junit4:junit4]   2> 11010 T3057 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> ASYNC  NEW_CORE C228 name=collection1 org.apache.solr.core.SolrCore@7e7ca685
[junit4:junit4]   2> 11016 T3057 C228 REQ [collection1] webapp=null path=null params={q=*:*} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 11033 T3057 C228 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4d2dfc0f),segFN=segments_l,generation=21,filenames=[segments_l]
[junit4:junit4]   2> 11034 T3057 C228 oasc.SolrDeletionPolicy.updateCommits newest commit = 21
[junit4:junit4]   2> 11034 T3057 C228 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=0,_version_=104,id=G4} DBQs=[DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 11043 T3057 C228 oass.SolrIndexSearcher.<init> Opening Searcher@6c69a5c2 realtime
[junit4:junit4]   2> 11043 T3057 C228 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 11044 T3057 C228 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=16 
[junit4:junit4]   2> 11050 T3057 C228 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=0,_version_=105,id=G5} DBQs=[DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 11057 T3057 C228 oass.SolrIndexSearcher.<init> Opening Searcher@70f45ffc realtime
[junit4:junit4]   2> 11057 T3057 C228 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 11059 T3057 C228 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=10 
[junit4:junit4]   2> 11064 T3057 C228 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=0,_version_=106,id=G6} DBQs=[DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}]
[junit4:junit4]   2> 11071 T3057 C228 oass.SolrIndexSearcher.<init> Opening Searcher@3d38ef3f realtime
[junit4:junit4]   2> 11072 T3057 C228 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 11072 T3057 C228 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=8 
[junit4:junit4]   2> 11073 T3057 C228 REQ [collection1] webapp=null path=null params={getVersions=3&qt=/get} status=0 QTime=1 
[junit4:junit4]   2> 11078 T3057 C228 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 11082 T3057 C228 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4d2dfc0f),segFN=segments_l,generation=21,filenames=[segments_l]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347564313172\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@4d2dfc0f),segFN=segments_m,generation=22,filenames=[_p_SimpleText_0.pst, _o.fdt, _o.fnm, _p.fdx, _p.fnm, _n_SimpleText_0.pst, _o_SimpleText_0.pst, _o.fdx, _p.fdt, _n.fdt, segments_m, _o_Memory_0.ram, _p.si, _n.fdx, _n_Memory_0.ram, _n.si, _o.si, _n.fnm, _p_Memory_0.ram]
[junit4:junit4]   2> 11082 T3057 C228 oasc.SolrDeletionPolicy.updateCommits newest commit = 22
[junit4:junit4]   2> 11086 T3057 C228 oass.SolrIndexSearcher.<init> Opening Searcher@402d9912 main
[junit4:junit4]   2> 11086 T3057 C228 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 11087 T3074 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@402d9912 main{StandardDirectoryReader(segments_l:65:nrt _n(5.0):C1 _o(5.0):C1 _p(5.0):C1)}
[junit4:junit4]   2> 11090 T3057 C228 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 11092 T3057 C228 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 14
[junit4:junit4]   2> 11105 T3057 C228 REQ [collection1] webapp=null path=null params={q=*:*} hits=3 status=0 QTime=0 
[junit4:junit4]   2> 11106 T3057 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1259545862
[junit4:junit4]   2> 11106 T3057 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7e7ca685
[junit4:junit4]   2> 11106 T3057 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 11106 T3057 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 11108 T3057 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 11128 T3057 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery
[junit4:junit4]   2> 11146 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testCorruptLog
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestRecovery -Dtests.method=testCorruptLog -Dtests.seed=44882BE7997A7A9F -Dtests.slow=true -Dtests.locale=zh_CN -Dtests.timezone=Asia/Jakarta -Dtests.file.encoding=UTF-8
[junit4:junit4] FAILURE 1.13s | TestRecovery.testCorruptLog <<<
[junit4:junit4]    > Throwable #1: java.lang.AssertionError: expected:<0> but was:<1>
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([44882BE7997A7A9F:B6559F3463422B43]:0)
[junit4:junit4]    > 	at org.junit.Assert.fail(Assert.java:93)
[junit4:junit4]    > 	at org.junit.Assert.failNotEquals(Assert.java:647)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:128)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:472)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:456)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.deleteLogs(TestRecovery.java:1046)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.testCorruptLog(TestRecovery.java:920)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:597)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:662)
[junit4:junit4]   2> 11160 T3057 oas.SolrTestCaseJ4.setUp ###Starting testTruncatedLog
[junit4:junit4]   2> 11163 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testTruncatedLog
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestRecovery -Dtests.method=testTruncatedLog -Dtests.seed=44882BE7997A7A9F -Dtests.slow=true -Dtests.locale=zh_CN -Dtests.timezone=Asia/Jakarta -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   0.01s | TestRecovery.testTruncatedLog <<<
[junit4:junit4]    > Throwable #1: java.lang.NullPointerException
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([44882BE7997A7A9F:20B2D39F904307EC]:0)
[junit4:junit4]    > 	at org.apache.solr.util.TestHarness.getCore(TestHarness.java:212)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.testTruncatedLog(TestRecovery.java:822)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:597)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:662)
[junit4:junit4]   2> 11171 T3057 oas.SolrTestCaseJ4.setUp ###Starting testRemoveOldLogs
[junit4:junit4]   2> 11174 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testRemoveOldLogs
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestRecovery -Dtests.method=testRemoveOldLogs -Dtests.seed=44882BE7997A7A9F -Dtests.slow=true -Dtests.locale=zh_CN -Dtests.timezone=Asia/Jakarta -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   0.01s | TestRecovery.testRemoveOldLogs <<<
[junit4:junit4]    > Throwable #1: java.lang.RuntimeException: java.lang.NullPointerException
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([44882BE7997A7A9F:6514EA4C5140F367]:0)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.clearIndex(TestRecovery.java:80)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.testRemoveOldLogs(TestRecovery.java:709)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:597)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:662)
[junit4:junit4]    > Caused by: java.lang.NullPointerException
[junit4:junit4]    > 	at org.apache.solr.util.TestHarness.getCore(TestHarness.java:212)
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:797)
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.deleteByQueryAndGetVersion(SolrTestCaseJ4.java:947)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.clearIndex(TestRecovery.java:78)
[junit4:junit4]    > 	... 41 more
[junit4:junit4]   2> 11182 T3057 oas.SolrTestCaseJ4.setUp ###Starting testVersionsOnRestart
[junit4:junit4]   2> 11182 T3057 oas.SolrTestCaseJ4.tearDown ###Ending testVersionsOnRestart
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestRecovery -Dtests.method=testVersionsOnRestart -Dtests.seed=44882BE7997A7A9F -Dtests.slow=true -Dtests.locale=zh_CN -Dtests.timezone=Asia/Jakarta -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   0.01s | TestRecovery.testVersionsOnRestart <<<
[junit4:junit4]    > Throwable #1: java.lang.RuntimeException: java.lang.NullPointerException
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([44882BE7997A7A9F:24260B99E624AA10]:0)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.clearIndex(TestRecovery.java:80)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.testVersionsOnRestart(TestRecovery.java:594)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:597)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:662)
[junit4:junit4]    > Caused by: java.lang.NullPointerException
[junit4:junit4]    > 	at org.apache.solr.util.TestHarness.getCore(TestHarness.java:212)
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:797)
[junit4:junit4]    > 	at org.apache.solr.SolrTestCaseJ4.deleteByQueryAndGetVersion(SolrTestCaseJ4.java:947)
[junit4:junit4]    > 	at org.apache.solr.search.TestRecovery.clearIndex(TestRecovery.java:78)
[junit4:junit4]    > 	... 41 more
[junit4:junit4]   2> 11190 T3057 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog\tlog.0000000000000000024 FAILED !!!!!
[junit4:junit4]   2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172\tlog FAILED !!!!!
[junit4:junit4]   2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347564313172 FAILED !!!!!
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40: {id=PostingsFormat(name=Memory doPackFST= false), _version_=PostingsFormat(name=SimpleText), val_i=PostingsFormat(name=Memory doPackFST= false)}, sim=DefaultSimilarity, locale=zh_CN, timezone=Asia/Jakarta
[junit4:junit4]   2> NOTE: Windows 7 6.1 amd64/Sun Microsystems Inc. 1.6.0_35 (64-bit)/cpus=2,threads=1,free=27725888,total=220528640
[junit4:junit4]   2> NOTE: All tests run in this JVM: [SuggesterFSTTest, TestPseudoReturnFields, TestReplicationHandler, TermVectorComponentTest, ShowFileRequestHandlerTest, DocumentBuilderTest, DOMUtilTest, CoreContainerCoreInitFailuresTest, BasicFunctionalityTest, TestPropInjectDefaults, BasicZkTest, QueryParsingTest, TermsComponentTest, DebugComponentTest, TestPHPSerializedResponseWriter, CopyFieldTest, RequestHandlersTest, SolrCoreCheckLockOnStartupTest, TestPhraseSuggestions, UpdateRequestProcessorFactoryTest, TestValueSourceCache, OverseerTest, SolrInfoMBeanTest, TestRandomFaceting, TestStressRecovery, UpdateParamsTest, FastVectorHighlighterTest, TestLMJelinekMercerSimilarityFactory, DateMathParserTest, SampleTest, TestSolrQueryParser, DistributedSpellCheckComponentTest, DirectUpdateHandlerTest, TestStressVersions, DocumentAnalysisRequestHandlerTest, IndexSchemaRuntimeFieldTest, SolrCmdDistributorTest, TestBinaryResponseWriter, TestFiltering, LoggingHandlerTest, TestCSVResponseWriter, TestLFUCache, TestIndexingPerformance, IndexReaderFactoryTest, TestXIncludeConfig, SystemInfoHandlerTest, ConvertedLegacyTest, SuggesterTest, ZkControllerTest, TestDistributedSearch, StandardRequestHandlerTest, TestReload, AutoCommitTest, SpatialFilterTest, QueryEqualityTest, TestSystemIdResolver, ScriptEngineTest, TestQueryTypes, TestCodecSupport, StatelessScriptUpdateProcessorFactoryTest, OpenExchangeRatesOrgProviderTest, ReturnFieldsTest, TestSolrDeletionPolicy1, TestJmxIntegration, TestRealTimeGet, PeerSyncTest, PrimUtilsTest, ZkSolrClientTest, ZkNodePropsTest, TestLuceneMatchVersion, TestCollationField, TestQuerySenderNoQuery, SearchHandlerTest, ClusterStateUpdateTest, TestSearchPerf, TestIndexSearcher, DirectUpdateHandlerOptimizeTest, XmlUpdateRequestHandlerTest, SimpleFacetsTest, QueryElevationComponentTest, TestBinaryField, RAMDirectoryFactoryTest, BasicDistributedZk2Test, MBeansHandlerTest, SolrPluginUtilsTest, TestBadConfig, DisMaxRequestHandlerTest, TestWriterPerf, TestStressLucene, CSVRequestHandlerTest, TestNumberUtils, SuggesterTSTTest, DistributedTermsComponentTest, FileUtilsTest, ClusterStateTest, IndexSchemaTest, AlternateDirectoryTest, BasicDistributedZkTest, PrimitiveFieldTypeTest, TestSolrJ, IndexBasedSpellCheckerTest, DistanceFunctionTest, TestArbitraryIndexDir, TestHashPartitioner, SolrRequestParserTest, TestDistributedGrouping, TestPerFieldSimilarity, TestDFRSimilarityFactory, SOLR749Test, TestBM25SimilarityFactory, LukeRequestHandlerTest, RecoveryZkTest, SpellCheckComponentTest, FullSolrCloudDistribCmdsTest, LeaderElectionIntegrationTest, LeaderElectionTest, SpellCheckCollatorTest, TestExtendedDismaxParser, SoftAutoCommitTest, TestFaceting, WordBreakSolrSpellCheckerTest, StatsComponentTest, TestRecovery]
[junit4:junit4] Completed in 11.27s, 10 tests, 1 failure, 3 errors <<< FAILURES!

[...truncated 310 lines...]
BUILD FAILED
C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\build.xml:29: The following error occurred while executing this line:
C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:146: The following error occurred while executing this line:
C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\lucene\module-build.xml:63: The following error occurred while executing this line:
C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1133: The following error occurred while executing this line:
C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:810: There were test failures: 228 suites, 923 tests, 3 errors, 1 failure, 11 ignored (6 assumptions)

Total time: 40 minutes 55 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Description set: Java: 64bit/jdk1.6.0_35 -XX:+UseParallelGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message