You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/01/10 06:52:58 UTC
[JENKINS] Lucene-Solr-4.x-Windows (32bit/jdk1.7.0_45) - Build #
3581 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3581/
Java: 32bit/jdk1.7.0_45 -client -XX:+UseSerialGC
1 tests failed.
REGRESSION: org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT
Error Message:
expected:<3> but was:<2>
Stack Trace:
java.lang.AssertionError: expected:<3> but was:<2>
at __randomizedtesting.SeedInfo.seed([AC36D4CE438CD5C:BF450CCB5BF97FA8]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.core.TestNonNRTOpen.assertNotNRT(TestNonNRTOpen.java:133)
at org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT(TestNonNRTOpen.java:94)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at java.lang.Thread.run(Thread.java:744)
Build Log:
[...truncated 10252 lines...]
[junit4] Suite: org.apache.solr.core.TestNonNRTOpen
[junit4] 2> 707004 T2050 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930
[junit4] 2> 707004 T2050 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 707007 T2050 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 707007 T2050 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 707088 T2050 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 707144 T2050 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 707145 T2050 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
[junit4] 2> 707150 T2050 oass.IndexSchema.readSchema [null] Schema name=minimal
[junit4] 2> 707165 T2050 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 707167 T2050 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 707167 T2050 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 707168 T2050 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 707180 T2050 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 707181 T2050 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 707181 T2050 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 707262 T2050 oasc.CoreContainer.<init> New CoreContainer 1011455
[junit4] 2> 707262 T2050 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
[junit4] 2> 707263 T2050 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 707264 T2050 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 707264 T2050 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 707264 T2050 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 707264 T2050 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 707264 T2050 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 707264 T2050 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 707264 T2050 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 707264 T2050 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 707269 T2050 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 707269 T2050 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 707269 T2050 oasc.CoreContainer.load Host Name:
[junit4] 2> 707274 T2051 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 707275 T2051 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 707275 T2051 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 707275 T2051 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 707324 T2051 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 707381 T2051 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 707382 T2051 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
[junit4] 2> 707388 T2051 oass.IndexSchema.readSchema [collection1] Schema name=minimal
[junit4] 2> 707402 T2051 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 707403 T2051 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 707403 T2051 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\
[junit4] 2> 707403 T2051 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 707404 T2051 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930
[junit4] 2> 707404 T2051 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\index/
[junit4] 2> 707405 T2051 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\index' doesn't exist. Creating new index...
[junit4] 2> 707405 T2051 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index
[junit4] 2> 707409 T2051 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_1,generation=1}
[junit4] 2> 707409 T2051 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 707410 T2051 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 707410 T2051 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 707411 T2051 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 707416 T2051 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 707421 T2051 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 707421 T2051 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 707421 T2051 oass.SolrIndexSearcher.<init> Opening Searcher@4f19c4 main
[junit4] 2> 707422 T2051 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 707422 T2052 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4f19c4 main{StandardDirectoryReader(segments_1:1)}
[junit4] 2> 707424 T2050 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> ASYNC NEW_CORE C1365 name=collection1 org.apache.solr.core.SolrCore@105a7b
[junit4] 2> 707433 T2050 C1365 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_1,generation=1}
[junit4] 2> 707433 T2050 C1365 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 707435 T2050 C1365 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 5
[junit4] 2> 707444 T2050 C1365 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 707457 T2050 C1365 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_1,generation=1}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_2,generation=2}
[junit4] 2> 707457 T2050 C1365 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 707467 T2050 C1365 oass.SolrIndexSearcher.<init> Opening Searcher@b37a6b main
[junit4] 2> 707467 T2050 C1365 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 707468 T2052 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b37a6b main{StandardDirectoryReader(segments_2:3 _0(4.7):C1)}
[junit4] 2> 707468 T2050 C1365 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 24
[junit4] 2> 707472 T2050 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 707472 T2050 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1011455
[junit4] 2> 707473 T2050 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@105a7b
[junit4] 2> 707473 T2050 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> 707473 T2050 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 707473 T2050 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 707473 T2050 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 707474 T2050 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 707474 T2050 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 707474 T2050 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index;done=false>>]
[junit4] 2> 707474 T2050 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index
[junit4] 2> 707474 T2050 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930;done=false>>]
[junit4] 2> 707474 T2050 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930
[junit4] 2> NOTE: per solr.test.leavedatadir, dataDir will not be removed: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930
[junit4] 2> 707476 T2050 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 707476 T2050 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 707477 T2050 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 707477 T2050 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 707554 T2050 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 707612 T2050 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 707613 T2050 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
[junit4] 2> 707619 T2050 oass.IndexSchema.readSchema [null] Schema name=minimal
[junit4] 2> 707634 T2050 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 707636 T2050 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 707636 T2050 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 707637 T2050 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 707652 T2050 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 707653 T2050 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 707653 T2050 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 707730 T2050 oasc.CoreContainer.<init> New CoreContainer 11442520
[junit4] 2> 707731 T2050 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\]
[junit4] 2> 707732 T2050 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 707732 T2050 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 707732 T2050 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 707733 T2050 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 707733 T2050 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 707733 T2050 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 707733 T2050 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 707734 T2050 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 707734 T2050 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 707737 T2050 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 707738 T2050 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 707738 T2050 oasc.CoreContainer.load Host Name:
[junit4] 2> 707746 T2054 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 707746 T2054 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 707746 T2054 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 707746 T2054 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 707795 T2054 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 707855 T2054 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 707856 T2054 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
[junit4] 2> 707861 T2054 oass.IndexSchema.readSchema [collection1] Schema name=minimal
[junit4] 2> 707875 T2054 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 707877 T2054 oasc.SolrCore.initDirectoryFactory solr.StandardDirectoryFactory
[junit4] 2> 707878 T2054 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\
[junit4] 2> 707878 T2054 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 707878 T2054 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930
[junit4] 2> 707878 T2054 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\index/
[junit4] 2> 707880 T2054 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 707881 T2054 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 707882 T2054 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 707889 T2054 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 707892 T2054 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 707892 T2054 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 707892 T2054 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index
[junit4] 2> 707894 T2054 oass.SolrIndexSearcher.<init> Opening Searcher@1fd20e2 main
[junit4] 2> 707894 T2054 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 707894 T2055 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1fd20e2 main{StandardDirectoryReader(segments_2:3 _0(4.7):C1)}
[junit4] 2> 707896 T2050 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 707899 T2050 oas.SolrTestCaseJ4.setUp ###Starting testSharedCores
[junit4] 2> ASYNC NEW_CORE C1366 name=collection1 org.apache.solr.core.SolrCore@ef4fb3
[junit4] 2> 707906 T2050 C1366 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 707908 T2050 C1366 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_2,generation=2}
[junit4] 2> 707909 T2050 C1366 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 707909 T2050 C1366 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 3
[junit4] 2> 707919 T2050 C1366 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
[junit4] 2> 707927 T2050 C1366 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 707936 T2050 C1366 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_2,generation=2}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_3,generation=3}
[junit4] 2> 707936 T2050 C1366 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 707949 T2050 C1366 oass.SolrIndexSearcher.<init> Opening Searcher@10d5016 main
[junit4] 2> 707950 T2050 C1366 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 707950 T2055 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10d5016 main{StandardDirectoryReader(segments_3:6 _1(4.7):C1)}
[junit4] 2> 707950 T2050 C1366 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 23
[junit4] 2> ASYNC NEW_CORE C1367 name=collection1 org.apache.solr.core.SolrCore@ef4fb3
[junit4] 2> 707964 T2050 C1367 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 707983 T2050 C1367 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_3,generation=3}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_4,generation=4}
[junit4] 2> 707983 T2050 C1367 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 707995 T2050 C1367 oass.SolrIndexSearcher.<init> Opening Searcher@1b99d1c main
[junit4] 2> 707996 T2050 C1367 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 707996 T2055 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b99d1c main{StandardDirectoryReader(segments_4:8 _2(4.7):C1)}
[junit4] 2> 707997 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 33
[junit4] 2> 708006 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
[junit4] 2> 708017 T2050 C1367 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 708032 T2050 C1367 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_4,generation=4}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_5,generation=5}
[junit4] 2> 708033 T2050 C1367 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 708041 T2050 C1367 oass.SolrIndexSearcher.<init> Opening Searcher@1f3638e main
[junit4] 2> 708041 T2050 C1367 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 708041 T2055 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f3638e main{StandardDirectoryReader(segments_5:10 _2(4.7):C1 _3(4.7):C1)}
[junit4] 2> 708041 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 24
[junit4] 2> 708053 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
[junit4] 2> 708061 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
[junit4] 2> 708069 T2050 C1367 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 708080 T2050 C1367 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_5,generation=5}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_6,generation=6}
[junit4] 2> 708080 T2050 C1367 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 708089 T2050 C1367 oass.SolrIndexSearcher.<init> Opening Searcher@23e285 main
[junit4] 2> 708090 T2050 C1367 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 708090 T2055 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@23e285 main{StandardDirectoryReader(segments_6:12 _2(4.7):C1 _3(4.7):C1 _4(4.7):C2)}
[junit4] 2> 708091 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 22
[junit4] 2> 708101 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=foo2:doc} 0 1
[junit4] 2> 708109 T2050 C1367 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 708116 T2050 C1367 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_6,generation=6}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_7,generation=7}
[junit4] 2> 708117 T2050 C1367 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 708126 T2050 C1367 oass.SolrIndexSearcher.<init> Opening Searcher@537751 main
[junit4] 2> 708126 T2050 C1367 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 708126 T2055 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@537751 main{StandardDirectoryReader(segments_7:13 _2(4.7):C1 _3(4.7):C1 _4(4.7):C2/1:delGen=1)}
[junit4] 2> 708127 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 18
[junit4] 2> 708131 T2050 oas.SolrTestCaseJ4.tearDown ###Ending testSharedCores
[junit4] 2> 708135 T2050 oas.SolrTestCaseJ4.setUp ###Starting testReaderIsNotNRT
[junit4] 2> 708142 T2050 C1367 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 708143 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1
[junit4] 2> 708152 T2050 C1367 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
[junit4] 2> ASYNC NEW_CORE C1368 name=collection1 org.apache.solr.core.SolrCore@ef4fb3
[junit4] 2> 708165 T2050 C1368 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 708175 T2050 C1368 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_7,generation=7}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_8,generation=8}
[junit4] 2> 708175 T2050 C1368 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 708201 T2050 C1368 oass.SolrIndexSearcher.<init> Opening Searcher@6aee33 main
[junit4] 2> 708202 T2050 C1368 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 708202 T2055 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6aee33 main{StandardDirectoryReader(segments_8:16 _5(4.7):C1)}
[junit4] 2> 708204 T2050 C1368 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 39
[junit4] 2> 708208 T2050 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 708209 T2050 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 708211 T2050 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 708212 T2050 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 708287 T2050 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 708344 T2050 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 708345 T2050 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
[junit4] 2> 708350 T2050 oass.IndexSchema.readSchema [collection1] Schema name=minimal
[junit4] 2> 708367 T2050 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 708369 T2050 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\
[junit4] 2> 708369 T2050 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 708369 T2050 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\index/
[junit4] 2> 708371 T2050 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 708371 T2050 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 708372 T2050 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 708378 T2050 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 708381 T2050 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 708381 T2050 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 708384 T2050 oass.SolrIndexSearcher.<init> Opening Searcher@1e48823 main
[junit4] 2> 708385 T2050 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 708385 T2058 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e48823 main{StandardDirectoryReader(segments_8:16 _5(4.7):C1)}
[junit4] 2> 708386 T2050 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 708386 T2050 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 708400 T2050 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_8,generation=8}
[junit4] 2> 708400 T2050 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 708401 T2050 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 708402 T2050 oass.SolrIndexSearcher.<init> Opening Searcher@90a702 main
[junit4] 2> 708403 T2058 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@90a702 main{StandardDirectoryReader(segments_8:16 _5(4.7):C1)}
[junit4] 2> 708404 T2050 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 708404 T2050 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@ef4fb3
[junit4] 2> 708404 T2050 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> 708405 T2050 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> ASYNC NEW_CORE C1369 name=collection1 org.apache.solr.core.SolrCore@c49778
[junit4] 2> 708417 T2050 C1369 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 1
[junit4] 2> 708424 T2050 C1369 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 708435 T2050 C1369 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_8,generation=8}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_9,generation=9}
[junit4] 2> 708435 T2050 C1369 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 708444 T2050 C1369 oass.SolrIndexSearcher.<init> Opening Searcher@1fe87a9 main
[junit4] 2> 708444 T2050 C1369 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 708444 T2058 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1fe87a9 main{StandardDirectoryReader(segments_9:18 _5(4.7):C1 _6(4.7):C1)}
[junit4] 2> 708445 T2050 C1369 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 21
[junit4] 2> 708456 T2050 C1369 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[(null)]} 0 0
[junit4] 2> 708458 T2050 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 708458 T2050 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 708460 T2050 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 708462 T2050 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 708544 T2050 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 708597 T2050 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 708598 T2050 oass.IndexSchema.readSchema Reading Solr Schema from schema-minimal.xml
[junit4] 2> 708604 T2050 oass.IndexSchema.readSchema [collection1] Schema name=minimal
[junit4] 2> 708625 T2050 oass.IndexSchema.readSchema WARN no uniqueKey specified in schema.
[junit4] 2> 708627 T2050 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\
[junit4] 2> 708627 T2050 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 708627 T2050 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-TestNonNRTOpen-1389330657930\index/
[junit4] 2> 708628 T2050 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 708629 T2050 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 708629 T2050 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 708636 T2050 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 708640 T2050 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 708641 T2050 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 708643 T2050 oass.SolrIndexSearcher.<init> Opening Searcher@ffca31 main
[junit4] 2> 708644 T2050 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter...
[junit4] 2> 708644 T2060 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ffca31 main{StandardDirectoryReader(segments_9:18 _5(4.7):C1 _6(4.7):C1)}
[junit4] 2> 708645 T2050 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1
[junit4] 2> 708645 T2050 oasu.DefaultSolrCoreState.newIndexWriter Closing old IndexWriter... core=collection1
[junit4] 2> 708657 T2050 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_9,generation=9}
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_a,generation=10}
[junit4] 2> 708657 T2050 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
[junit4] 2> 708666 T2050 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index,segFN=segments_a,generation=10}
[junit4] 2> 708667 T2050 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
[junit4] 2> 708667 T2050 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used.
[junit4] 2> 708672 T2050 oass.SolrIndexSearcher.<init> Opening Searcher@13189e0 main
[junit4] 2> 708672 T2050 oasc.CoreContainer.registerCore replacing core: collection1
[junit4] 2> 708672 T2050 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@c49778
[junit4] 2> 708672 T2050 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> 708674 T2050 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 708675 T2050 oas.SolrTestCaseJ4.tearDown ###Ending testReaderIsNotNRT
[junit4] 2> 708676 T2060 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@13189e0 main{StandardDirectoryReader(segments_a:20 _5(4.7):C1 _6(4.7):C1 _7(4.7):C1)}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestNonNRTOpen -Dtests.method=testReaderIsNotNRT -Dtests.seed=AC36D4CE438CD5C -Dtests.slow=true -Dtests.locale=en_PH -Dtests.timezone=Australia/NSW -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.56s | TestNonNRTOpen.testReaderIsNotNRT <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<3> but was:<2>
[junit4] > at __randomizedtesting.SeedInfo.seed([AC36D4CE438CD5C:BF450CCB5BF97FA8]:0)
[junit4] > at org.apache.solr.core.TestNonNRTOpen.assertNotNRT(TestNonNRTOpen.java:133)
[junit4] > at org.apache.solr.core.TestNonNRTOpen.testReaderIsNotNRT(TestNonNRTOpen.java:94)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] 2> 708687 T2050 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 708687 T2050 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=11442520
[junit4] 2> 708688 T2050 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@152d6dd
[junit4] 2> 708688 T2050 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> 708688 T2050 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 708688 T2050 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 708688 T2050 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 708689 T2050 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 708689 T2050 oasc.CachingDirectoryFactory.close Closing StandardDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 708689 T2050 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930 [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930;done=false>>]
[junit4] 2> 708689 T2050 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930
[junit4] 2> 708690 T2050 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index;done=false>>]
[junit4] 2> 708690 T2050 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\solrtest-TestNonNRTOpen-1389330657930\index
[junit4] 2> NOTE: test params are: codec=Lucene3x, sim=DefaultSimilarity, locale=en_PH, timezone=Australia/NSW
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.7.0_45 (32-bit)/cpus=2,threads=1,free=45953104,total=137277440
[junit4] 2> NOTE: All tests run in this JVM: [TestFoldingMultitermQuery, TestPseudoReturnFields, TestLMDirichletSimilarityFactory, TestFuzzyAnalyzedSuggestions, DistributedQueryElevationComponentTest, TestReversedWildcardFilterFactory, TestImplicitCoreProperties, SearchHandlerTest, SpellCheckCollatorTest, TestSchemaNameResource, TestSolrXmlPersistence, TestSchemaSimilarityResource, HdfsChaosMonkeySafeLeaderTest, TestAddFieldRealTimeGet, TestReload, TestHighFrequencyDictionaryFactory, CollectionsAPIDistributedZkTest, TestLMJelinekMercerSimilarityFactory, InfoHandlerTest, TestFastLRUCache, DeleteShardTest, TestPerFieldSimilarity, BasicZkTest, TestClassNameShortening, AlternateDirectoryTest, ScriptEngineTest, SOLR749Test, TestDFRSimilarityFactory, DateMathParserTest, TestCloudManagedSchemaAddField, TestComponentsName, TestFaceting, TestFiltering, TestSystemIdResolver, TermsComponentTest, TestBinaryField, SchemaVersionSpecificBehaviorTest, TestFastOutputStream, TestUpdate, IndexBasedSpellCheckerTest, ResourceLoaderTest, URLClassifyProcessorTest, CurrencyFieldXmlFileTest, TestSchemaVersionResource, TestAnalyzedSuggestions, TestDefaultSearchFieldResource, JsonLoaderTest, DocumentAnalysisRequestHandlerTest, AssignTest, TestGroupingSearch, TestRandomFaceting, TestFieldTypeCollectionResource, ConvertedLegacyTest, FastVectorHighlighterTest, TestCollapseQParserPlugin, ChaosMonkeyNothingIsSafeTest, RecoveryZkTest, DisMaxRequestHandlerTest, SuggesterFSTTest, TestPHPSerializedResponseWriter, SolrIndexConfigTest, TestConfig, UUIDFieldTest, PreAnalyzedFieldTest, ClusterStateUpdateTest, TestFieldTypeResource, TestOmitPositions, StatelessScriptUpdateProcessorFactoryTest, ZkNodePropsTest, PrimUtilsTest, EchoParamsTest, SliceStateUpdateTest, TestCollationFieldDocValues, SuggesterWFSTTest, SuggesterTSTTest, TestDistributedMissingSort, CoreAdminCreateDiscoverTest, ClusterStateTest, AutoCommitTest, TestNonNRTOpen]
[junit4] Completed in 1.74s, 2 tests, 1 failure <<< FAILURES!
[...truncated 834 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:459: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:439: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:491: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1307: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:940: There were test failures: 348 suites, 1525 tests, 1 failure, 40 ignored (11 assumptions)
Total time: 78 minutes 17 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.7.0_45 -client -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure