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/07/23 03:55:16 UTC

[JENKINS] Lucene-Solr-trunk-Linux (32bit/jdk1.8.0_11) - Build # 10873 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/10873/
Java: 32bit/jdk1.8.0_11 -server -XX:+UseG1GC

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

Error Message:
SOLR-5815? : wrong maxDoc: core=org.apache.solr.core.SolrCore@1fa713e searcher=Searcher@1e6e32[collection1] main{UninvertingDirectoryReader(Uninverting(_1(5.0):C1) Uninverting(_2(5.0):C1))} expected:<3> but was:<2>

Stack Trace:
java.lang.AssertionError: SOLR-5815? : wrong maxDoc: core=org.apache.solr.core.SolrCore@1fa713e searcher=Searcher@1e6e32[collection1] main{UninvertingDirectoryReader(Uninverting(_1(5.0):C1) Uninverting(_2(5.0):C1))} expected:<3> but was:<2>
	at __randomizedtesting.SeedInfo.seed([304454EC351ECE70:85C2356B8ADF7C84]: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.apache.solr.core.TestNonNRTOpen.assertNotNRT(TestNonNRTOpen.java:142)
	at org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT(TestNonNRTOpen.java:100)
	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:1618)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
	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.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:65)
	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:365)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
	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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	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:65)
	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:365)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11047 lines...]
   [junit4] Suite: org.apache.solr.core.TestNonNRTOpen
   [junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001
   [junit4]   2> 195797 T434 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (true)
   [junit4]   2> 195798 T434 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 195799 T434 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 195799 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 195800 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 195800 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 195834 T434 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
   [junit4]   2> 195842 T434 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 195843 T434 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 195846 T434 oass.IndexSchema.readSchema [null] Schema name=minimal
   [junit4]   2> 195850 T434 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 195850 T434 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 195850 T434 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 195851 T434 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 195869 T434 oasc.CoreContainer.<init> New CoreContainer 29175474
   [junit4]   2> 195869 T434 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 195870 T434 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 195870 T434 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
   [junit4]   2> 195870 T434 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 195870 T434 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 195871 T434 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 195871 T434 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 195871 T434 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 195871 T434 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 195871 T434 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 195875 T434 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 195875 T434 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 195875 T434 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 195877 T435 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 195878 T435 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 195878 T435 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 195878 T435 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 195894 T435 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
   [junit4]   2> 195900 T435 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 195901 T435 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 195903 T435 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 195905 T435 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 195905 T435 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 195905 T435 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
   [junit4]   2> 195915 T435 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/
   [junit4]   2> 195915 T435 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 195915 T435 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001
   [junit4]   2> 195915 T435 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index/
   [junit4]   2> 195916 T435 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 195916 T435 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index
   [junit4]   2> 195929 T435 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_1,generation=1}
   [junit4]   2> 195929 T435 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 195930 T435 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 195930 T435 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 195930 T435 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 195932 T435 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 195933 T435 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 195933 T435 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 195934 T435 oass.SolrIndexSearcher.<init> Opening Searcher@93ead2[collection1] main
   [junit4]   2> 195934 T435 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 195934 T435 oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 195935 T435 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 195935 T435 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
   [junit4]   2> 195935 T435 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 195935 T435 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 195935 T435 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 195935 T436 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@93ead2[collection1] main{UninvertingDirectoryReader()}
   [junit4]   2> 195936 T434 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> ASYNC  NEW_CORE C355 name=collection1 org.apache.solr.core.SolrCore@146ccfd
   [junit4]   2> 195938 T434 C355 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_1,generation=1}
   [junit4]   2> 195939 T434 C355 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 195941 T434 C355 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 4
   [junit4]   2> 195943 T434 C355 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 195969 T434 C355 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_2,generation=2}
   [junit4]   2> 195969 T434 C355 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 195974 T434 C355 oass.SolrIndexSearcher.<init> Opening Searcher@1a25352[collection1] main
   [junit4]   2> 195974 T434 C355 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 195974 T436 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a25352[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1))}
   [junit4]   2> 195974 T434 C355 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 31
   [junit4]   2> 195975 T434 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 195975 T434 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=29175474
   [junit4]   2> 195976 T434 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@146ccfd
   [junit4]   2> 195976 T434 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> 195976 T434 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 195977 T434 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 195977 T434 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 195978 T434 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 195978 T434 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 195978 T434 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001;done=false>>]
   [junit4]   2> 195978 T434 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001
   [junit4]   2> 195979 T434 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 195979 T434 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index
   [junit4]   2> 195980 T434 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 195980 T434 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 195980 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 195981 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 195981 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 196002 T434 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
   [junit4]   2> 196008 T434 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 196009 T434 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 196011 T434 oass.IndexSchema.readSchema [null] Schema name=minimal
   [junit4]   2> 196013 T434 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 196014 T434 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 196014 T434 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr
   [junit4]   2> 196015 T434 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 196049 T434 oasc.CoreContainer.<init> New CoreContainer 22463590
   [junit4]   2> 196049 T434 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 196049 T434 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
   [junit4]   2> 196050 T434 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
   [junit4]   2> 196050 T434 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
   [junit4]   2> 196050 T434 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 196050 T434 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 196050 T434 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 196051 T434 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 196051 T434 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 196051 T434 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 196054 T434 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 196054 T434 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 196054 T434 oasc.CoreContainer.load Host Name: 
   [junit4]   2> 196055 T438 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 196056 T438 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 196057 T438 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 196057 T438 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 196078 T438 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
   [junit4]   2> 196087 T438 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 196087 T438 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 196090 T438 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 196093 T438 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 196093 T438 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 196094 T438 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
   [junit4]   2> 196094 T438 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/
   [junit4]   2> 196094 T438 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 196094 T438 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001
   [junit4]   2> 196095 T438 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index/
   [junit4]   2> 196096 T438 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 196096 T438 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 196097 T438 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 196099 T438 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 196100 T438 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 196100 T438 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 196101 T438 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index
   [junit4]   2> 196103 T438 oass.SolrIndexSearcher.<init> Opening Searcher@10cd43a[collection1] main
   [junit4]   2> 196103 T438 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 196104 T438 oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 196104 T438 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 196104 T438 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
   [junit4]   2> 196104 T438 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 196105 T438 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 196105 T439 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10cd43a[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1))}
   [junit4]   2> 196105 T438 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 196106 T434 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 196107 T434 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=1 of core=org.apache.solr.core.SolrCore@4d7e5b
   [junit4]   2> 196109 T434 oas.SolrTestCaseJ4.setUp ###Starting testReaderIsNotNRT
   [junit4]   2> ASYNC  NEW_CORE C356 name=collection1 org.apache.solr.core.SolrCore@4d7e5b
   [junit4]   2> 196110 T434 C356 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 196113 T434 C356 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_2,generation=2}
   [junit4]   2> 196113 T434 C356 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 196114 T434 C356 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 4
   [junit4]   2> 196115 T434 C356 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
   [junit4]   2> 196116 T434 C356 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 196138 T434 C356 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_3,generation=3}
   [junit4]   2> 196138 T434 C356 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 196142 T434 C356 oass.SolrIndexSearcher.<init> Opening Searcher@2e28ae[collection1] main
   [junit4]   2> 196143 T434 C356 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 196143 T439 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2e28ae[collection1] main{UninvertingDirectoryReader(Uninverting(_1(5.0):C1))}
   [junit4]   2> 196143 T434 C356 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 27
   [junit4]   2> 196144 T434 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=1 of core=org.apache.solr.core.SolrCore@4d7e5b
   [junit4]   2> 196144 T434 oasc.TestNonNRTOpen.testReaderIsNotNRT Reloading core: org.apache.solr.core.SolrCore@4d7e5b
   [junit4]   2> 196144 T434 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 196145 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 196145 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 196146 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 196169 T434 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
   [junit4]   2> 196177 T434 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 196178 T434 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 196182 T434 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 196186 T434 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 196186 T434 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 196187 T434 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/
   [junit4]   2> 196188 T434 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 196188 T434 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index/
   [junit4]   2> 196189 T434 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 196190 T434 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 196190 T434 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 196193 T434 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 196194 T434 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 196194 T434 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 196196 T434 oass.SolrIndexSearcher.<init> Opening Searcher@9d6a1f[collection1] main
   [junit4]   2> 196196 T434 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 196197 T434 oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 196197 T434 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 196197 T434 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
   [junit4]   2> 196197 T434 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 196198 T434 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 196198 T434 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
   [junit4]   2> 196198 T434 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 196198 T434 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
   [junit4]   2> 196198 T441 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9d6a1f[collection1] main{UninvertingDirectoryReader(Uninverting(_1(5.0):C1))}
   [junit4]   2> 196201 T434 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_3,generation=3}
   [junit4]   2> 196201 T434 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 196201 T434 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
   [junit4]   2> 196202 T434 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 196202 T434 oasc.CoreContainer.registerCore replacing core: collection1
   [junit4]   2> 196203 T434 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4d7e5b
   [junit4]   2> 196203 T434 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> 196203 T434 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 196204 T434 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=1 of core=org.apache.solr.core.SolrCore@f1ae3
   [junit4]   2> ASYNC  NEW_CORE C357 name=collection1 org.apache.solr.core.SolrCore@f1ae3
   [junit4]   2> 196205 T434 C357 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
   [junit4]   2> 196206 T434 C357 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 196238 T434 C357 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_3,generation=3}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_4,generation=4}
   [junit4]   2> 196239 T434 C357 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
   [junit4]   2> 196243 T434 C357 oass.SolrIndexSearcher.<init> Opening Searcher@6eb446[collection1] main
   [junit4]   2> 196243 T434 C357 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 196246 T441 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6eb446[collection1] main{UninvertingDirectoryReader(Uninverting(_1(5.0):C1) Uninverting(_2(5.0):C1))}
   [junit4]   2> 196247 T434 C357 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 41
   [junit4]   2> 196247 T434 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=2 of core=org.apache.solr.core.SolrCore@f1ae3
   [junit4]   2> 196248 T434 C357 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
   [junit4]   2> 196249 T434 oasc.TestNonNRTOpen.testReaderIsNotNRT Reloading core: org.apache.solr.core.SolrCore@f1ae3
   [junit4]   2> 196249 T434 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 196250 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
   [junit4]   2> 196250 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 196251 T434 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 196271 T434 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
   [junit4]   2> 196277 T434 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 196277 T434 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
   [junit4]   2> 196280 T434 oass.IndexSchema.readSchema [collection1] Schema name=minimal
   [junit4]   2> 196282 T434 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
   [junit4]   2> 196283 T434 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 196283 T434 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/
   [junit4]   2> 196283 T434 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
   [junit4]   2> 196284 T434 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index/
   [junit4]   2> 196284 T434 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 196285 T434 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 196285 T434 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 196287 T434 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 196288 T434 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 196288 T434 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 196290 T434 oass.SolrIndexSearcher.<init> Opening Searcher@1e6e32[collection1] main
   [junit4]   2> 196291 T434 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 196291 T434 oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 196291 T434 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 196292 T434 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
   [junit4]   2> 196292 T434 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 196292 T434 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 196292 T434 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
   [junit4]   2> 196293 T434 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
   [junit4]   2> 196293 T434 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
   [junit4]   2> 196292 T442 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e6e32[collection1] main{UninvertingDirectoryReader(Uninverting(_1(5.0):C1) Uninverting(_2(5.0):C1))}
   [junit4]   2> 196315 T434 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_4,generation=4}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_5,generation=5}
   [junit4]   2> 196315 T434 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 196321 T434 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_5,generation=5}
   [junit4]   2> 196321 T434 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
   [junit4]   2> 196321 T434 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
   [junit4]   2> 196325 T434 oass.SolrIndexSearcher.<init> Opening Searcher@163da5b[collection1] main
   [junit4]   2> 196326 T434 oasc.CoreContainer.registerCore replacing core: collection1
   [junit4]   2> 196326 T434 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@f1ae3
   [junit4]   2> 196327 T434 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> 196327 T434 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 196328 T434 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=3 of core=org.apache.solr.core.SolrCore@1fa713e
   [junit4]   2> 196328 T442 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@163da5b[collection1] main{UninvertingDirectoryReader(Uninverting(_1(5.0):C1) Uninverting(_2(5.0):C1) Uninverting(_3(5.0):C1))}
   [junit4]   2> 196329 T434 oas.SolrTestCaseJ4.tearDown ###Ending testReaderIsNotNRT
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestNonNRTOpen -Dtests.method=testReaderIsNotNRT -Dtests.seed=304454EC351ECE70 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=iw_IL -Dtests.timezone=Africa/Accra -Dtests.file.encoding=US-ASCII
   [junit4] FAILURE 0.23s J0 | TestNonNRTOpen.testReaderIsNotNRT <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: SOLR-5815? : wrong maxDoc: core=org.apache.solr.core.SolrCore@1fa713e searcher=Searcher@1e6e32[collection1] main{UninvertingDirectoryReader(Uninverting(_1(5.0):C1) Uninverting(_2(5.0):C1))} expected:<3> but was:<2>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([304454EC351ECE70:85C2356B8ADF7C84]:0)
   [junit4]    > 	at org.apache.solr.core.TestNonNRTOpen.assertNotNRT(TestNonNRTOpen.java:142)
   [junit4]    > 	at org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT(TestNonNRTOpen.java:100)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 196338 T434 oas.SolrTestCaseJ4.setUp ###Starting testSharedCores
   [junit4]   2> ASYNC  NEW_CORE C358 name=collection1 org.apache.solr.core.SolrCore@1fa713e
   [junit4]   2> 196338 T434 C358 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 196339 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
   [junit4]   2> 196340 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
   [junit4]   2> 196341 T434 C358 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 196365 T434 C358 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_5,generation=5}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_6,generation=6}
   [junit4]   2> 196365 T434 C358 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
   [junit4]   2> 196370 T434 C358 oass.SolrIndexSearcher.<init> Opening Searcher@5310b0[collection1] main
   [junit4]   2> 196370 T434 C358 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 196371 T442 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5310b0[collection1] main{UninvertingDirectoryReader(Uninverting(_4(5.0):C1))}
   [junit4]   2> 196371 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 30
   [junit4]   2> 196372 T434 C358 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 196373 T434 C358 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 196374 T434 C358 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 196374 T434 C358 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 196374 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 2
   [junit4]   2> 196375 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
   [junit4]   2> 196376 T434 C358 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 196425 T434 C358 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_6,generation=6}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_7,generation=7}
   [junit4]   2> 196425 T434 C358 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
   [junit4]   2> 196429 T434 C358 oass.SolrIndexSearcher.<init> Opening Searcher@18c20f2[collection1] main
   [junit4]   2> 196429 T434 C358 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 196429 T442 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@18c20f2[collection1] main{UninvertingDirectoryReader(Uninverting(_4(5.0):C1) Uninverting(_5(5.0):C1))}
   [junit4]   2> 196430 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 54
   [junit4]   2> 196431 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
   [junit4]   2> 196432 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
   [junit4]   2> 196432 T434 C358 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 196453 T434 C358 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_7,generation=7}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_8,generation=8}
   [junit4]   2> 196454 T434 C358 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
   [junit4]   2> 196458 T434 C358 oass.SolrIndexSearcher.<init> Opening Searcher@129a30[collection1] main
   [junit4]   2> 196459 T434 C358 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 196459 T442 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@129a30[collection1] main{UninvertingDirectoryReader(Uninverting(_4(5.0):C1) Uninverting(_5(5.0):C1) Uninverting(_6(5.0):C2))}
   [junit4]   2> 196459 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 27
   [junit4]   2> 196460 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=foo2:doc} 0 0
   [junit4]   2> 196461 T434 C358 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 196483 T434 C358 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_8,generation=8}
   [junit4]   2> 		commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index,segFN=segments_9,generation=9}
   [junit4]   2> 196484 T434 C358 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
   [junit4]   2> 196488 T434 C358 oass.SolrIndexSearcher.<init> Opening Searcher@160d93b[collection1] main
   [junit4]   2> 196489 T434 C358 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 196489 T442 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@160d93b[collection1] main{UninvertingDirectoryReader(Uninverting(_4(5.0):C1) Uninverting(_5(5.0):C1) Uninverting(_6(5.0):C2/1:delGen=1))}
   [junit4]   2> 196489 T434 C358 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 29
   [junit4]   2> 196490 T434 oas.SolrTestCaseJ4.tearDown ###Ending testSharedCores
   [junit4]   2> 196491 T434 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 196491 T434 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=22463590
   [junit4]   2> 196491 T434 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1fa713e
   [junit4]   2> 196492 T434 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> 196492 T434 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 196492 T434 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 196492 T434 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 196494 T434 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 196494 T434 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 196494 T434 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001;done=false>>]
   [junit4]   2> 196495 T434 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001
   [junit4]   2> 196495 T434 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 196495 T434 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001/init-core-data-001/index
   [junit4]   2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./temp/solr.core.TestNonNRTOpen-304454EC351ECE70-001
   [junit4]   2> NOTE: test params are: codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=22), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=22)), sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=iw_IL, timezone=Africa/Accra
   [junit4]   2> NOTE: Linux 3.13.0-32-generic i386/Oracle Corporation 1.8.0_11 (32-bit)/cpus=8,threads=1,free=272757152,total=491782144
   [junit4]   2> NOTE: All tests run in this JVM: [ModifyConfFileTest, TestSolrQueryParserResource, TestOverriddenPrefixQueryForCustomFieldType, BasicDistributedZkTest, SpellCheckCollatorTest, HdfsChaosMonkeySafeLeaderTest, TestCopyFieldCollectionResource, TestStressVersions, TestNonNRTOpen]
   [junit4] Completed on J0 in 0.72s, 2 tests, 1 failure <<< FAILURES!

[...truncated 1207 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:467: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:447: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:45: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:496: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1298: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:922: There were test failures: 419 suites, 1733 tests, 1 failure, 39 ignored (18 assumptions)

Total time: 90 minutes 12 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 32bit/jdk1.8.0_11 -server -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any