You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/11/07 21:23:56 UTC

[JENKINS] Lucene-Solr-4.x-Windows (32bit/jdk1.8.0-ea-b114) - Build # 3363 - Still Failing!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3363/
Java: 32bit/jdk1.8.0-ea-b114 -server -XX:+UseParallelGC

1 tests failed.
REGRESSION:  org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT

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

Stack Trace:
java.lang.AssertionError: expected:<3> but was:<2>
	at __randomizedtesting.SeedInfo.seed([7EFEB9D13C1A0A82:CB78D85683DBB876]: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.core.TestNonNRTOpen.assertNotNRT(TestNonNRTOpen.java:133)
	at org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT(TestNonNRTOpen.java:94)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:483)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
	at java.lang.Thread.run(Thread.java:744)




Build Log:
[...truncated 9842 lines...]
   [junit4] Suite: org.apache.solr.core.TestNonNRTOpen
   [junit4]   2> 13134 T16 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057
   [junit4]   2> 13135 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
   [junit4]   2> 13138 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 13140 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 13288 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 13300 T16 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 13300 T16 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 13305 T16 oass.IndexSchema.readSchema [null] Schema name=minimal
   [junit4]   2> 13312 T16 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 13313 T16 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 13314 T16 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
   [junit4]   2> 13314 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
   [junit4]   2> 13334 T16 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 13334 T16 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
   [junit4]   2> 13334 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
   [junit4]   2> 13380 T16 oasc.CoreContainer.<init> New CoreContainer 15545048
   [junit4]   2> 13380 T16 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
   [junit4]   2> 13381 T16 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 13382 T16 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 13382 T16 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 13382 T16 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 13382 T16 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 13382 T16 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 13384 T16 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 13384 T16 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 13386 T16 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 13392 T16 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 13394 T16 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 13540 T17 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
   [junit4]   2> 13541 T17 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
   [junit4]   2> 13541 T17 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 13542 T17 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 13582 T17 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 13595 T17 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 13595 T17 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 13606 T17 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 13609 T17 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 13609 T17 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
   [junit4]   2> 13643 T17 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\
   [junit4]   2> 13643 T17 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 13644 T17 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057
   [junit4]   2> 13645 T17 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\index/
   [junit4]   2> 13646 T17 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\index' doesn't exist. Creating new index...
   [junit4]   2> 13646 T17 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index
   [junit4]   2> 13652 T17 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_1,generation=1}
   [junit4]   2> 13652 T17 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 13653 T17 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 13653 T17 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 13656 T17 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 13662 T17 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 13664 T17 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 13664 T17 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 13664 T17 oass.SolrIndexSearcher.<init> Opening Searcher@14f5f89 main
   [junit4]   2> 13667 T17 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 13667 T18 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14f5f89 main{StandardDirectoryReader(segments_1:1)}
   [junit4]   2> 13672 T16 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> ASYNC  NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@1a4ef9d
   [junit4]   2> 13677 T16 C1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_1,generation=1}
   [junit4]   2> 13683 T16 C1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 13683 T16 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 11
   [junit4]   2> 13692 T16 C1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 13713 T16 C1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_2,generation=2}
   [junit4]   2> 13714 T16 C1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 13768 T16 C1 oass.SolrIndexSearcher.<init> Opening Searcher@3d841a main
   [junit4]   2> 13769 T16 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 13769 T18 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3d841a main{StandardDirectoryReader(segments_2:3 _0(4.6):C1)}
   [junit4]   2> 13770 T16 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 79
   [junit4]   2> 13773 T16 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 13774 T16 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=15545048
   [junit4]   2> 13774 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1a4ef9d
   [junit4]   2> 13774 T16 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=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 13774 T16 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 13775 T16 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 13776 T16 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 13778 T16 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 13779 T16 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 13779 T16 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index;done=false>>]
   [junit4]   2> 13779 T16 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index
   [junit4]   2> 13779 T16 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057;done=false>>]
   [junit4]   2> 13779 T16 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057
   [junit4]   2> NOTE: per solr.test.leavedatadir, dataDir will not be removed: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057
   [junit4]   2> 13782 T16 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 13782 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
   [junit4]   2> 13784 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 13786 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 13843 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 13856 T16 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 13858 T16 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 13867 T16 oass.IndexSchema.readSchema [null] Schema name=minimal
   [junit4]   2> 13884 T16 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 13885 T16 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 13894 T16 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
   [junit4]   2> 13894 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
   [junit4]   2> 13920 T16 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 13920 T16 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
   [junit4]   2> 13922 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
   [junit4]   2> 13955 T16 oasc.CoreContainer.<init> New CoreContainer 22884857
   [junit4]   2> 13963 T16 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
   [junit4]   2> 13964 T16 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 13964 T16 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 13964 T16 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 13964 T16 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 13964 T16 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 13964 T16 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 13964 T16 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 13966 T16 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 13966 T16 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 13970 T16 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 13970 T16 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 13974 T20 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
   [junit4]   2> 13976 T20 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
   [junit4]   2> 13977 T20 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 13978 T20 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 14012 T20 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 14020 T20 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 14021 T20 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 14025 T20 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 14027 T20 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 14028 T20 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
   [junit4]   2> 14028 T20 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\
   [junit4]   2> 14028 T20 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 14028 T20 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057
   [junit4]   2> 14029 T20 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\index/
   [junit4]   2> 14031 T20 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 14032 T20 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 14032 T20 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 14038 T20 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 14040 T20 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 14040 T20 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 14042 T20 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index
   [junit4]   2> 14047 T20 oass.SolrIndexSearcher.<init> Opening Searcher@1d893ee main
   [junit4]   2> 14048 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1d893ee main{StandardDirectoryReader(segments_2:3 _0(4.6):C1)}
   [junit4]   2> 14048 T20 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 14050 T16 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 14064 T16 oas.SolrTestCaseJ4.setUp ###Starting testSharedCores
   [junit4]   2> ASYNC  NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@d9fb1d
   [junit4]   2> 14067 T16 C2 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 14071 T16 C2 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_2,generation=2}
   [junit4]   2> 14073 T16 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 14077 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 12
   [junit4]   2> 14087 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 7
   [junit4]   2> 14094 T16 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14112 T16 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_3,generation=3}
   [junit4]   2> 14112 T16 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 14130 T16 C2 oass.SolrIndexSearcher.<init> Opening Searcher@16a03ce main
   [junit4]   2> 14132 T16 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14132 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@16a03ce main{StandardDirectoryReader(segments_3:6 _1(4.6):C1)}
   [junit4]   2> 14135 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 44
   [junit4]   2> 14141 T16 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14277 T16 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_3,generation=3}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_4,generation=4}
   [junit4]   2> 14277 T16 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
   [junit4]   2> 14293 T16 C2 oass.SolrIndexSearcher.<init> Opening Searcher@abf993 main
   [junit4]   2> 14293 T16 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14295 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@abf993 main{StandardDirectoryReader(segments_4:8 _2(4.6):C1)}
   [junit4]   2> 14298 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 162
   [junit4]   2> 14312 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 6
   [junit4]   2> 14314 T16 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14334 T16 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_4,generation=4}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_5,generation=5}
   [junit4]   2> 14334 T16 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 14345 T16 C2 oass.SolrIndexSearcher.<init> Opening Searcher@1250839 main
   [junit4]   2> 14345 T16 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14346 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1250839 main{StandardDirectoryReader(segments_5:10 _2(4.6):C1 _3(4.6):C1)}
   [junit4]   2> 14348 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 34
   [junit4]   2> 14356 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 6
   [junit4]   2> 14360 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 2
   [junit4]   2> 14368 T16 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14391 T16 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_5,generation=5}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_6,generation=6}
   [junit4]   2> 14391 T16 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
   [junit4]   2> 14410 T16 C2 oass.SolrIndexSearcher.<init> Opening Searcher@66b6d7 main
   [junit4]   2> 14410 T16 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14411 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@66b6d7 main{StandardDirectoryReader(segments_6:12 _2(4.6):C1 _3(4.6):C1 _4(4.6):C2)}
   [junit4]   2> 14412 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 47
   [junit4]   2> 14420 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=foo2:doc} 0 5
   [junit4]   2> 14422 T16 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14482 T16 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_6,generation=6}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_7,generation=7}
   [junit4]   2> 14482 T16 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
   [junit4]   2> 14499 T16 C2 oass.SolrIndexSearcher.<init> Opening Searcher@de71ef main
   [junit4]   2> 14500 T16 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14501 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@de71ef main{StandardDirectoryReader(segments_7:13 _2(4.6):C1 _3(4.6):C1 _4(4.6):C2/1:delGen=1)}
   [junit4]   2> 14502 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 81
   [junit4]   2> 14503 T16 oas.SolrTestCaseJ4.tearDown ###Ending testSharedCores
   [junit4]   2> 14514 T16 oas.SolrTestCaseJ4.setUp ###Starting testReaderIsNotNRT
   [junit4]   2> 14521 T16 C2 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 14521 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 7
   [junit4]   2> 14523 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
   [junit4]   2> 14526 T16 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14537 T16 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_7,generation=7}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_8,generation=8}
   [junit4]   2> 14538 T16 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
   [junit4]   2> 14573 T16 C2 oass.SolrIndexSearcher.<init> Opening Searcher@fae58b main
   [junit4]   2> 14574 T16 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14574 T21 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@fae58b main{StandardDirectoryReader(segments_8:16 _5(4.6):C1)}
   [junit4]   2> 14579 T16 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 54
   [junit4]   2> 14581 T16 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
   [junit4]   2> 14581 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
   [junit4]   2> 14583 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 14583 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 14633 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 14644 T16 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 14644 T16 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 14648 T16 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 14653 T16 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 14659 T16 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\
   [junit4]   2> 14660 T16 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 14661 T16 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\index/
   [junit4]   2> 14665 T16 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 14665 T16 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 14666 T16 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 14674 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 14680 T16 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 14681 T16 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 14682 T16 oass.SolrIndexSearcher.<init> Opening Searcher@1c8648f main
   [junit4]   2> 14685 T16 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
   [junit4]   2> 14686 T16 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 14686 T16 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
   [junit4]   2> 14702 T16 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_8,generation=8}
   [junit4]   2> 14702 T16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
   [junit4]   2> 14703 T16 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
   [junit4]   2> 14703 T16 oasc.SolrCore.getSearcher WARN [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 14704 T16 oass.SolrIndexSearcher.<init> Opening Searcher@1cb10f6 main
   [junit4]   2> 14706 T16 oasc.CoreContainer.registerCore replacing core: collection1
   [junit4]   2> 14706 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@d9fb1d
   [junit4]   2> 14706 T16 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=5,autocommits=0,soft autocommits=0,optimizes=1,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=3,cumulative_errors=0}
   [junit4]   2> 14707 T24 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c8648f main{StandardDirectoryReader(segments_8:16 _5(4.6):C1)}
   [junit4]   2> 14707 T24 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1cb10f6 main{StandardDirectoryReader(segments_8:16 _5(4.6):C1)}
   [junit4]   2> 14708 T16 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> ASYNC  NEW_CORE C3 name=collection1 org.apache.solr.core.SolrCore@a8a29
   [junit4]   2> 14731 T16 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 7
   [junit4]   2> 14736 T16 C3 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 14753 T16 C3 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_8,generation=8}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_9,generation=9}
   [junit4]   2> 14753 T16 C3 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
   [junit4]   2> 14763 T16 C3 oass.SolrIndexSearcher.<init> Opening Searcher@c085bd main
   [junit4]   2> 14765 T16 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 14765 T24 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c085bd main{StandardDirectoryReader(segments_9:18 _5(4.6):C1 _6(4.6):C1)}
   [junit4]   2> 14766 T16 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 34
   [junit4]   2> 14776 T16 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 8
   [junit4]   2> 14778 T16 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
   [junit4]   2> 14778 T16 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
   [junit4]   2> 14778 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 14781 T16 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 14828 T16 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_46
   [junit4]   2> 14835 T16 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 14836 T16 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 14839 T16 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 14843 T16 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 14846 T16 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\
   [junit4]   2> 14846 T16 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 14846 T16 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1383853991057\index/
   [junit4]   2> 14848 T16 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 14848 T16 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 14849 T16 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 14855 T16 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 14855 T16 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 14856 T16 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 14866 T16 oass.SolrIndexSearcher.<init> Opening Searcher@879046 main
   [junit4]   2> 14867 T16 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
   [junit4]   2> 14867 T16 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 14867 T16 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
   [junit4]   2> 14877 T25 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@879046 main{StandardDirectoryReader(segments_9:18 _5(4.6):C1 _6(4.6):C1)}
   [junit4]   2> 14881 T16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_9,generation=9}
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_a,generation=10}
   [junit4]   2> 14882 T16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
   [junit4]   2> 14895 T16 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index,segFN=segments_a,generation=10}
   [junit4]   2> 14895 T16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
   [junit4]   2> 14895 T16 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
   [junit4]   2> 14904 T16 oass.SolrIndexSearcher.<init> Opening Searcher@e44741 main
   [junit4]   2> 14904 T16 oasc.CoreContainer.registerCore replacing core: collection1
   [junit4]   2> 14904 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@a8a29
   [junit4]   2> 14904 T16 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=1,adds=1,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 14906 T16 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 14908 T16 oas.SolrTestCaseJ4.tearDown ###Ending testReaderIsNotNRT
   [junit4]   2> 14944 T25 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e44741 main{StandardDirectoryReader(segments_a:20 _5(4.6):C1 _6(4.6):C1 _7(4.6):C1)}
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestNonNRTOpen -Dtests.method=testReaderIsNotNRT -Dtests.seed=7EFEB9D13C1A0A82 -Dtests.slow=true -Dtests.locale=fr_LU -Dtests.timezone=Pacific/Gambier -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 0.46s | TestNonNRTOpen.testReaderIsNotNRT <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<3> but was:<2>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([7EFEB9D13C1A0A82:CB78D85683DBB876]:0)
   [junit4]    > 	at org.apache.solr.core.TestNonNRTOpen.assertNotNRT(TestNonNRTOpen.java:133)
   [junit4]    > 	at org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT(TestNonNRTOpen.java:94)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:744)
   [junit4]   2> 14966 T16 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 14967 T16 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=22884857
   [junit4]   2> 14967 T16 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@5f9637
   [junit4]   2> 14967 T16 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 14967 T16 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 14968 T16 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 14968 T16 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 14970 T16 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 14972 T16 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 14972 T16 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057;done=false>>]
   [junit4]   2> 14972 T16 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057
   [junit4]   2> 14972 T16 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index;done=false>>]
   [junit4]   2> 14972 T16 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1383853991057\index
   [junit4]   2> NOTE: test params are: codec=Lucene42, sim=DefaultSimilarity, locale=fr_LU, timezone=Pacific/Gambier
   [junit4]   2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0-ea (32-bit)/cpus=2,threads=1,free=111075744,total=177209344
   [junit4]   2> NOTE: All tests run in this JVM: [MoreLikeThisHandlerTest, TestNonNRTOpen]
   [junit4] Completed in 1.94s, 2 tests, 1 failure <<< FAILURES!

[...truncated 1035 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:428: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:408: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:483: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1263: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:906: There were test failures: 335 suites, 1475 tests, 1 failure, 46 ignored (11 assumptions)

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