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 2016/02/13 18:40:32 UTC

[JENKINS] Lucene-Solr-5.x-Linux (64bit/jdk1.8.0_72) - Build # 15571 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/15571/
Java: 64bit/jdk1.8.0_72 -XX:+UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.core.TestNRTOpen.testSharedCores

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

Stack Trace:
java.lang.AssertionError: expected:<3> but was:<2>
	at __randomizedtesting.SeedInfo.seed([9EC410D73C43C5E2:78C75A98B4B5E8ED]: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.TestNRTOpen.testSharedCores(TestNRTOpen.java:116)
	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:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	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:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.search.TestIndexSearcher.testReopen

Error Message:
nothing changed, searcher should be the same expected same:<Searcher@1df977cb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.6.0):c2) Uninverting(_1(5.6.0):c2) Uninverting(_2(5.6.0):c2)))}> was not:<Searcher@7e19dc99[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(5.6.0):C2) Uninverting(_1(5.6.0):c2) Uninverting(_2(5.6.0):c2)))}>

Stack Trace:
java.lang.AssertionError: nothing changed, searcher should be the same expected same:<Searcher@1df977cb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.6.0):c2) Uninverting(_1(5.6.0):c2) Uninverting(_2(5.6.0):c2)))}> was not:<Searcher@7e19dc99[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(5.6.0):C2) Uninverting(_1(5.6.0):c2) Uninverting(_2(5.6.0):c2)))}>
	at __randomizedtesting.SeedInfo.seed([9EC410D73C43C5E2:B28CC1C14F7F4AC1]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotSame(Assert.java:641)
	at org.junit.Assert.assertSame(Assert.java:580)
	at org.apache.solr.search.TestIndexSearcher.testReopen(TestIndexSearcher.java:134)
	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:498)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	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:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10790 lines...]
   [junit4] Suite: org.apache.solr.core.TestNRTOpen
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001
   [junit4]   2> 186454 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 186454 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 186454 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 186455 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 186455 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 186455 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 186455 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 186469 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 186471 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.6.0
   [junit4]   2> 186473 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 186475 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=minimal
   [junit4]   2> 186476 WARN  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 186477 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 186477 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 186477 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr'
   [junit4]   2> 186477 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 186477 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 186477 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer New CoreContainer 914002428
   [junit4]   2> 186477 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr]
   [junit4]   2> 186477 WARN  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 186477 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 186478 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 186479 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 186479 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 186479 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 186480 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 186480 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig-basic.xml, transient=false, schema=schema-minimal.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001, shard=shard1}
   [junit4]   2> 186483 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 186485 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 186485 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 186485 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 186485 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 186506 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 186508 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.6.0
   [junit4]   2> 186511 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 186514 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=minimal
   [junit4]   2> 186516 WARN  (coreLoadExecutor-591-thread-1) [    ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 186517 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 186518 INFO  (coreLoadExecutor-591-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 186518 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.StandardDirectoryFactory
   [junit4]   2> 186525 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/]
   [junit4]   2> 186525 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 186525 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001
   [junit4]   2> 186525 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index/
   [junit4]   2> 186525 WARN  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 186526 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index
   [junit4]   2> 186526 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@2e5b82eb
   [junit4]   2> 186589 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_1,generation=1}
   [junit4]   2> 186589 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 186589 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/
   [junit4]   2> 186590 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 186592 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 186592 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 186592 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 186593 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 186594 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 186594 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 186594 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 186594 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 186594 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=25, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=74.517578125, floorSegmentMB=1.14453125, forceMergeDeletesPctAllowed=2.9789072800634564, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.617700077951712
   [junit4]   2> 186595 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_1,generation=1}
   [junit4]   2> 186595 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 186595 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@23cdfd62[collection1] main
   [junit4]   2> 186595 WARN  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 186595 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 186595 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 186595 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 186595 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 186595 INFO  (searcherExecutor-592-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@23cdfd62[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 186595 INFO  (coreLoadExecutor-591-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 186596 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 186598 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 1
   [junit4]   2> 186601 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 186730 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_1,generation=1}
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_2,generation=2}
   [junit4]   2> 186731 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 186733 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.SolrIndexSearcher Opening Searcher@1510149d[collection1] main
   [junit4]   2> 186733 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 186733 INFO  (searcherExecutor-592-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1510149d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.6.0):c1)))}
   [junit4]   2> 186733 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 132
   [junit4]   2> 186733 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 186733 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=914002428
   [junit4]   2> 186734 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@9be31e2
   [junit4]   2> 186734 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 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> 186734 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 186734 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 186734 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 186735 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 186735 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 186735 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 186735 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index
   [junit4]   2> 186735 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001;done=false>>]
   [junit4]   2> 186735 INFO  (coreCloseExecutor-596-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001
   [junit4]   2> 186736 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 186736 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 186736 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 186736 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 186736 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 186736 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 186755 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 186757 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.6.0
   [junit4]   2> 186760 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 186763 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=minimal
   [junit4]   2> 186764 WARN  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 186765 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 186765 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 186765 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr'
   [junit4]   2> 186765 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 186765 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 186765 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer New CoreContainer 797467828
   [junit4]   2> 186765 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr]
   [junit4]   2> 186765 WARN  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 186766 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 186767 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 186768 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 186768 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 186768 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 186768 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 186768 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig-basic.xml, transient=false, schema=schema-minimal.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001, shard=shard1}
   [junit4]   2> 186769 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 186769 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 186769 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 186769 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 186769 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 186780 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 186782 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.6.0
   [junit4]   2> 186797 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 186799 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=minimal
   [junit4]   2> 186801 WARN  (coreLoadExecutor-602-thread-1) [    ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 186802 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 186802 INFO  (coreLoadExecutor-602-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 186802 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.SolrCore solr.StandardDirectoryFactory
   [junit4]   2> 186802 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/]
   [junit4]   2> 186802 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 186802 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001
   [junit4]   2> 186803 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index/
   [junit4]   2> 186803 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/
   [junit4]   2> 186804 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 186805 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 186806 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 186807 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 186807 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 186808 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 186808 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 186808 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 186809 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 186809 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index
   [junit4]   2> 186809 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@5cffd92f
   [junit4]   2> 186810 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_2,generation=2}
   [junit4]   2> 186810 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 186811 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@52678fdb[collection1] main
   [junit4]   2> 186811 WARN  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 186811 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 186811 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 186811 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 186811 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 186811 INFO  (searcherExecutor-603-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@52678fdb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.6.0):c1)))}
   [junit4]   2> 186812 INFO  (coreLoadExecutor-602-thread-1) [    x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 186812 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 186814 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testSharedCores
   [junit4]   2> 186815 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 186816 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 2
   [junit4]   2> 186817 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 0
   [junit4]   2> 186818 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 186941 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_2,generation=2}
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_3,generation=3}
   [junit4]   2> 186941 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 186943 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.s.SolrIndexSearcher Opening Searcher@278772d0[collection1] main
   [junit4]   2> 186943 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 186943 INFO  (searcherExecutor-603-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@278772d0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.6.0):c1)))}
   [junit4]   2> 186943 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 125
   [junit4]   2> 186943 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 186944 WARN  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care.
   [junit4]   2> 186944 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 186944 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 186944 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 186944 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{optimize=} 0 0
   [junit4]   2> 186945 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 0
   [junit4]   2> 186945 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 186949 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.s.SolrIndexSearcher Opening Searcher@4aeeb123[collection1] main
   [junit4]   2> 186949 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 186949 INFO  (searcherExecutor-603-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4aeeb123[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.6.0):c1) Uninverting(_2(5.6.0):c1)))}
   [junit4]   2> 186949 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 4
   [junit4]   2> 186950 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 0
   [junit4]   2> 186950 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 0
   [junit4]   2> 186950 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 187098 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_3,generation=3}
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_4,generation=4}
   [junit4]   2> 187098 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 4
   [junit4]   2> 187100 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.s.SolrIndexSearcher Opening Searcher@24921495[collection1] main
   [junit4]   2> 187100 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 187100 INFO  (searcherExecutor-603-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@24921495[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.6.0):c2) Uninverting(_3(5.6.0):c2)))}
   [junit4]   2> 187100 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 149
   [junit4]   2> 187101 INFO  (TEST-TestNRTOpen.testSharedCores-seed#[9EC410D73C43C5E2]) [    ] o.a.s.SolrTestCaseJ4 ###Ending testSharedCores
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestNRTOpen -Dtests.method=testSharedCores -Dtests.seed=9EC410D73C43C5E2 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=pt-PT -Dtests.timezone=Asia/Pontianak -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.29s J2 | TestNRTOpen.testSharedCores <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<3> but was:<2>
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([9EC410D73C43C5E2:78C75A98B4B5E8ED]:0)
   [junit4]    > 	at org.apache.solr.core.TestNRTOpen.testSharedCores(TestNRTOpen.java:116)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 187105 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testReaderIsNRT
   [junit4]   2> 187106 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 187106 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{deleteByQuery=*:*} 0 0
   [junit4]   2> 187106 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 0
   [junit4]   2> 187107 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 187187 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_4,generation=4}
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_5,generation=5}
   [junit4]   2> 187187 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrDeletionPolicy newest commit generation = 5
   [junit4]   2> 187188 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.s.SolrIndexSearcher Opening Searcher@5325cffe[collection1] main
   [junit4]   2> 187188 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 187188 INFO  (searcherExecutor-603-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5325cffe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(5.6.0):c1)))}
   [junit4]   2> 187189 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 82
   [junit4]   2> 187189 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 187189 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 187189 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 187190 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 187190 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 187205 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 187207 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.6.0
   [junit4]   2> 187209 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 187212 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.s.IndexSchema [collection1] Schema name=minimal
   [junit4]   2> 187213 WARN  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 187214 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 187214 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 187215 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/]
   [junit4]   2> 187215 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 187215 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index/
   [junit4]   2> 187215 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/
   [junit4]   2> 187216 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 187217 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 187217 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 187218 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 187218 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 187219 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 187219 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 187219 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 187219 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 187219 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3f0dd808[collection1] main
   [junit4]   2> 187220 WARN  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 187220 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 187220 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 187220 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 187220 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 187220 INFO  (searcherExecutor-607-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3f0dd808[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(5.6.0):c1)))}
   [junit4]   2> 187220 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DefaultSolrCoreState Closing old IndexWriter... core=collection1
   [junit4]   2> 187220 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 187221 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_5,generation=5}
   [junit4]   2> 187221 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 5
   [junit4]   2> 187221 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 187222 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@49ed726[collection1] main
   [junit4]   2> 187222 INFO  (searcherExecutor-607-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@49ed726[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(5.6.0):c1)))}
   [junit4]   2> 187222 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.CoreContainer replacing core: collection1
   [junit4]   2> 187222 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@570a15ff
   [junit4]   2> 187222 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=4,autocommits=0,soft autocommits=0,optimizes=1,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0}
   [junit4]   2> 187222 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 187223 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 0
   [junit4]   2> 187223 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 187226 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4db7a5ff[collection1] main
   [junit4]   2> 187226 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 187226 INFO  (searcherExecutor-607-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4db7a5ff[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(5.6.0):c1) Uninverting(_6(5.6.0):c1)))}
   [junit4]   2> 187226 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 3
   [junit4]   2> 187227 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 0
   [junit4]   2> 187228 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 187370 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_5,generation=5}
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_6,generation=6}
   [junit4]   2> 187370 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 6
   [junit4]   2> 187371 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6a6af3ca[collection1] main
   [junit4]   2> 187371 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 187371 INFO  (searcherExecutor-607-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6a6af3ca[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(5.6.0):c1) Uninverting(_6(5.6.0):c1) Uninverting(_7(5.6.0):c1)))}
   [junit4]   2> 187371 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{commit=} 0 143
   [junit4]   2> 187372 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null params={}{add=[(null)]} 0 0
   [junit4]   2> 187372 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 187372 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 187372 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 187372 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 187372 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 187386 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 187388 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.6.0
   [junit4]   2> 187390 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig-basic.xml
   [junit4]   2> 187393 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=minimal
   [junit4]   2> 187394 WARN  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 187395 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 187395 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 187395 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/]
   [junit4]   2> 187395 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
   [junit4]   2> 187395 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index/
   [junit4]   2> 187395 INFO  (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/
   [junit4]   2> 187396 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 187397 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 187398 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 187398 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 187399 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 187399 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 187399 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 187400 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 187400 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 187402 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@649df8e1[collection1] main
   [junit4]   2> 187403 WARN  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
   [junit4]   2> 187403 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 187403 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 187403 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 187403 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 187403 INFO  (searcherExecutor-611-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@649df8e1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(5.6.0):c1) Uninverting(_6(5.6.0):c1) Uninverting(_7(5.6.0):c1) Uninverting(_8(5.6.0):c1)))}
   [junit4]   2> 187403 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DefaultSolrCoreState Closing old IndexWriter... core=collection1
   [junit4]   2> 187523 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_6,generation=6}
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_7,generation=7}
   [junit4]   2> 187523 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 7
   [junit4]   2> 187523 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=94.84375, floorSegmentMB=0.5361328125, forceMergeDeletesPctAllowed=2.549926528410733, segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 187525 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 	commit{dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index,segFN=segments_7,generation=7}
   [junit4]   2> 187525 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 7
   [junit4]   2> 187525 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 187527 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6db30515[collection1] main
   [junit4]   2> 187527 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.CoreContainer replacing core: collection1
   [junit4]   2> 187527 INFO  (searcherExecutor-611-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6db30515[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(5.6.0):c1) Uninverting(_6(5.6.0):c1) Uninverting(_7(5.6.0):c1) Uninverting(_8(5.6.0):c1)))}
   [junit4]   2> 187527 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1de64c28
   [junit4]   2> 187527 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.u.DirectUpdateHandler2 closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=1,adds=1,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 187527 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 187528 INFO  (TEST-TestNRTOpen.testReaderIsNRT-seed#[9EC410D73C43C5E2]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testReaderIsNRT
   [junit4]   2> 187528 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 187528 INFO  (SUITE-TestNRTOpen-seed#[9EC410D73C43C5E2]-worker) [    x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=797467828
   [junit4]   2> 187528 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4b49e2d
   [junit4]   2> 187528 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DirectUpdateHandler2 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> 187528 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 187528 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 187528 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
   [junit4]   2> 187530 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 187530 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 187530 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001;done=false>>]
   [junit4]   2> 187530 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001
   [junit4]   2> 187530 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 187530 INFO  (coreCloseExecutor-615-thread-1-processing-x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001/init-core-data-001/index
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.core.TestNRTOpen_9EC410D73C43C5E2-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene54): {bazz=FSTOrd50, foo=Lucene50(blocksize=128), bazzz=FSTOrd50, baz=FSTOrd50, foo2=BlockTreeOrds(blocksize=128)}, docValues:{}, sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=pt-PT, timezone=Asia/Pontianak
   [junit4]   2> NOTE: Linux 3.19.0-47-generic amd64/Oracle Corporation 1.8.0_72 (64-bit)/cpus=12,threads=1,free=226254376,total=528482304
   [junit4]   2> NOTE: All tests run in this JVM: [SampleTest, TestStressReorder, CollectionsAPIAsyncDistributedZkTest, TestCharFilters, TestFuzzyAnalyzedSuggestions, MultiThreadedOCPTest, DebugComponentTest, TestSchemaVersionResource, TestGroupingSearch, TestTrieFacet, RecoveryZkTest, TestReRankQParserPlugin, ClusterStateTest, TestDynamicFieldResource, TestNRTOpen]
   [junit4] Completed [59/566 (1!)] on J2 in 1.09s, 2 tests, 1 failure <<< FAILURES!

[...truncated 856 lines...]
   [junit4] Suite: org.apache.solr.search.TestIndexSearcher
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.TestIndexSearcher_9EC410D73C43C5E2-001/init-core-data-001
   [junit4]   2> 1222982 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
   [junit4]   2> 1222982 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1222982 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1222982 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1222983 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1222983 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1222983 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1223006 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1223016 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.6.0
   [junit4]   2> 1223038 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1223044 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1223136 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1223144 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 1223146 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1223151 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1223153 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 1223155 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1223155 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1223155 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1223155 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1223156 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr'
   [junit4]   2> 1223156 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1223156 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1223156 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer New CoreContainer 504309710
   [junit4]   2> 1223156 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr]
   [junit4]   2> 1223156 WARN  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Couldn't add files from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib to classpath: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 1223156 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1223158 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 1223158 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1223158 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1223158 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1223158 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1223160 INFO  (SUITE-TestIndexSearcher-seed#[9EC410D73C43C5E2]-worker) [    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=collection1, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.TestIndexSearcher_9EC410D73C43C5E2-001/init-core-data-001, shard=shard1}
   [junit4]   2> 1223160 INFO  (coreLoadExecutor-5057-thread-1) [    ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1'
   [junit4]   2> 1223160 INFO  (coreLoadExecutor-5057-thread-1) [    ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1223160 INFO  (coreLoadExecutor-5057-thread-1) [    ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 1223161 INFO  (coreLoadExecutor-5057-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1223161 INFO  (coreLoadExecutor-5057-thread-1) [    ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1223179 INFO  (coreLoadExecutor-5057-thread-1) [    ] o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1223189 INFO  (coreLoadExecutor-5057-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.6.0
   [junit4]   2> 1223213 INFO  (coreLoadExecutor-5057-thread-1) [    ] o.a.s.c.SolrConfig Loaded SolrConfig: solrc

[...truncated too long message...]

oseExecutor-5083-thread-1-processing-x:core1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1225098 INFO  (coreCloseExecutor-5083-thread-1-processing-x:core1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1237208 ERROR (coreCloseExecutor-5083-thread-1-processing-x:core1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Timeout waiting for all directory ref counts to be released - gave up waiting on CachedDir<<refCount=2;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.TestIndexSearcher_9EC410D73C43C5E2-001/init-core-data-001/index;done=false>>
   [junit4]   2> 1237209 ERROR (coreCloseExecutor-5083-thread-1-processing-x:core1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Error closing directory:org.apache.solr.common.SolrException: Timeout waiting for all directory ref counts to be released - gave up waiting on CachedDir<<refCount=2;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.TestIndexSearcher_9EC410D73C43C5E2-001/init-core-data-001/index;done=false>>
   [junit4]   2> 	at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:187)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.close(SolrCore.java:1275)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:134)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:129)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 1237209 INFO  (coreCloseExecutor-5083-thread-1-processing-x:core1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.TestIndexSearcher_9EC410D73C43C5E2-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.TestIndexSearcher_9EC410D73C43C5E2-001/init-core-data-001;done=false>>]
   [junit4]   2> 1237209 INFO  (coreCloseExecutor-5083-thread-1-processing-x:core1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.TestIndexSearcher_9EC410D73C43C5E2-001/init-core-data-001
   [junit4]   2> 1237209 ERROR (coreCloseExecutor-5083-thread-1-processing-x:core1) [    x:collection1] o.a.s.c.SolrCore java.lang.AssertionError: 2
   [junit4]   2> 	at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:201)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.close(SolrCore.java:1275)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:134)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:129)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 1237209 ERROR (coreCloseExecutor-5083-thread-1-processing-x:core1) [    x:collection1] o.a.s.c.SolrCores Error shutting down core:java.lang.AssertionError: 2
   [junit4]   2> 	at org.apache.solr.core.CachingDirectoryFactory.close(CachingDirectoryFactory.java:201)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.close(SolrCore.java:1275)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:134)
   [junit4]   2> 	at org.apache.solr.core.SolrCores$2.call(SolrCores.java:129)
   [junit4]   2> 	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2> 	at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.TestIndexSearcher_9EC410D73C43C5E2-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene54): {v_s1=PostingsFormat(name=Direct), range_facet_l_dv=PostingsFormat(name=Direct), _version_=PostingsFormat(name=Memory doPackFST= true), multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), intDefault=PostingsFormat(name=Memory doPackFST= true), v_t=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct), range_facet_i_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), text=Lucene50(blocksize=128), v_f=Lucene50(blocksize=128), range_facet_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))}, docValues:{range_facet_l_dv=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Memory), timestamp=DocValuesFormat(name=Memory)}, sim=DefaultSimilarity, locale=hu-HU, timezone=Mexico/BajaNorte
   [junit4]   2> NOTE: Linux 3.19.0-47-generic amd64/Oracle Corporation 1.8.0_72 (64-bit)/cpus=12,threads=1,free=319704952,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [SampleTest, TestStressReorder, CollectionsAPIAsyncDistributedZkTest, TestCharFilters, TestFuzzyAnalyzedSuggestions, MultiThreadedOCPTest, DebugComponentTest, TestSchemaVersionResource, TestGroupingSearch, TestTrieFacet, RecoveryZkTest, TestReRankQParserPlugin, ClusterStateTest, TestDynamicFieldResource, TestNRTOpen, TestSolrConfigHandler, TestClusterStateMutator, TestFieldSortValues, TestAuthorizationFramework, QueryResultKeyTest, DirectSolrConnectionTest, ShowFileRequestHandlerTest, HdfsNNFailoverTest, OverseerCollectionConfigSetProcessorTest, RuleEngineTest, HdfsChaosMonkeyNothingIsSafeTest, BinaryUpdateRequestHandlerTest, TestCoreDiscovery, NoCacheHeaderTest, ScriptEngineTest, TestWriterPerf, HardAutoCommitTest, DeleteStatusTest, TestCollationField, HLLSerializationTest, TestPerFieldSimilarity, DistribJoinFromCollectionTest, TestCollapseQParserPlugin, TestConfigSetProperties, TestShortCircuitedRequests, OverseerTest, BitVectorTest, TestFreeTextSuggestions, TestSolr4Spatial2, TestImplicitCoreProperties, BlockDirectoryTest, SuggesterTSTTest, TestJmxIntegration, TestTolerantSearch, TestSolrQueryParser, DirectUpdateHandlerTest, DateMathParserTest, DataDrivenBlockJoinTest, AtomicUpdatesTest, TestUseDocValuesAsStored2, FacetPivotSmallTest, TestSweetSpotSimilarityFactory, FullSolrCloudDistribCmdsTest, CoreAdminHandlerTest, TestManagedSynonymFilterFactory, TestUtils, BadIndexSchemaTest, TestReload, TestLRUStatsCache, BJQParserTest, SharedFSAutoReplicaFailoverTest, TestFieldTypeCollectionResource, TestExclusionRuleCollectionAccess, TestFastWriter, OverseerTaskQueueTest, TestSolrJ, SecurityConfHandlerTest, DeleteLastCustomShardedReplicaTest, TestDistributedMissingSort, CollectionReloadTest, BlockJoinFacetSimpleTest, TestJmxMonitoredMap, TestSchemaNameResource, TestRestManager, SuggesterWFSTTest, HdfsRestartWhileUpdatingTest, TestManagedSchemaFieldResource, IgnoreCommitOptimizeUpdateProcessorFactoryTest, SortSpecParsingTest, TestSolrConfigHandlerCloud, TestTestInjection, TestSearchPerf, SearchHandlerTest, TestConfigSetsAPI, BadComponentTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, LeaderElectionIntegrationTest, BasicZkTest, ClusterStateUpdateTest, TestRandomFaceting, ZkSolrClientTest, TestRandomDVFaceting, AutoCommitTest, TestDistributedGrouping, TestRecovery, DistributedSpellCheckComponentTest, TestJoin, SolrCoreTest, StatsComponentTest, TestIndexSearcher]
   [junit4] Completed [328/566 (2!)] on J2 in 14.24s, 5 tests, 1 failure <<< FAILURES!

[...truncated 741 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:750: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:694: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:534: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1477: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1033: There were test failures: 566 suites (7 ignored), 2279 tests, 2 failures, 84 ignored (39 assumptions) [seed: 9EC410D73C43C5E2]

Total time: 49 minutes 19 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any