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/12/23 11:29:13 UTC
[JENKINS] Lucene-Solr-5.x-Linux (64bit/jdk1.8.0_40-ea-b09) - Build
# 11625 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/11625/
Java: 64bit/jdk1.8.0_40-ea-b09 -XX:-UseCompressedOops -XX:+UseSerialGC (asserts: true)
1 tests failed.
FAILED: org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT
Error Message:
SOLR-5815? : wrong maxDoc: core=org.apache.solr.core.SolrCore@2e1ac03a searcher=Searcher@4cba79d8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.0.0):c1) Uninverting(_5(5.0.0):c1)))} expected:<3> but was:<2>
Stack Trace:
java.lang.AssertionError: SOLR-5815? : wrong maxDoc: core=org.apache.solr.core.SolrCore@2e1ac03a searcher=Searcher@4cba79d8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.0.0):c1) Uninverting(_5(5.0.0):c1)))} expected:<3> but was:<2>
at __randomizedtesting.SeedInfo.seed([D15989A452DD41E1:64DFE823ED1CF315]: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:497)
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:54)
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 10291 lines...]
[junit4] Suite: org.apache.solr.core.TestNonNRTOpen
[junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001
[junit4] 2> 2624083 T9652 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
[junit4] 2> 2624083 T9652 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 2624083 T9652 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 2624084 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 2624084 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 2624084 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 2624113 T9652 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 2624121 T9652 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 2624122 T9652 oass.IndexSchema.readSchema Reading Solr Schema from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-minimal.xml
[junit4] 2> 2624123 T9652 oass.IndexSchema.readSchema [null] Schema name=minimal
[junit4] 2> 2624126 T9652 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 2624126 T9652 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2624126 T9652 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
[junit4] 2> 2624127 T9652 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/'
[junit4] 2> 2624142 T9652 oasc.CoreContainer.<init> New CoreContainer 1119844127
[junit4] 2> 2624143 T9652 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/]
[junit4] 2> 2624143 T9652 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 2624143 T9652 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 2624143 T9652 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 2624143 T9652 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2624144 T9652 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 2624144 T9652 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2624144 T9652 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2624144 T9652 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2624144 T9652 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2624144 T9652 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2624146 T9652 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 2624147 T9652 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2624147 T9652 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2624147 T9652 oasc.CoreContainer.load Host Name:
[junit4] 2> 2624149 T9653 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 2624150 T9653 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 2624150 T9653 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 2624150 T9653 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 2624165 T9653 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 2624181 T9653 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 2624181 T9653 oass.IndexSchema.readSchema Reading Solr Schema from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-minimal.xml
[junit4] 2> 2624183 T9653 oass.IndexSchema.readSchema [collection1] Schema name=minimal
[junit4] 2> 2624184 T9653 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 2624185 T9653 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
[junit4] 2> 2624185 T9653 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 2624185 T9653 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/
[junit4] 2> 2624185 T9653 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2624186 T9653 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001
[junit4] 2> 2624186 T9653 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index/
[junit4] 2> 2624186 T9653 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index' doesn't exist. Creating new index...
[junit4] 2> 2624187 T9653 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index
[junit4] 2> 2624204 T9653 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_1,generation=1}
[junit4] 2> 2624204 T9653 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2624205 T9653 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2624205 T9653 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624205 T9653 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624206 T9653 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624206 T9653 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 2624206 T9653 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 2624206 T9653 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 2624206 T9653 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 2624206 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 2624207 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 2624207 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 2624207 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 2624207 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 2624207 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 2624208 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 2624208 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 2624208 T9653 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 2624208 T9653 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2624208 T9653 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2624210 T9653 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624210 T9653 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624211 T9653 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624211 T9653 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624212 T9653 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2624212 T9653 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2624213 T9653 oass.SolrIndexSearcher.<init> Opening Searcher@14985aab[collection1] main
[junit4] 2> 2624213 T9653 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 2624213 T9653 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 2624213 T9653 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 2624213 T9653 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 2624214 T9653 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 2624214 T9653 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 2624214 T9653 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2624214 T9653 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2624214 T9654 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14985aab[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2624215 T9652 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> ASYNC NEW_CORE C3637 name=collection1 org.apache.solr.core.SolrCore@2d126ed7
[junit4] 2> 2624217 T9652 C3637 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_1,generation=1}
[junit4] 2> 2624218 T9652 C3637 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 2624219 T9652 C3637 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 3
[junit4] 2> 2624220 T9652 C3637 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2624303 T9652 C3637 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_1,generation=1}
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_2,generation=2}
[junit4] 2> 2624304 T9652 C3637 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 2624309 T9652 C3637 oass.SolrIndexSearcher.<init> Opening Searcher@15cfd264[collection1] main
[junit4] 2> 2624309 T9652 C3637 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2624310 T9654 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15cfd264[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1)))}
[junit4] 2> 2624310 T9652 C3637 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 90
[junit4] 2> 2624310 T9652 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 2624311 T9652 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1119844127
[junit4] 2> 2624311 T9652 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2d126ed7
[junit4] 2> 2624311 T9652 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> 2624311 T9652 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2624311 T9652 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2624312 T9652 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2624312 T9652 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2624312 T9652 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2624313 T9652 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index;done=false>>]
[junit4] 2> 2624313 T9652 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index
[junit4] 2> 2624313 T9652 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001;done=false>>]
[junit4] 2> 2624313 T9652 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001
[junit4] 2> 2624313 T9652 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 2624314 T9652 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 2624314 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 2624314 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 2624314 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 2624328 T9652 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 2624333 T9652 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 2624334 T9652 oass.IndexSchema.readSchema Reading Solr Schema from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-minimal.xml
[junit4] 2> 2624336 T9652 oass.IndexSchema.readSchema [null] Schema name=minimal
[junit4] 2> 2624337 T9652 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 2624338 T9652 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2624338 T9652 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
[junit4] 2> 2624338 T9652 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/'
[junit4] 2> 2624352 T9652 oasc.CoreContainer.<init> New CoreContainer 1947538918
[junit4] 2> 2624352 T9652 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/]
[junit4] 2> 2624353 T9652 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 2624353 T9652 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 2624353 T9652 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 2624353 T9652 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 2624354 T9652 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000
[junit4] 2> 2624354 T9652 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 2624354 T9652 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 2624354 T9652 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 2624354 T9652 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 2624354 T9652 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 2624355 T9652 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 2624356 T9652 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2624356 T9652 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2624357 T9652 oasc.CoreContainer.load Host Name:
[junit4] 2> 2624358 T9656 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 2624360 T9656 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 2624360 T9656 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 2624360 T9656 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 2624375 T9656 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 2624395 T9656 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 2624396 T9656 oass.IndexSchema.readSchema Reading Solr Schema from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-minimal.xml
[junit4] 2> 2624397 T9656 oass.IndexSchema.readSchema [collection1] Schema name=minimal
[junit4] 2> 2624400 T9656 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 2624400 T9656 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
[junit4] 2> 2624401 T9656 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 2624401 T9656 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/
[junit4] 2> 2624401 T9656 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2624402 T9656 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001
[junit4] 2> 2624402 T9656 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index/
[junit4] 2> 2624403 T9656 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2624404 T9656 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624404 T9656 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624404 T9656 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624404 T9656 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 2624405 T9656 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 2624405 T9656 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 2624405 T9656 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 2624406 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 2624406 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 2624406 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 2624406 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 2624407 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 2624407 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 2624407 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 2624407 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 2624408 T9656 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 2624408 T9656 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2624408 T9656 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2624409 T9656 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624409 T9656 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624410 T9656 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624410 T9656 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624411 T9656 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2624411 T9656 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2624412 T9656 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index
[junit4] 2> 2624413 T9656 oass.SolrIndexSearcher.<init> Opening Searcher@516bfd08[collection1] main
[junit4] 2> 2624413 T9656 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 2624413 T9656 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 2624414 T9656 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 2624414 T9656 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 2624414 T9656 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 2624414 T9656 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 2624414 T9656 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2624414 T9656 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 2624414 T9657 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@516bfd08[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c1)))}
[junit4] 2> 2624415 T9652 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 2624416 T9652 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=1 of core=org.apache.solr.core.SolrCore@9010407
[junit4] 2> 2624421 T9652 oas.SolrTestCaseJ4.setUp ###Starting testSharedCores
[junit4] 2> ASYNC NEW_CORE C3638 name=collection1 org.apache.solr.core.SolrCore@9010407
[junit4] 2> 2624421 T9652 C3638 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 2624424 T9652 C3638 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_2,generation=2}
[junit4] 2> 2624425 T9652 C3638 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 2624425 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 4
[junit4] 2> 2624426 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
[junit4] 2> 2624427 T9652 C3638 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2624443 T9652 C3638 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_2,generation=2}
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_3,generation=3}
[junit4] 2> 2624444 T9652 C3638 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 2624446 T9652 C3638 oass.SolrIndexSearcher.<init> Opening Searcher@6b39efdc[collection1] main
[junit4] 2> 2624446 T9652 C3638 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2624446 T9657 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b39efdc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.0.0):c1)))}
[junit4] 2> 2624447 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 20
[junit4] 2> 2624447 T9652 C3638 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2624448 T9652 C3638 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 2624449 T9652 C3638 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 2624449 T9652 C3638 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2624449 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 2
[junit4] 2> 2624450 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
[junit4] 2> 2624451 T9652 C3638 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2624483 T9652 C3638 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_3,generation=3}
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_4,generation=4}
[junit4] 2> 2624484 T9652 C3638 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 2624487 T9652 C3638 oass.SolrIndexSearcher.<init> Opening Searcher@3f496757[collection1] main
[junit4] 2> 2624488 T9652 C3638 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2624488 T9657 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3f496757[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.0.0):c1) Uninverting(_2(5.0.0):c1)))}
[junit4] 2> 2624488 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 37
[junit4] 2> 2624490 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
[junit4] 2> 2624491 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
[junit4] 2> 2624491 T9652 C3638 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2624513 T9652 C3638 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_4,generation=4}
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_5,generation=5}
[junit4] 2> 2624513 T9652 C3638 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 2624517 T9652 C3638 oass.SolrIndexSearcher.<init> Opening Searcher@103e2622[collection1] main
[junit4] 2> 2624518 T9652 C3638 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2624518 T9657 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@103e2622[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.0.0):c1) Uninverting(_2(5.0.0):c1) Uninverting(_3(5.0.0):c2)))}
[junit4] 2> 2624518 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 27
[junit4] 2> 2624520 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=foo2:doc} 0 1
[junit4] 2> 2624521 T9652 C3638 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2624532 T9652 C3638 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_5,generation=5}
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_6,generation=6}
[junit4] 2> 2624533 T9652 C3638 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 2624535 T9652 C3638 oass.SolrIndexSearcher.<init> Opening Searcher@a7fa8d6[collection1] main
[junit4] 2> 2624536 T9652 C3638 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2624536 T9657 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a7fa8d6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.0.0):c1) Uninverting(_2(5.0.0):c1) Uninverting(_3(5.0.0):c2/1:delGen=1)))}
[junit4] 2> 2624536 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 16
[junit4] 2> 2624537 T9652 oas.SolrTestCaseJ4.tearDown ###Ending testSharedCores
[junit4] 2> 2624541 T9652 oas.SolrTestCaseJ4.setUp ###Starting testReaderIsNotNRT
[junit4] 2> 2624542 T9652 C3638 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 2624542 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 2624544 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
[junit4] 2> 2624545 T9652 C3638 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2624563 T9652 C3638 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_6,generation=6}
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_7,generation=7}
[junit4] 2> 2624563 T9652 C3638 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 2624567 T9652 C3638 oass.SolrIndexSearcher.<init> Opening Searcher@3c823c29[collection1] main
[junit4] 2> 2624567 T9652 C3638 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2624567 T9657 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3c823c29[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.0.0):c1)))}
[junit4] 2> 2624568 T9652 C3638 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 24
[junit4] 2> 2624568 T9652 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=1 of core=org.apache.solr.core.SolrCore@9010407
[junit4] 2> 2624569 T9652 oasc.TestNonNRTOpen.testReaderIsNotNRT Reloading core: org.apache.solr.core.SolrCore@9010407
[junit4] 2> 2624569 T9652 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 2624570 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 2624570 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 2624571 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 2624591 T9652 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 2624598 T9652 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 2624598 T9652 oass.IndexSchema.readSchema Reading Solr Schema from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-minimal.xml
[junit4] 2> 2624600 T9652 oass.IndexSchema.readSchema [collection1] Schema name=minimal
[junit4] 2> 2624602 T9652 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 2624603 T9652 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
[junit4] 2> 2624603 T9652 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/
[junit4] 2> 2624604 T9652 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2624604 T9652 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index/
[junit4] 2> 2624605 T9652 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2624605 T9652 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624605 T9652 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624605 T9652 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624606 T9652 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 2624606 T9652 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 2624606 T9652 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 2624606 T9652 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 2624607 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 2624607 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 2624607 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 2624607 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 2624608 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 2624608 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 2624608 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 2624608 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 2624609 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 2624609 T9652 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2624609 T9652 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2624611 T9652 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624611 T9652 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624612 T9652 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624613 T9652 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624614 T9652 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2624614 T9652 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2624615 T9652 oass.SolrIndexSearcher.<init> Opening Searcher@7658a805[collection1] main
[junit4] 2> 2624616 T9652 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 2624616 T9652 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 2624616 T9652 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 2624616 T9652 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 2624617 T9652 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 2624617 T9652 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 2624617 T9652 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2624617 T9652 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 2624617 T9652 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 2624618 T9652 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 2624617 T9659 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7658a805[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.0.0):c1)))}
[junit4] 2> 2624619 T9652 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_7,generation=7}
[junit4] 2> 2624620 T9652 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 2624620 T9652 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 2624621 T9652 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 2624621 T9652 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 2624621 T9652 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@9010407
[junit4] 2> 2624621 T9652 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=5,autocommits=0,soft autocommits=0,optimizes=1,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=3,cumulative_errors=0}
[junit4] 2> 2624622 T9652 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2624622 T9652 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=1 of core=org.apache.solr.core.SolrCore@3ca470b5
[junit4] 2> ASYNC NEW_CORE C3639 name=collection1 org.apache.solr.core.SolrCore@3ca470b5
[junit4] 2> 2624623 T9652 C3639 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
[junit4] 2> 2624624 T9652 C3639 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2624693 T9652 C3639 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_7,generation=7}
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_8,generation=8}
[junit4] 2> 2624694 T9652 C3639 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 2624696 T9652 C3639 oass.SolrIndexSearcher.<init> Opening Searcher@1ee53b19[collection1] main
[junit4] 2> 2624696 T9652 C3639 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 2624696 T9659 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1ee53b19[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.0.0):c1) Uninverting(_5(5.0.0):c1)))}
[junit4] 2> 2624697 T9652 C3639 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 73
[junit4] 2> 2624697 T9652 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=2 of core=org.apache.solr.core.SolrCore@3ca470b5
[junit4] 2> 2624698 T9652 C3639 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
[junit4] 2> 2624699 T9652 oasc.TestNonNRTOpen.testReaderIsNotNRT Reloading core: org.apache.solr.core.SolrCore@3ca470b5
[junit4] 2> 2624699 T9652 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 2624700 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 2624700 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 2624700 T9652 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 2624730 T9652 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 2624736 T9652 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 2624737 T9652 oass.IndexSchema.readSchema Reading Solr Schema from /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-minimal.xml
[junit4] 2> 2624738 T9652 oass.IndexSchema.readSchema [collection1] Schema name=minimal
[junit4] 2> 2624740 T9652 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 2624740 T9652 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
[junit4] 2> 2624741 T9652 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/
[junit4] 2> 2624741 T9652 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 2624741 T9652 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index/
[junit4] 2> 2624742 T9652 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2624742 T9652 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624743 T9652 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624743 T9652 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 2624743 T9652 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 2624743 T9652 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 2624743 T9652 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 2624744 T9652 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 2624744 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 2624744 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 2624745 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 2624745 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 2624745 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 2624745 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 2624746 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 2624746 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 2624746 T9652 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 2624746 T9652 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 2624746 T9652 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 2624747 T9652 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624748 T9652 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624749 T9652 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624749 T9652 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 2624750 T9652 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 2624750 T9652 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 2624754 T9652 oass.SolrIndexSearcher.<init> Opening Searcher@4cba79d8[collection1] main
[junit4] 2> 2624754 T9652 oasr.ManagedResourceStorage.newStorageIO WARN Cannot write to config directory /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 2624755 T9652 oasr.RestManager.init Initializing RestManager with initArgs: {}
[junit4] 2> 2624755 T9652 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 2624755 T9652 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 2624756 T9652 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 2624756 T9652 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 2624756 T9652 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 2624757 T9652 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 2624757 T9660 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4cba79d8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.0.0):c1) Uninverting(_5(5.0.0):c1)))}
[junit4] 2> 2624757 T9652 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 2624758 T9652 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 2624766 T9652 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_8,generation=8}
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_9,generation=9}
[junit4] 2> 2624767 T9652 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 2624770 T9652 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index,segFN=segments_9,generation=9}
[junit4] 2> 2624771 T9652 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 2624771 T9652 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 2624775 T9652 oass.SolrIndexSearcher.<init> Opening Searcher@ca3e72[collection1] main
[junit4] 2> 2624775 T9652 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 2624775 T9652 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3ca470b5
[junit4] 2> 2624776 T9652 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> 2624777 T9652 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2624777 T9652 oasc.TestNonNRTOpen.assertNotNRT Checking notNRT & maxDoc=3 of core=org.apache.solr.core.SolrCore@2e1ac03a
[junit4] 2> 2624778 T9652 oas.SolrTestCaseJ4.tearDown ###Ending testReaderIsNotNRT
[junit4] 2> 2624779 T9660 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ca3e72[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.0.0):c1) Uninverting(_5(5.0.0):c1) Uninverting(_6(5.0.0):c1)))}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestNonNRTOpen -Dtests.method=testReaderIsNotNRT -Dtests.seed=D15989A452DD41E1 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_YE -Dtests.timezone=Asia/Vientiane -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 0.26s J0 | TestNonNRTOpen.testReaderIsNotNRT <<<
[junit4] > Throwable #1: java.lang.AssertionError: SOLR-5815? : wrong maxDoc: core=org.apache.solr.core.SolrCore@2e1ac03a searcher=Searcher@4cba79d8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.0.0):c1) Uninverting(_5(5.0.0):c1)))} expected:<3> but was:<2>
[junit4] > at __randomizedtesting.SeedInfo.seed([D15989A452DD41E1:64DFE823ED1CF315]: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> 2624801 T9652 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 2624802 T9652 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1947538918
[junit4] 2> 2624802 T9652 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2e1ac03a
[junit4] 2> 2624802 T9652 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 2624802 T9652 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 2624803 T9652 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2624803 T9652 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 2624803 T9652 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 2624804 T9652 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2624804 T9652 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001;done=false>>]
[junit4] 2> 2624804 T9652 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001
[junit4] 2> 2624804 T9652 oasc.CachingDirectoryFactory.closeCacheValue looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index;done=false>>]
[junit4] 2> 2624804 T9652 oasc.CachingDirectoryFactory.close Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001/init-core-data-001/index
[junit4] 2> NOTE: leaving temporary files on disk at: /mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestNonNRTOpen-D15989A452DD41E1-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {bazz=Lucene50(blocksize=128), foo=Lucene50(blocksize=128), baz=Lucene50(blocksize=128), foo2=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=ar_YE, timezone=Asia/Vientiane
[junit4] 2> NOTE: Linux 3.13.0-43-generic amd64/Oracle Corporation 1.8.0_40-ea (64-bit)/cpus=8,threads=1,free=96722464,total=426790912
[junit4] 2> NOTE: All tests run in this JVM: [RequiredFieldsTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverseerTest, TestIndexingPerformance, LeaderInitiatedRecoveryOnCommitTest, ZkControllerTest, TestPartialUpdateDeduplication, DistributedFacetPivotSmallTest, TestLRUCache, TestCollectionAPI, TestHashPartitioner, FacetPivotSmallTest, EnumFieldTest, TestStressVersions, TestSortingResponseWriter, ClusterStateTest, SolrCoreTest, SimpleCollectionCreateDeleteTest, SolrXmlInZkTest, TestXIncludeConfig, TestCursorMarkWithoutUniqueKey, TestImplicitCoreProperties, DefaultValueUpdateProcessorTest, QueryResultKeyTest, TestSweetSpotSimilarityFactory, TestPhraseSuggestions, SolrIndexConfigTest, ResourceLoaderTest, MergeStrategyTest, TestManagedSynonymFilterFactory, TestQuerySenderListener, VMParamsZkACLAndCredentialsProvidersTest, DistributedFacetPivotLargeTest, AnalysisAfterCoreReloadTest, TestCollationField, TestTolerantSearch, SolrCoreCheckLockOnStartupTest, SolrInfoMBeanTest, ParsingFieldUpdateProcessorsTest, TestWriterPerf, DistanceFunctionTest, NotRequiredUniqueKeyTest, MultiThreadedOCPTest, TestIntervalFaceting, ZkCLITest, RequestHandlersTest, TestSurroundQueryParser, SharedFSAutoReplicaFailoverUtilsTest, TestFastWriter, TestExpandComponent, HdfsUnloadDistributedZkTest, MinimalSchemaTest, TestLazyCores, RecoveryZkTest, TestSolrXml, TestCustomSort, TestDistributedSearch, HdfsDirectoryTest, TestCodecSupport, SolrIndexSplitterTest, TestReplicaProperties, HighlighterConfigTest, TestReplicationHandlerBackup, LukeRequestHandlerTest, TestSearcherReuse, IndexSchemaRuntimeFieldTest, TestCSVLoader, TestSolrDeletionPolicy2, TestShortCircuitedRequests, TestIndexSearcher, AddSchemaFieldsUpdateProcessorFactoryTest, TestMaxScoreQueryParser, TestStressReorder, TestArbitraryIndexDir, TestAddFieldRealTimeGet, BlockCacheTest, SimpleFacetsTest, DistributedQueryElevationComponentTest, LeaderElectionTest, DeleteReplicaTest, DocValuesTest, SuggesterWFSTTest, UUIDUpdateProcessorFallbackTest, TestDynamicFieldCollectionResource, SliceStateTest, UniqFieldsUpdateProcessorFactoryTest, HttpPartitionTest, HdfsBasicDistributedZkTest, DistributedQueueTest, NoCacheHeaderTest, ShowFileRequestHandlerTest, SolrTestCaseJ4Test, PluginInfoTest, DistributedQueryComponentOptimizationTest, TestHighlightDedupGrouping, UnloadDistributedZkTest, BasicDistributedZkTest, DistributedQueryComponentCustomSortTest, TestWordDelimiterFilterFactory, OutputWriterTest, QueryElevationComponentTest, HighlighterMaxOffsetTest, SoftAutoCommitTest, SuggesterTest, CoreAdminCreateDiscoverTest, DistributedSpellCheckComponentTest, TestCSVResponseWriter, TestStandardQParsers, OverseerRolesTest, TestFastOutputStream, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, SyncSliceTest, FullSolrCloudDistribCmdsTest, ClusterStateUpdateTest, TestRandomFaceting, TestRandomDVFaceting, TestFaceting, TestRecovery, TestJoin, HardAutoCommitTest, DistributedTermsComponentTest, TestRangeQuery, TestCoreContainer, TestGroupingSearch, SolrCmdDistributorTest, PeerSyncTest, ConvertedLegacyTest, TestFiltering, PolyFieldTest, TestPseudoReturnFields, TestAtomicUpdateErrorCases, DocValuesMultiTest, DebugComponentTest, CacheHeaderTest, StandardRequestHandlerTest, TestQueryTypes, TestOmitPositions, XmlUpdateRequestHandlerTest, PathHierarchyTokenizerFactoryTest, FieldAnalysisRequestHandlerTest, SolrPluginUtilsTest, UpdateRequestProcessorFactoryTest, TestAnalyzedSuggestions, PingRequestHandlerTest, SearchHandlerTest, TestBinaryResponseWriter, TestQuerySenderNoQuery, BadComponentTest, TestMergePolicyConfig, MultiTermTest, TestDocSet, TestBinaryField, TestSearchPerf, NumericFieldsTest, TestElisionMultitermQuery, TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, TestSolrCoreProperties, TestCharFilters, TestPerFieldSimilarity, TestLMJelinekMercerSimilarityFactory, TestDefaultSimilarityFactory, TestJmxMonitoredMap, TestFastLRUCache, ChaosMonkeyNothingIsSafeTest, AliasIntegrationTest, ConnectionManagerTest, CustomCollectionTest, DeleteShardTest, DistribCursorPagingTest, OverriddenZkACLAndCredentialsProvidersTest, ReplicationFactorTest, TestLeaderElectionZkExpiry, TestModifyConfFiles, HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest, HdfsRecoveryZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, TestClusterStateMutator, ZkStateWriterTest, CachingDirectoryFactoryTest, TestNonNRTOpen]
[junit4] Completed on J0 in 0.74s, 2 tests, 1 failure <<< FAILURES!
[...truncated 239 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:529: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:477: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:190: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:508: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1363: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:970: There were test failures: 452 suites, 1852 tests, 1 failure, 32 ignored (22 assumptions)
Total time: 86 minutes 51 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40-ea-b09 -XX:-UseCompressedOops -XX:+UseSerialGC (asserts: true)
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any