You are viewing a plain text version of this content. The canonical link for it is here.

Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/01/15 19:57:43 UTC

[JENKINS] Lucene-Solr-4.x-Linux (64bit/jdk1.8.0-ea-b123) - Build # 9004 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/9004/
Java: 64bit/jdk1.8.0-ea-b123 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

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([BA623A1A6355178:BE20422619F4E38C]: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:62)
	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 10113 lines...]
   [junit4] Suite: org.apache.solr.core.TestNonNRTOpen
   [junit4]   2> 16266 T60 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991
   [junit4]   2> 16267 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 16267 T60 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 16268 T60 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 16341 T60 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 16367 T60 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 16368 T60 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 16372 T60 oass.IndexSchema.readSchema [null] Schema name=minimal
   [junit4]   2> 16376 T60 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 16395 T60 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 16395 T60 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
   [junit4]   2> 16395 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
   [junit4]   2> 16410 T60 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 16428 T60 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
   [junit4]   2> 16429 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
   [junit4]   2> 16472 T60 oasc.CoreContainer.<init> New CoreContainer 416300928
   [junit4]   2> 16473 T60 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
   [junit4]   2> 16473 T60 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 16473 T60 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 16474 T60 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 16474 T60 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 16474 T60 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 16475 T60 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 16475 T60 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 16475 T60 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 16475 T60 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 16489 T60 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 16490 T60 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 16490 T60 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 16492 T61 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
   [junit4]   2> 16498 T61 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 16499 T61 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 16499 T61 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 16573 T61 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 16581 T61 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 16582 T61 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 16607 T61 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 16610 T61 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 16611 T61 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
   [junit4]   2> 16621 T61 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/
   [junit4]   2> 16621 T61 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 16622 T61 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991
   [junit4]   2> 16622 T61 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/index/
   [junit4]   2> 16623 T61 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/index' doesn't exist. Creating new index...
   [junit4]   2> 16623 T61 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index
   [junit4]   2> 16696 T61 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_1,generation=1}
   [junit4]   2> 16697 T61 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 16698 T61 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 16698 T61 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 16699 T61 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 16701 T61 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 16712 T61 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 16713 T61 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 16714 T61 oass.SolrIndexSearcher.<init> Opening Searcher@35feb41e main
   [junit4]   2> 16714 T61 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 16715 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@35feb41e main{StandardDirectoryReader(segments_1:1)}
   [junit4]   2> 16718 T60 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> ASYNC  NEW_CORE C11 name=collection1 org.apache.solr.core.SolrCore@75859feb
   [junit4]   2> 16723 T60 C11 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_1,generation=1}
   [junit4]   2> 16723 T60 C11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 16725 T60 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 5
   [junit4]   2> 16730 T60 C11 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 16760 T60 C11 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_2,generation=2}
   [junit4]   2> 16761 T60 C11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 16780 T60 C11 oass.SolrIndexSearcher.<init> Opening Searcher@253e7d5e main
   [junit4]   2> 16781 T60 C11 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 16781 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@253e7d5e main{StandardDirectoryReader(segments_2:3 _0(4.7):C1)}
   [junit4]   2> 16782 T60 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 53
   [junit4]   2> 16783 T60 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 16783 T60 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=416300928
   [junit4]   2> 16784 T60 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@75859feb
   [junit4]   2> 16784 T60 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> 16784 T60 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 16785 T60 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 16785 T60 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 16788 T60 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 16789 T60 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 16789 T60 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index;done=false>>]
   [junit4]   2> 16790 T60 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index
   [junit4]   2> 16790 T60 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991;done=false>>]
   [junit4]   2> 16790 T60 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991
   [junit4]   2> NOTE: per solr.test.leavedatadir, dataDir will not be removed: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991
   [junit4]   2> 16791 T60 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 16792 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 16808 T60 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 16809 T60 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 16861 T60 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 16889 T60 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 16890 T60 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 16893 T60 oass.IndexSchema.readSchema [null] Schema name=minimal
   [junit4]   2> 16911 T60 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 16912 T60 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 16912 T60 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
   [junit4]   2> 16913 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
   [junit4]   2> 16934 T60 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 16934 T60 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
   [junit4]   2> 16934 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
   [junit4]   2> 16986 T60 oasc.CoreContainer.<init> New CoreContainer 535019470
   [junit4]   2> 16986 T60 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/]
   [junit4]   2> 16987 T60 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 16988 T60 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
   [junit4]   2> 16988 T60 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 16988 T60 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 16988 T60 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 16989 T60 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 16989 T60 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 16989 T60 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 16989 T60 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 16993 T60 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 16993 T60 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 16993 T60 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 17008 T64 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
   [junit4]   2> 17012 T64 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 17013 T64 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 17013 T64 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 17057 T64 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 17091 T64 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 17092 T64 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 17096 T64 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 17099 T64 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 17100 T64 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
   [junit4]   2> 17100 T64 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/
   [junit4]   2> 17100 T64 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 17112 T64 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991
   [junit4]   2> 17113 T64 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/index/
   [junit4]   2> 17114 T64 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 17114 T64 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 17115 T64 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 17117 T64 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 17132 T64 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 17133 T64 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 17133 T64 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index
   [junit4]   2> 17138 T64 oass.SolrIndexSearcher.<init> Opening Searcher@33bf4c5c main
   [junit4]   2> 17138 T64 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 17139 T65 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@33bf4c5c main{StandardDirectoryReader(segments_2:3 _0(4.7):C1)}
   [junit4]   2> 17149 T60 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 17153 T60 oas.SolrTestCaseJ4.setUp ###Starting testReaderIsNotNRT
   [junit4]   2> ASYNC  NEW_CORE C12 name=collection1 org.apache.solr.core.SolrCore@31cb311d
   [junit4]   2> 17154 T60 C12 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 17162 T60 C12 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_2,generation=2}
   [junit4]   2> 17162 T60 C12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 17163 T60 C12 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 9
   [junit4]   2> 17167 T60 C12 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 2
   [junit4]   2> 17169 T60 C12 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 17201 T60 C12 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_3,generation=3}
   [junit4]   2> 17202 T60 C12 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 17208 T60 C12 oass.SolrIndexSearcher.<init> Opening Searcher@3ead17b4 main
   [junit4]   2> 17209 T60 C12 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17209 T65 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3ead17b4 main{StandardDirectoryReader(segments_3:6 _1(4.7):C1)}
   [junit4]   2> 17211 T60 C12 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 42
   [junit4]   2> 17213 T60 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
   [junit4]   2> 17213 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 17214 T60 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 17214 T60 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 17234 T60 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 17247 T60 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 17248 T60 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 17252 T60 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 17256 T60 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 17257 T60 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/
   [junit4]   2> 17258 T60 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 17258 T60 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/index/
   [junit4]   2> 17259 T60 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 17260 T60 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 17260 T60 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 17263 T60 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 17266 T60 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 17267 T60 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 17271 T60 oass.SolrIndexSearcher.<init> Opening Searcher@1a5b5cbc main
   [junit4]   2> 17272 T60 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
   [junit4]   2> 17272 T60 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 17273 T60 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
   [junit4]   2> 17277 T60 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_3,generation=3}
   [junit4]   2> 17277 T60 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 17277 T60 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
   [junit4]   2> 17278 T60 oasc.SolrCore.getSearcher WARN [collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
   [junit4]   2> 17280 T60 oass.SolrIndexSearcher.<init> Opening Searcher@78d19139 main
   [junit4]   2> 17281 T67 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a5b5cbc main{StandardDirectoryReader(segments_3:6 _1(4.7):C1)}
   [junit4]   2> 17281 T67 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@78d19139 main{StandardDirectoryReader(segments_3:6 _1(4.7):C1)}
   [junit4]   2> 17281 T60 oasc.CoreContainer.registerCore replacing core: collection1
   [junit4]   2> 17282 T60 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@31cb311d
   [junit4]   2> 17282 T60 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=1,cumulative_errors=0}
   [junit4]   2> 17283 T60 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> ASYNC  NEW_CORE C13 name=collection1 org.apache.solr.core.SolrCore@17c5a3f3
   [junit4]   2> 17286 T60 C13 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
   [junit4]   2> 17289 T60 C13 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 17322 T60 C13 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_3,generation=3}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_4,generation=4}
   [junit4]   2> 17322 T60 C13 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
   [junit4]   2> 17330 T60 C13 oass.SolrIndexSearcher.<init> Opening Searcher@3bd42348 main
   [junit4]   2> 17331 T67 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3bd42348 main{StandardDirectoryReader(segments_4:8 _1(4.7):C1 _2(4.7):C1)}
   [junit4]   2> 17331 T60 C13 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17332 T60 C13 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 43
   [junit4]   2> 17336 T60 C13 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 2
   [junit4]   2> 17339 T60 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
   [junit4]   2> 17339 T60 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 17340 T60 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 17341 T60 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 17380 T60 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
   [junit4]   2> 17393 T60 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 17394 T60 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 17398 T60 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 17401 T60 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 17402 T60 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/
   [junit4]   2> 17403 T60 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 17403 T60 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-TestNonNRTOpen-1389811029991/index/
   [junit4]   2> 17404 T60 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 17405 T60 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 17405 T60 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 17408 T60 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 17409 T60 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 17409 T60 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 17416 T60 oass.SolrIndexSearcher.<init> Opening Searcher@71a421c6 main
   [junit4]   2> 17416 T60 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
   [junit4]   2> 17417 T60 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 17417 T60 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
   [junit4]   2> 17416 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@71a421c6 main{StandardDirectoryReader(segments_4:8 _1(4.7):C1 _2(4.7):C1)}
   [junit4]   2> 17442 T60 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_4,generation=4}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_5,generation=5}
   [junit4]   2> 17442 T60 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 17449 T60 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_5,generation=5}
   [junit4]   2> 17450 T60 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 17450 T60 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
   [junit4]   2> 17458 T60 oass.SolrIndexSearcher.<init> Opening Searcher@4e93289c main
   [junit4]   2> 17459 T60 oasc.CoreContainer.registerCore replacing core: collection1
   [junit4]   2> 17459 T60 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@17c5a3f3
   [junit4]   2> 17459 T60 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> 17460 T60 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 17462 T60 oas.SolrTestCaseJ4.tearDown ###Ending testReaderIsNotNRT
   [junit4]   2> 17464 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4e93289c main{StandardDirectoryReader(segments_5:10 _1(4.7):C1 _2(4.7):C1 _3(4.7):C1)}
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestNonNRTOpen -Dtests.method=testReaderIsNotNRT -Dtests.seed=BA623A1A6355178 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=el -Dtests.timezone=Etc/GMT -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.35s J1 | TestNonNRTOpen.testReaderIsNotNRT <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<3> but was:<2>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([BA623A1A6355178:BE20422619F4E38C]: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> 17502 T60 oas.SolrTestCaseJ4.setUp ###Starting testSharedCores
   [junit4]   2> ASYNC  NEW_CORE C14 name=collection1 org.apache.solr.core.SolrCore@6cb1e6eb
   [junit4]   2> 17504 T60 C14 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 17505 T60 C14 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 2
   [junit4]   2> 17508 T60 C14 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 2
   [junit4]   2> 17510 T60 C14 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 17532 T60 C14 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_5,generation=5}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_6,generation=6}
   [junit4]   2> 17532 T60 C14 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
   [junit4]   2> 17542 T60 C14 oass.SolrIndexSearcher.<init> Opening Searcher@7b9bec07 main
   [junit4]   2> 17543 T60 C14 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17543 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7b9bec07 main{StandardDirectoryReader(segments_6:13 _4(4.7):C1)}
   [junit4]   2> 17545 T60 C14 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 35
   [junit4]   2> 17548 T60 C14 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 17630 T60 C14 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_6,generation=6}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_7,generation=7}
   [junit4]   2> 17631 T60 C14 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
   [junit4]   2> 17636 T60 C14 oass.SolrIndexSearcher.<init> Opening Searcher@6b2fec44 main
   [junit4]   2> 17637 T60 C14 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17637 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b2fec44 main{StandardDirectoryReader(segments_7:15 _5(4.7):C1)}
   [junit4]   2> 17638 T60 C14 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 91
   [junit4]   2> 17641 T60 C14 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 2
   [junit4]   2> ASYNC  NEW_CORE C15 name=collection1 org.apache.solr.core.SolrCore@6cb1e6eb
   [junit4]   2> 17646 T60 C15 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 17682 T60 C15 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_7,generation=7}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_8,generation=8}
   [junit4]   2> 17682 T60 C15 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
   [junit4]   2> 17687 T60 C15 oass.SolrIndexSearcher.<init> Opening Searcher@1f1bc992 main
   [junit4]   2> 17688 T60 C15 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17688 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f1bc992 main{StandardDirectoryReader(segments_8:17 _5(4.7):C1 _6(4.7):C1)}
   [junit4]   2> 17689 T60 C15 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 43
   [junit4]   2> 17691 T60 C15 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
   [junit4]   2> 17693 T60 C15 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
   [junit4]   2> 17695 T60 C15 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 17730 T60 C15 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_8,generation=8}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_9,generation=9}
   [junit4]   2> 17731 T60 C15 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
   [junit4]   2> 17739 T60 C15 oass.SolrIndexSearcher.<init> Opening Searcher@4d35b168 main
   [junit4]   2> 17740 T60 C15 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17740 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4d35b168 main{StandardDirectoryReader(segments_9:19 _5(4.7):C1 _6(4.7):C1 _7(4.7):C2)}
   [junit4]   2> 17741 T60 C15 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 46
   [junit4]   2> 17743 T60 C15 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=foo2:doc} 0 1
   [junit4]   2> 17744 T60 C15 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 17770 T60 C15 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_9,generation=9}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index,segFN=segments_a,generation=10}
   [junit4]   2> 17771 T60 C15 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
   [junit4]   2> 17780 T60 C15 oass.SolrIndexSearcher.<init> Opening Searcher@78c392cf main
   [junit4]   2> 17780 T60 C15 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 17780 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@78c392cf main{StandardDirectoryReader(segments_a:20 _5(4.7):C1 _6(4.7):C1 _7(4.7):C2/1:delGen=1)}
   [junit4]   2> 17781 T60 C15 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 37
   [junit4]   2> 17783 T60 oas.SolrTestCaseJ4.tearDown ###Ending testSharedCores
   [junit4]   2> 17784 T60 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 17784 T60 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=535019470
   [junit4]   2> 17788 T60 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@6cb1e6eb
   [junit4]   2> 17789 T60 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=4,autocommits=0,soft autocommits=0,optimizes=1,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0}
   [junit4]   2> 17789 T60 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 17789 T60 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 17789 T60 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 17790 T60 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 17791 T60 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 17792 T60 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991;done=false>>]
   [junit4]   2> 17792 T60 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991
   [junit4]   2> 17792 T60 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index;done=false>>]
   [junit4]   2> 17793 T60 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/solrtest-TestNonNRTOpen-1389811029991/index
   [junit4]   2> NOTE: test params are: codec=Lucene46: {bazz=Lucene41(blocksize=128), foo=PostingsFormat(name=Direct), baz=Lucene41(blocksize=128), foo2=PostingsFormat(name=NestedPulsing)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=el, timezone=Etc/GMT
   [junit4]   2> NOTE: Linux 3.8.0-35-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=135062472,total=189792256
   [junit4]   2> NOTE: All tests run in this JVM: [TestPartialUpdateDeduplication, DistanceFunctionTest, TestQuerySenderListener, TestUpdate, XsltUpdateRequestHandlerTest, TestClassNameShortening, NotRequiredUniqueKeyTest, TestNonNRTOpen]
   [junit4] Completed on J1 in 1.58s, 2 tests, 1 failure <<< FAILURES!

[...truncated 1052 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:459: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:439: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:491: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1307: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:940: There were test failures: 352 suites, 1539 tests, 1 failure, 34 ignored (6 assumptions)

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