Hi,

this failed run also made the checkout dirty:

BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/build.xml:771:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/build.xml:643:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/build.xml:630:
 Source checkout is dirty (unversioned/missing files) after running tests!!! 
Offending files:
* 
solr/contrib/dataimporthandler-extras/src/test-files/dihextras/solr/collection1/conf/dataimport.properties

So it looks that some test does not correctly clone the test-files to a working 
directory. I thought all tests were changed to do this, but this one seems to 
still be broken!

Please keep in mind that this run worked without a SecurityManager (because we 
use an external data source for linedocs), so maybe the write was not 
successfully rejected. It looks like the test swallowed the exception.

Should I open issue?

Uwe

-----
Uwe Schindler
H.-H.-Meier-Allee 63, D-28213 Bremen
http://www.thetaphi.de
eMail: [email protected]

> -----Original Message-----
> From: Apache Jenkins Server [mailto:[email protected]]
> Sent: Tuesday, August 16, 2016 9:53 AM
> To: [email protected]
> Subject: [JENKINS] Lucene-Solr-NightlyTests-6.x - Build # 145 - Still Failing
> 
> Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/145/
> 
> 3 tests failed.
> FAILED:
> org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationAfterR
> estart
> 
> Error Message:
> Timeout waiting for CDCR replication to complete @source_collection:shard1
> 
> Stack Trace:
> java.lang.RuntimeException: Timeout waiting for CDCR replication to
> complete @source_collection:shard1
>       at
> __randomizedtesting.SeedInfo.seed([EDCA8B6884E218E5:B1D76CE94AC2AC
> D3]:0)
>       at
> org.apache.solr.cloud.BaseCdcrDistributedZkTest.waitForReplicationToComp
> lete(BaseCdcrDistributedZkTest.java:794)
>       at
> org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationAfterR
> estart(CdcrReplicationDistributedZkTest.java:264)
>       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>       at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.ja
> va:62)
>       at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccess
> orImpl.java:43)
>       at java.lang.reflect.Method.invoke(Method.java:498)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomize
> dRunner.java:1764)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Rando
> mizedRunner.java:871)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Rando
> mizedRunner.java:907)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rand
> omizedRunner.java:921)
>       at
> org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFi
> xedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
>       at
> org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsSt
> atement.evaluate(BaseDistributedSearchTestCase.java:967)
>       at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>       at
> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRule
> SetupTeardownChained.java:49)
>       at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAf
> terRule.java:45)
>       at
> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThr
> eadAndTestName.java:48)
>       at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleI
> gnoreAfterMaxFailures.java:64)
>       at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.
> java:47)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.r
> un(ThreadLeakControl.java:367)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask
> (ThreadLeakControl.java:809)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadL
> eakControl.java:460)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran
> domizedRunner.java:880)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Rando
> mizedRunner.java:781)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Rando
> mizedRunner.java:816)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Rando
> mizedRunner.java:827)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>       at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAf
> terRule.java:45)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreCla
> ssName.java:41)
>       at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>       at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAsse
> rtionsRequired.java:53)
>       at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.
> java:47)
>       at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleI
> gnoreAfterMaxFailures.java:64)
>       at
> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreT
> estSuites.java:54)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.r
> un(ThreadLeakControl.java:367)
>       at java.lang.Thread.run(Thread.java:745)
> 
> 
> FAILED:  org.apache.solr.core.TestArbitraryIndexDir.testLoadNewIndexDir
> 
> Error Message:
> Exception during query
> 
> Stack Trace:
> java.lang.RuntimeException: Exception during query
>       at
> __randomizedtesting.SeedInfo.seed([EDCA8B6884E218E5:49030501A7B884D
> ]:0)
>       at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:783)
>       at
> org.apache.solr.core.TestArbitraryIndexDir.testLoadNewIndexDir(TestArbitra
> ryIndexDir.java:107)
>       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>       at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.ja
> va:62)
>       at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccess
> orImpl.java:43)
>       at java.lang.reflect.Method.invoke(Method.java:498)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomize
> dRunner.java:1764)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Rando
> mizedRunner.java:871)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Rando
> mizedRunner.java:907)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rand
> omizedRunner.java:921)
>       at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>       at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>       at
> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRule
> SetupTeardownChained.java:49)
>       at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAf
> terRule.java:45)
>       at
> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThr
> eadAndTestName.java:48)
>       at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleI
> gnoreAfterMaxFailures.java:64)
>       at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.
> java:47)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.r
> un(ThreadLeakControl.java:367)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask
> (ThreadLeakControl.java:809)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadL
> eakControl.java:460)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran
> domizedRunner.java:880)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Rando
> mizedRunner.java:781)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Rando
> mizedRunner.java:816)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Rando
> mizedRunner.java:827)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>       at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAf
> terRule.java:45)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreCla
> ssName.java:41)
>       at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>       at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAsse
> rtionsRequired.java:53)
>       at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.
> java:47)
>       at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleI
> gnoreAfterMaxFailures.java:64)
>       at
> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreT
> estSuites.java:54)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.r
> un(ThreadLeakControl.java:367)
>       at java.lang.Thread.run(Thread.java:745)
> Caused by: java.lang.RuntimeException: REQUEST FAILED:
> xpath=*[count(//doc)=1]
>       xml response was: <?xml version="1.0" encoding="UTF-8"?>
> <response>
> <lst name="responseHeader"><int name="status">0</int><int
> name="QTime">9</int></lst><result name="response" numFound="0"
> start="0"></result>
> </response>
> 
>       request was:q=id:2&qt=standard&start=0&rows=20&version=2.2
>       at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:776)
>       ... 41 more
> 
> 
> FAILED:
> junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler
> 
> Error Message:
> ObjectTracker found 4 object(s) that were not released!!!
> [NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory,
> NRTCachingDirectory]
> 
> Stack Trace:
> java.lang.AssertionError: ObjectTracker found 4 object(s) that were not
> released!!! [NRTCachingDirectory, NRTCachingDirectory,
> NRTCachingDirectory, NRTCachingDirectory]
>       at __randomizedtesting.SeedInfo.seed([EDCA8B6884E218E5]:0)
>       at org.junit.Assert.fail(Assert.java:93)
>       at org.junit.Assert.assertTrue(Assert.java:43)
>       at org.junit.Assert.assertNull(Assert.java:551)
>       at
> org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:258)
>       at sun.reflect.GeneratedMethodAccessor24.invoke(Unknown Source)
>       at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccess
> orImpl.java:43)
>       at java.lang.reflect.Method.invoke(Method.java:498)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomize
> dRunner.java:1764)
>       at
> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Rando
> mizedRunner.java:834)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>       at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAf
> terRule.java:45)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreCla
> ssName.java:41)
>       at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>       at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAsse
> rtionsRequired.java:53)
>       at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.
> java:47)
>       at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleI
> gnoreAfterMaxFailures.java:64)
>       at
> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreT
> estSuites.java:54)
>       at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>       at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.r
> un(ThreadLeakControl.java:367)
>       at java.lang.Thread.run(Thread.java:745)
> 
> 
> 
> 
> Build Log:
> [...truncated 11135 lines...]
>    [junit4] Suite: org.apache.solr.core.TestArbitraryIndexDir
>    [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001
>    [junit4]   2> 22127 INFO  (SUITE-TestArbitraryIndexDir-
> seed#[EDCA8B6884E218E5]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl
> (false) and clientAuth (true) via:
> @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN,
> clientAuth=NaN)
>    [junit4]   2> 22129 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.SolrTestCaseJ4 ###Starting
> testLoadNewIndexDir
>    [junit4]   2> 22129 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.SolrTestCaseJ4 ####initCore
>    [junit4]   2> 22129 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader new
> SolrResourceLoader for directory: '/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-
> files/solr/collection1'
>    [junit4]   2> 22130 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader JNDI not
> configured for solr (NoInitialContextEx)
>    [junit4]   2> 22130 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader using system
> property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/core/src/test-files/solr
>    [junit4]   2> 22130 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader Adding
> 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes/' to
> classloader
>    [junit4]   2> 22130 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader Adding
> 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr/collection1/lib/README' to
> classloader
>    [junit4]   2> 22152 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrConfig current version of
> requestparams : -1
>    [junit4]   2> 22160 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrConfig Using Lucene
> MatchVersion: 6.2.0
>    [junit4]   2> 22180 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrConfig Loaded SolrConfig:
> solrconfig.xml
>    [junit4]   2> 22191 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.IndexSchema [null] Schema
> name=test
>    [junit4]   2> 22296 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.IndexSchema default search field in
> schema is text
>    [junit4]   2> 22297 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.IndexSchema unique key field: id
>    [junit4]   2> 22297 WARN  (TEST-
> TestArbitraryIndexDir.testLoadNewIndexDir-seed#[EDCA8B6884E218E5]) [    ]
> o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple
> copyFields (2)
>    [junit4]   2> 22319 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.FileExchangeRateProvider Reloading
> exchange rates from file currency.xml
>    [junit4]   2> 22321 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.FileExchangeRateProvider Reloading
> exchange rates from file currency.xml
>    [junit4]   2> 22323 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader JNDI not
> configured for solr (NoInitialContextEx)
>    [junit4]   2> 22323 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader using system
> property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/core/src/test-files/solr
>    [junit4]   2> 22323 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader new
> SolrResourceLoader for directory: '/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-
> files/solr'
>    [junit4]   2> 22323 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader JNDI not
> configured for solr (NoInitialContextEx)
>    [junit4]   2> 22323 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader using system
> property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/core/src/test-files/solr
>    [junit4]   2> 22323 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer New CoreContainer
> 286352551
>    [junit4]   2> 22323 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer Loading cores into
> CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr]
>    [junit4]   2> 22323 WARN  (TEST-
> TestArbitraryIndexDir.testLoadNewIndexDir-seed#[EDCA8B6884E218E5]) [    ]
> o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-
> files/solr/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/core/src/test-files/solr/lib
>    [junit4]   2> 22324 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] 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,connectionsEvictorSleepDelay :
> 5000,maxConnectionIdleTime : 40000,
>    [junit4]   2> 22324 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.u.UpdateShardHandler Creating
> UpdateShardHandler HTTP client with params:
> socketTimeout=30000&connTimeout=30000&retry=true
>    [junit4]   2> 22325 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.l.LogWatcher SLF4J impl is
> org.slf4j.impl.Log4jLoggerFactory
>    [junit4]   2> 22325 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.l.LogWatcher Registering Log Listener
> [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
>    [junit4]   2> 22325 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer Security conf doesn't
> exist. Skipping setup for authorization module.
>    [junit4]   2> 22325 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer No authentication
> plugin used.
>    [junit4]   2> 22326 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreDescriptor Created
> CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false,
> schema=schema12.xml, loadOnStartup=true,
> configSetProperties=configsetprops.json, collection=collection1,
> dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001, shard=shard1}
>    [junit4]   2> 22327 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
> '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr/collection1'
>    [junit4]   2> 22327 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
>    [junit4]   2> 22327 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.SolrResourceLoader using system property solr.solr.home:
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr
>    [junit4]   2> 22327 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-
> files/solr/collection1/lib/classes/' to classloader
>    [junit4]   2> 22327 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.SolrResourceLoader Adding 'file:/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-
> files/solr/collection1/lib/README' to classloader
>    [junit4]   2> 22349 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.SolrConfig current version of requestparams : -1
>    [junit4]   2> 22357 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0
>    [junit4]   2> 22379 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
>    [junit4]   2> 22393 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.s.IndexSchema [collection1] Schema name=test
>    [junit4]   2> 22510 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.s.IndexSchema default search field in schema is text
>    [junit4]   2> 22511 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.s.IndexSchema unique key field: id
>    [junit4]   2> 22511 WARN  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple
> copyFields (2)
>    [junit4]   2> 22553 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file
> currency.xml
>    [junit4]   2> 22555 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file
> currency.xml
>    [junit4]   2> 22557 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming
> default properties: Can't find resource 'configsetprops.json' in classpath or
> '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr/collection1'
>    [junit4]   2> 22557 INFO  (coreLoadExecutor-33-thread-1) [    ]
> o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
> instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr/collection1
>    [junit4]   2> 22557 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrCore org.apache.solr.core.MockFSDirectoryFactory
>    [junit4]   2> 22558 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
> [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr/collection1],
> dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/]
>    [junit4]   2> 22559 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.JmxMonitoredMap No JMX servers found, not exposing Solr
> information with JMX.
>    [junit4]   2> 22562 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/snapshot_metadata
>    [junit4]   2> 22563 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata
> file...
>    [junit4]   2> 22563 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001
>    [junit4]   2> 22563 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrCore New index directory detected: old=null
> new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index/
>    [junit4]   2> 22563 WARN  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index' doesn't exist. Creating new index...
>    [junit4]   2> 22564 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index
>    [junit4]   2> 22564 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=8, maxMergeAtOnceExplicit=3,
> maxMergedSegmentMB=39.8056640625, floorSegmentMB=1.48828125,
> forceMergeDeletesPctAllowed=23.112295353481933, segmentsPerTier=26.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
>    [junit4]   2> 22575 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
>    [junit4]   2>
>       commit{dir=MockDirectoryWrapper(NRTCachingDirectory(MMapDire
> ctory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@53bd163b;
> maxCacheMB=0.052734375
> maxMergeSizeMB=0.1474609375)),segFN=segments_1,generation=1}
>    [junit4]   2> 22575 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 22579 INFO  (OldIndexDirectoryCleanupThreadForCore-
> collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index 
> directories
> to cleanup for core collection1 in /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/
>    [junit4]   2> 22580 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "dedupe"
>    [junit4]   2> 22580 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "dedupe"
>    [junit4]   2> 22580 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "dedupe-allfields"
>    [junit4]   2> 22580 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "dedupe-allfields"
>    [junit4]   2> 22581 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "stored_sig"
>    [junit4]   2> 22581 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "stored_sig"
>    [junit4]   2> 22581 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "uniq-fields"
>    [junit4]   2> 22581 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "uniq-fields"
>    [junit4]   2> 22581 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "distrib-dup-test-chain-explicit"
>    [junit4]   2> 22581 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "distrib-dup-test-chain-implicit"
>    [junit4]   2> 22582 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "distrib-dup-test-chain-implicit"
>    [junit4]   2> 22582 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrCore no updateRequestProcessorChain defined as default,
> creating implicit default
>    [junit4]   2> 22583 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 22583 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 22584 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 22585 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 22592 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
>    [junit4]   2> 22593 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.RequestHandlers Registered paths:
> /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admi
> n/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/propertie
> s,/update/json,mltrh,/admin/threads,/search-facet-
> def,/update/csv,/sql,/graph,/search-facet-
> invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/repli
> cation,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/log
> ging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/ter
> ms,spellCheckCompRH_Direct,/debug/dump
>    [junit4]   2> 22593 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrCore Using default statsCache cache:
> org.apache.solr.search.stats.LocalStatsCache
>    [junit4]   2> 22593 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.CommitTracker Hard AutoCommit: disabled
>    [junit4]   2> 22593 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.CommitTracker Soft AutoCommit: disabled
>    [junit4]   2> 22594 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
> minMergeSize=1677721, mergeFactor=40, maxMergeSize=2147483648,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12,
> noCFSRatio=0.19800664624367326]
>    [junit4]   2> 22598 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
>    [junit4]   2>
>       commit{dir=MockDirectoryWrapper(NRTCachingDirectory(MMapDire
> ctory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@53bd163b;
> maxCacheMB=0.052734375
> maxMergeSizeMB=0.1474609375)),segFN=segments_1,generation=1}
>    [junit4]   2> 22598 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 22598 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.s.SolrIndexSearcher Opening [Searcher@5b487e30[collection1] main]
>    [junit4]   2> 22598 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.r.RestManager Initializing RestManager with initArgs:
> {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorag
> eIO}
>    [junit4]   2> 22598 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
> InMemoryStorage
>    [junit4]   2> 22599 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.r.RestManager Initializing 0 registered ManagedResources
>    [junit4]   2> 22599 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.h.c.SpellCheckComponent Initializing spell checkers
>    [junit4]   2> 22609 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.s.DirectSolrSpellChecker init:
> {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLen
> gth=3}
>    [junit4]   2> 22650 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.h.ReplicationHandler Commits will be reserved for  10000
>    [junit4]   2> 22651 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: default
>    [junit4]   2> 22651 INFO  (coreLoadExecutor-33-thread-1) [    
> x:collection1]
> o.a.s.c.CoreContainer registering core: collection1
>    [junit4]   2> 22652 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: direct
>    [junit4]   2> 22652 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
>    [junit4]   2> 22652 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: wordbreak
>    [junit4]   2> 22652 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: multipleFields
>    [junit4]   2> 22653 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: jarowinkler
>    [junit4]   2> 22654 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: external
>    [junit4]   2> 22655 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: freq
>    [junit4]   2> 22655 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: fqcn
>    [junit4]   2> 22660 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.u.p.LogUpdateProcessorFactory
> [collection1]  webapp=null path=null params={}{add=[1]} 0 7
>    [junit4]   2> 22664 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: perDict
>    [junit4]   2> 22664 INFO  (searcherExecutor-34-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered 
> new
> searcher Searcher@5b487e30[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
>    [junit4]   2> 22732 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.u.DirectUpdateHandler2 start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDelet
> es=false,softCommit=false,prepareCommit=false}
>    [junit4]   2> 22746 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrDeletionPolicy
> SolrDeletionPolicy.onCommit: commits: num=2
>    [junit4]   2>
>       commit{dir=MockDirectoryWrapper(NRTCachingDirectory(MMapDire
> ctory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@53bd163b;
> maxCacheMB=0.052734375
> maxMergeSizeMB=0.1474609375)),segFN=segments_1,generation=1}
>    [junit4]   2>
>       commit{dir=MockDirectoryWrapper(NRTCachingDirectory(MMapDire
> ctory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@53bd163b;
> maxCacheMB=0.052734375
> maxMergeSizeMB=0.1474609375)),segFN=segments_2,generation=2}
>    [junit4]   2> 22746 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrDeletionPolicy newest commit
> generation = 2
>    [junit4]   2> 22747 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrCore New index directory
> detected: old=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index/ new=/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index_temp
>    [junit4]   2> 22751 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.SolrIndexSearcher Opening
> [Searcher@74581559[collection1] main]
>    [junit4]   2> 22752 INFO  (searcherExecutor-34-thread-1) [    ]
> o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@74581559[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.
> 2.0):c1)))}
>    [junit4]   2> 22752 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.u.DirectUpdateHandler2
> end_commit_flush
>    [junit4]   2> 22752 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.u.p.LogUpdateProcessorFactory
> [collection1]  webapp=null path=null params={}{commit=} 0 20
>    [junit4]   2> 22753 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader new
> SolrResourceLoader for directory: '/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-
> files/solr/collection1'
>    [junit4]   2> 22753 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader JNDI not
> configured for solr (NoInitialContextEx)
>    [junit4]   2> 22753 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader using system
> property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/core/src/test-files/solr
>    [junit4]   2> 22754 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader Adding
> 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes/' to
> classloader
>    [junit4]   2> 22754 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader Adding
> 'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/core/src/test-files/solr/collection1/lib/README' to
> classloader
>    [junit4]   2> 22776 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrConfig current version of
> requestparams : -1
>    [junit4]   2> 22784 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrConfig Using Lucene
> MatchVersion: 6.2.0
>    [junit4]   2> 22804 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrConfig Loaded SolrConfig:
> solrconfig.xml
>    [junit4]   2> 22814 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.IndexSchema [collection1] Schema
> name=test
>    [junit4]   2> 22892 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.IndexSchema default search field in
> schema is text
>    [junit4]   2> 22893 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.IndexSchema unique key field: id
>    [junit4]   2> 22894 WARN  (TEST-
> TestArbitraryIndexDir.testLoadNewIndexDir-seed#[EDCA8B6884E218E5]) [    ]
> o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple
> copyFields (2)
>    [junit4]   2> 22901 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.FileExchangeRateProvider Reloading
> exchange rates from file currency.xml
>    [junit4]   2> 22903 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.FileExchangeRateProvider Reloading
> exchange rates from file currency.xml
>    [junit4]   2> 22905 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.ConfigSetProperties Did not find
> ConfigSet properties, assuming default properties: Can't find resource
> 'configsetprops.json' in classpath or '/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-
> files/solr/collection1'
>    [junit4]   2> 22905 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer Reloading SolrCore
> 'collection1' using configuration from instancedir /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-
> files/solr/collection1
>    [junit4]   2> 22906 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.SolrCore [[collection1] ]
> Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1],
> dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/]
>    [junit4]   2> 22906 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.JmxMonitoredMap No
> JMX servers found, not exposing Solr information with JMX.
>    [junit4]   2> 22906 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata
> file...
>    [junit4]   2> 22907 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.SolrCore New index
> directory detected: old=null new=/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index_temp
>    [junit4]   2> 22907 INFO  (OldIndexDirectoryCleanupThreadForCore-
> collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index 
> directories
> to cleanup for core collection1 in /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/
>    [junit4]   2> 22908 INFO  (OldIndexDirectoryCleanupThreadForCore-
> collection1) [    x:collection1] o.a.s.c.DirectoryFactory Found 1 old index
> directories to clean-up under /x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/
>    [junit4]   2> 22908 WARN  (OldIndexDirectoryCleanupThreadForCore-
> collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Cannot delete
> directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index as it is still being referenced in the cache!
>    [junit4]   2> 22908 WARN  (OldIndexDirectoryCleanupThreadForCore-
> collection1) [    x:collection1] o.a.s.c.DirectoryFactory Delete old index
> directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index failed.
>    [junit4]   2> 22910 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "dedupe"
>    [junit4]   2> 22910 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "dedupe"
>    [junit4]   2> 22910 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "dedupe-allfields"
>    [junit4]   2> 22910 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "dedupe-allfields"
>    [junit4]   2> 22910 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "stored_sig"
>    [junit4]   2> 22910 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "stored_sig"
>    [junit4]   2> 22911 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "uniq-fields"
>    [junit4]   2> 22911 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "uniq-fields"
>    [junit4]   2> 22912 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "distrib-dup-test-chain-explicit"
>    [junit4]   2> 22912 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain creating
> updateRequestProcessorChain "distrib-dup-test-chain-implicit"
>    [junit4]   2> 22912 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.u.p.UpdateRequestProcessorChain inserting
> DistributedUpdateProcessorFactory into updateRequestProcessorChain
> "distrib-dup-test-chain-implicit"
>    [junit4]   2> 22912 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.SolrCore no
> updateRequestProcessorChain defined as default, creating implicit default
>    [junit4]   2> 22914 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.h.l.XMLLoader
> xsltCacheLifetimeSeconds=60
>    [junit4]   2> 22914 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.h.l.XMLLoader
> xsltCacheLifetimeSeconds=60
>    [junit4]   2> 22915 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.h.l.XMLLoader
> xsltCacheLifetimeSeconds=60
>    [junit4]   2> 22916 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.h.l.XMLLoader
> xsltCacheLifetimeSeconds=60
>    [junit4]   2> 22918 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.PluginBag
> requestHandler : 'lazy' created with startup=lazy
>    [junit4]   2> 22919 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.RequestHandlers
> Registered paths:
> /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admi
> n/luke,/export,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/propertie
> s,/update/json,mltrh,/admin/threads,/search-facet-
> def,/update/csv,/sql,/graph,/search-facet-
> invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/repli
> cation,dismax,defaults,/config,/stream,/schema,/admin/plugins,/admin/log
> ging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/ter
> ms,spellCheckCompRH_Direct,/debug/dump
>    [junit4]   2> 22919 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.SolrCore Using default
> statsCache cache: org.apache.solr.search.stats.LocalStatsCache
>    [junit4]   2> 22919 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.u.CommitTracker Hard
> AutoCommit: disabled
>    [junit4]   2> 22921 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.u.CommitTracker Soft
> AutoCommit: disabled
>    [junit4]   2> 22923 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.s.SolrIndexSearcher
> Opening [Searcher@76adf9c8[collection1] main]
>    [junit4]   2> 22923 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.r.RestManager Initializing
> RestManager with initArgs:
> {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorag
> eIO}
>    [junit4]   2> 22924 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1]
> o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
> InMemoryStorage
>    [junit4]   2> 22924 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.r.RestManager Initializing
> 0 registered ManagedResources
>    [junit4]   2> 22924 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.h.c.SpellCheckComponent
> Initializing spell checkers
>    [junit4]   2> 22924 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.s.DirectSolrSpellChecker
> init:
> {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLen
> gth=3}
>    [junit4]   2> 22928 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.h.ReplicationHandler
> Commits will be reserved for  10000
>    [junit4]   2> 22929 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.u.DefaultSolrCoreState
> Closing old IndexWriter... core=collection1
>    [junit4]   2> 22930 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: default
>    [junit4]   2> 22930 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: direct
>    [junit4]   2> 22930 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: wordbreak
>    [junit4]   2> 22930 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: multipleFields
>    [junit4]   2> 22931 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.CachingDirectoryFactory
> return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index_temp
>    [junit4]   2> 22932 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: jarowinkler
>    [junit4]   2> 22932 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.u.RandomMergePolicy
> RandomMergePolicy wrapping class
> org.apache.lucene.index.MockRandomMergePolicy:
> org.apache.lucene.index.MockRandomMergePolicy@5dd0fb5c
>    [junit4]   2> 22932 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: external
>    [junit4]   2> 22932 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: freq
>    [junit4]   2> 22934 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.SolrDeletionPolicy
> SolrDeletionPolicy.onInit: commits: num=1
>    [junit4]   2>
>       commit{dir=RawDirectoryWrapper(SimpleFSDirectory@/x1/jenkins/j
> enkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index_temp
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2957c37b),
> segFN=segments_1,generation=1}
>    [junit4]   2> 22934 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.SolrDeletionPolicy
> newest commit generation = 1
>    [junit4]   2> 22934 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.u.DefaultSolrCoreState
> New IndexWriter is ready to be used.
>    [junit4]   2> 22934 WARN  (TEST-
> TestArbitraryIndexDir.testLoadNewIndexDir-seed#[EDCA8B6884E218E5]) [
> x:collection1] o.a.s.c.SolrCore [collection1] PERFORMANCE WARNING:
> Overlapping onDeckSearchers=2
>    [junit4]   2> 22935 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: fqcn
>    [junit4]   2> 22936 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell
> index for spellchecker: perDict
>    [junit4]   2> 22936 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered 
> new
> searcher Searcher@76adf9c8[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.
> 2.0):c1)))}
>    [junit4]   2> 22937 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.s.SolrIndexSearcher
> Opening [Searcher@71f87724[collection1] main]
>    [junit4]   2> 22937 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.CoreContainer replacing
> core: collection1
>    [junit4]   2> 22937 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.SolrCore [collection1]
> CLOSING SolrCore org.apache.solr.core.SolrCore@217577ca
>    [junit4]   2> 22937 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.u.DirectUpdateHandler2
> closing DirectUpdateHandler2{commits=1,autocommits=0,soft
> autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,a
> dds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumula
> tive_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
>    [junit4]   2> 22938 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.SolrCore [collection1]
> Closing main searcher on request.
>    [junit4]   2> 22944 INFO  (searcherExecutor-38-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Registered 
> new
> searcher Searcher@71f87724[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.
> 2.0):c1)))}
>    [junit4]   2> 22948 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.c.S.Request [collection1]
> webapp=null path=null
> params={q=id:2&qt=standard&start=0&rows=20&version=2.2} hits=0
> status=0 QTime=9
>    [junit4]   2> 22949 ERROR (TEST-
> TestArbitraryIndexDir.testLoadNewIndexDir-seed#[EDCA8B6884E218E5]) [
> x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=*[count(//doc)=1]
>    [junit4]   2>      xml response was: <?xml version="1.0" encoding="UTF-8"?>
>    [junit4]   2> <response>
>    [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int
> name="QTime">9</int></lst><result name="response" numFound="0"
> start="0"></result>
>    [junit4]   2> </response>
>    [junit4]   2>
>    [junit4]   2>      request
> was:q=id:2&qt=standard&start=0&rows=20&version=2.2
>    [junit4]   2> 22949 ERROR (TEST-
> TestArbitraryIndexDir.testLoadNewIndexDir-seed#[EDCA8B6884E218E5]) [
> x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED:
> q=id:2&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeExcep
> tion: REQUEST FAILED: xpath=*[count(//doc)=1]
>    [junit4]   2>      xml response was: <?xml version="1.0" encoding="UTF-8"?>
>    [junit4]   2> <response>
>    [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int
> name="QTime">9</int></lst><result name="response" numFound="0"
> start="0"></result>
>    [junit4]   2> </response>
>    [junit4]   2>
>    [junit4]   2>      request
> was:q=id:2&qt=standard&start=0&rows=20&version=2.2
>    [junit4]   2>      at
> org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:776)
>    [junit4]   2>      at
> org.apache.solr.core.TestArbitraryIndexDir.testLoadNewIndexDir(TestArbitra
> ryIndexDir.java:107)
>    [junit4]   2>      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
> Method)
>    [junit4]   2>      at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.ja
> va:62)
>    [junit4]   2>      at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccess
> orImpl.java:43)
>    [junit4]   2>      at java.lang.reflect.Method.invoke(Method.java:498)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomize
> dRunner.java:1764)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Rando
> mizedRunner.java:871)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Rando
> mizedRunner.java:907)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rand
> omizedRunner.java:921)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRule
> SetupTeardownChained.java:49)
>    [junit4]   2>      at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAf
> terRule.java:45)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThr
> eadAndTestName.java:48)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleI
> gnoreAfterMaxFailures.java:64)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.
> java:47)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.r
> un(ThreadLeakControl.java:367)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask
> (ThreadLeakControl.java:809)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadL
> eakControl.java:460)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran
> domizedRunner.java:880)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Rando
> mizedRunner.java:781)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Rando
> mizedRunner.java:816)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Rando
> mizedRunner.java:827)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.e
> valuate(SystemPropertiesRestoreRule.java:57)
>    [junit4]   2>      at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAf
> terRule.java:45)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreCla
> ssName.java:41)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAsse
> rtionsRequired.java:53)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.
> java:47)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleI
> gnoreAfterMaxFailures.java:64)
>    [junit4]   2>      at
> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreT
> estSuites.java:54)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(State
> mentAdapter.java:36)
>    [junit4]   2>      at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.r
> un(ThreadLeakControl.java:367)
>    [junit4]   2>      at java.lang.Thread.run(Thread.java:745)
>    [junit4]   2>
>    [junit4]   2> 22950 INFO  (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-
> seed#[EDCA8B6884E218E5]) [    x:collection1] o.a.s.SolrTestCaseJ4 ###Ending
> testLoadNewIndexDir
>    [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
> 'ant
> get-jenkins-line-docs' in the lucene directory.
>    [junit4]   2> NOTE: reproduce with: ant test  -
> Dtestcase=TestArbitraryIndexDir -Dtests.method=testLoadNewIndexDir -
> Dtests.seed=EDCA8B6884E218E5 -Dtests.multiplier=2 -Dtests.nightly=true -
> Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/test-
> data/enwiki.random.lines.txt -Dtests.locale=en-US -
> Dtests.timezone=America/Resolute -Dtests.asserts=true -
> Dtests.file.encoding=UTF-8
>    [junit4] ERROR   0.83s J0 | TestArbitraryIndexDir.testLoadNewIndexDir <<<
>    [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during
> query
>    [junit4]    >      at
> __randomizedtesting.SeedInfo.seed([EDCA8B6884E218E5:49030501A7B884D
> ]:0)
>    [junit4]    >      at
> org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:783)
>    [junit4]    >      at
> org.apache.solr.core.TestArbitraryIndexDir.testLoadNewIndexDir(TestArbitra
> ryIndexDir.java:107)
>    [junit4]    >      at java.lang.Thread.run(Thread.java:745)
>    [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED:
> xpath=*[count(//doc)=1]
>    [junit4]    >      xml response was: <?xml version="1.0" encoding="UTF-8"?>
>    [junit4]    > <response>
>    [junit4]    > <lst name="responseHeader"><int name="status">0</int><int
> name="QTime">9</int></lst><result name="response" numFound="0"
> start="0"></result>
>    [junit4]    > </response>
>    [junit4]    >      request
> was:q=id:2&qt=standard&start=0&rows=20&version=2.2
>    [junit4]    >      at
> org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:776)
>    [junit4]    >      ... 41 more
>    [junit4]   2> 22954 INFO  (SUITE-TestArbitraryIndexDir-
> seed#[EDCA8B6884E218E5]-worker) [    x:collection1] o.a.s.SolrTestCaseJ4
> ###deleteCore
>    [junit4]   2> 22954 INFO  (SUITE-TestArbitraryIndexDir-
> seed#[EDCA8B6884E218E5]-worker) [    x:collection1] o.a.s.c.CoreContainer
> Shutting down CoreContainer instance=286352551
>    [junit4]   2> 22958 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING
> SolrCore org.apache.solr.core.SolrCore@367fa169
>    [junit4]   2> 22958 INFO  (coreCloseExecutor-42-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,a
> dds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumula
> tive_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
>    [junit4]   2> 22958 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
>    [junit4]   2> 22958 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState 
> ref
> count has reached 0 - closing IndexWriter
>    [junit4]   2> 22958 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.u.DefaultSolrCoreState closing
> IndexWriter with IndexWriterCloser
>    [junit4]   2> 22960 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.SolrCore [collection1] Closing main
> searcher on request.
>    [junit4]   2> 22961 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> MockFSDirectoryFactory - 4 directories currently being tracked
>    [junit4]   2> 22961 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to
> close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index_temp
> [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index_temp;done=false>>]
>    [junit4]   2> 22961 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> directory, CoreContainer#isShutdown=true
>    [junit4]   2> 22961 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index_temp
>    [junit4]   2> 22980 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to
> close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index
> [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index;done=false>>]
>    [junit4]   2> 22980 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> directory, CoreContainer#isShutdown=true
>    [junit4]   2> 22980 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/index
>    [junit4]   2> 22985 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to
> close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/snapshot_metadata
> [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/snapshot_metadata;done=false>>]
>    [junit4]   2> 22985 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> directory, CoreContainer#isShutdown=true
>    [junit4]   2> 22985 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001/snapshot_metadata
>    [junit4]   2> 22985 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory looking to
> close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001 [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001;done=false>>]
>    [junit4]   2> 22985 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> directory, CoreContainer#isShutdown=true
>    [junit4]   2> 22985 INFO  (coreCloseExecutor-42-thread-1-processing-
> x:collection1) [    x:collection1] o.a.s.c.CachingDirectoryFactory Closing
> directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-
> 001/init-core-data-001
>    [junit4]   2> NOTE: leaving temporary files on disk at: 
> /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.core.TestArbitraryIndexDir_EDCA8B6884E218E5-001
>    [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62):
> {name=FST50, id=FST50}, docValues:{}, maxPointsInLeafNode=1057,
> maxMBSortInHeap=6.283943130221446,
> sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=en-US,
> timezone=America/Resolute
>    [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
> 1.8.0_102 (64-bit)/cpus=4,threads=1,free=180730616,total=304611328
>    [junit4]   2> NOTE: All tests run in this JVM: [BufferStoreTest,
> CursorPagingTest, RequestLoggingTest, TestArbitraryIndexDir]
>    [junit4] Completed [7/629 (1!)] on J0 in 0.88s, 1 test, 1 error <<< 
> FAILURES!
> 
> [...truncated 354 lines...]
>    [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
>    [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/init-core-data-001
>    [junit4]   2> 322476 INFO  (SUITE-TestReplicationHandler-
> seed#[EDCA8B6884E218E5]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl
> (false) and clientAuth (false) via:
> @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
>    [junit4]   2> 322477 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.SolrTestCaseJ4 ###Starting
> doTestReplicateAfterCoreReload
>    [junit4]   2> 322478 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties
> file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/collection1
>    [junit4]   2> 322480 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.e.j.s.Server jetty-9.3.8.v20160314
>    [junit4]   2> 322492 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.e.j.s.h.ContextHandler Started
> o.e.j.s.ServletContextHandler@10c5dba1{/solr,null,AVAILABLE}
>    [junit4]   2> 322495 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.e.j.s.ServerConnector Started
> ServerConnector@63e82015{HTTP/1.1,[http/1.1]}{127.0.0.1:๔๐๓๓๒}
>    [junit4]   2> 322495 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.e.j.s.Server Started @๓๒๔๙๑๐ms
>    [junit4]   2> 322495 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
> {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=40332}
>    [junit4]   2> 322495 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.SolrDispatchFilter
> SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@5c647e05
>    [junit4]   2> 322502 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader new
> SolrResourceLoader for directory: '/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001'
>    [junit4]   2> 322502 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader JNDI not
> configured for solr (NoInitialContextEx)
>    [junit4]   2> 322502 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrResourceLoader solr home
> defaulted to 'solr/' (could not find system property or JNDI)
>    [junit4]   2> 322503 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.SolrXmlConfig Loading container
> configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-
> NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/solr.xml
>    [junit4]   2> 322510 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CorePropertiesLocator Config-
> defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/.
>    [junit4]   2> 322511 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer New CoreContainer
> 330895800
>    [junit4]   2> 322511 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer Loading cores into
> CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001]
>    [junit4]   2> 322511 WARN  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer Couldn't add files
> from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/lib to classpath: /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/lib
>    [junit4]   2> 322511 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.h.c.HttpShardHandlerFactory created
> with socketTimeout : 90000,urlScheme : ,connTimeout :
> 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize :
> 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -
> 1,fairnessPolicy : false,useRetries : false,connectionsEvictorSleepDelay :
> 5000,maxConnectionIdleTime : 40000,
>    [junit4]   2> 322512 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.u.UpdateShardHandler Creating
> UpdateShardHandler HTTP client with params:
> socketTimeout=340000&connTimeout=45000&retry=true
>    [junit4]   2> 322514 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.l.LogWatcher SLF4J impl is
> org.slf4j.impl.Log4jLoggerFactory
>    [junit4]   2> 322514 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.l.LogWatcher Registering Log Listener
> [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
>    [junit4]   2> 322514 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer Security conf doesn't
> exist. Skipping setup for authorization module.
>    [junit4]   2> 322514 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreContainer No authentication
> plugin used.
>    [junit4]   2> 322515 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CorePropertiesLocator Looking for
> core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-
> Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/.
>    [junit4]   2> 322515 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CoreDescriptor Created
> CoreDescriptor: {name=collection1, config=solrconfig.xml,
> loadOnStartup=true, schema=schema.xml,
> configSetProperties=configsetprops.json, transient=false, dataDir=data/}
>    [junit4]   2> 322515 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CorePropertiesLocator Found core
> collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1
>    [junit4]   2> 322516 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core
> definitions
>    [junit4]   2> 322516 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.SolrDispatchFilter
> user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-core/test/J0
>    [junit4]   2> 322517 INFO  (TEST-
> TestReplicationHandler.doTestReplicateAfterCoreReload-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.s.SolrDispatchFilter
> SolrDispatchFilter.init() done
>    [junit4]   2> 322518 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
> '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/collection1'
>    [junit4]   2> 322518 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
>    [junit4]   2> 322518 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
> system property or JNDI)
>    [junit4]   2> 322523 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.SolrConfig current version of requestparams : -1
>    [junit4]   2> 322526 WARN  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
> <mergePolicyFactory> instead.
>    [junit4]   2> 322526 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0
>    [junit4]   2> 322533 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
>    [junit4]   2> 322536 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.s.IndexSchema [collection1] Schema name=test
>    [junit4]   2> 322539 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.s.IndexSchema unique key field: id
>    [junit4]   2> 322539 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming
> default properties: Can't find resource 'configsetprops.json' in classpath or
> '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/collection1'
>    [junit4]   2> 322540 INFO  (coreLoadExecutor-1057-thread-1) [    ]
> o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
> instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1
>    [junit4]   2> 322540 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
>    [junit4]   2> 322540 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
> [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/collection1], dataDir=[/x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1/data/]
>    [junit4]   2> 322540 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
> collection1
>    [junit4]   2> 322540 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1/data/snapshot_metadata
>    [junit4]   2> 322540 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from
> snapshot metadata file...
>    [junit4]   2> 322541 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1/data
>    [junit4]   2> 322541 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
> new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1/data/index/
>    [junit4]   2> 322541 WARN  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
> '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new
> index...
>    [junit4]   2> 322542 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1/data/index
>    [junit4]   2> 322542 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping
> class org.apache.lucene.index.LogByteSizeMergePolicy:
> [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=27,
> maxMergeSize=2147483648,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12,
> noCFSRatio=0.8486568341347084]
>    [junit4]   2> 322545 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=1
>    [junit4]   2>
>       commit{dir=MockDirectoryWrapper(RAMDirectory@148187d9
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6fa9400c),s
> egFN=segments_1,generation=1}
>    [junit4]   2> 322545 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 322547 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
> default, creating implicit default
>    [junit4]   2> 322548 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 322548 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 322549 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 322549 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 322550 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with
> startup=lazy
>    [junit4]   2> 322551 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.RequestHandlers Registered paths:
> /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,
> /admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/a
> dmin/segments,/admin/system,/replication,defaults,/config,/stream,/schem
> a,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
>    [junit4]   2> 322551 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
> org.apache.solr.search.stats.LocalStatsCache
>    [junit4]   2> 322551 INFO  (OldIndexDirectoryCleanupThreadForCore-
> collection1) [    x:collection1] o.a.s.c.SolrCore Looking for old index 
> directories
> to cleanup for core collection1 in /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/./collection1/data/
>    [junit4]   2> 322553 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
>    [junit4]   2> 322555 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
>    [junit4]   2> 322555 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping
> class org.apache.lucene.index.LogByteSizeMergePolicy:
> [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=7,
> maxMergeSize=2147483648,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12,
> noCFSRatio=0.6891780809741005]
>    [junit4]   2> 322555 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits:
> num=1
>    [junit4]   2>
>       commit{dir=MockDirectoryWrapper(RAMDirectory@148187d9
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6fa9400c),s
> egFN=segments_1,generation=1}
>    [junit4]   2> 322555 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 322556 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening
> [Searcher@6231e8bc[collection1] main]
>    [junit4]   2> 322556 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized
> to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/collection1/conf
>    [junit4]   2> 322556 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
> {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-
> core/test/J0/temp/solr.handler.TestReplicationHandler_EDCA8B6884E218E5
> -001/solr-instance-001/collection1/conf}
>    [junit4]   2> 322556 INFO  (coreLoadExecutor-1057-thread-1) [
> x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
> using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/solr/build/solr-core/test/J0/temp/
> 
> [...truncated too long message...]
> 
> 3396 ERROR (TEST-
> CdcrReplicationDistributedZkTest.testBatchAddsWithDelete-
> seed#[EDCA8B6884E218E5]-EventThread) [n:127.0.0.1:58497_    ]
> o.a.z.ClientCnxn Error while calling watcher
>    [junit4]   2> java.util.concurrent.RejectedExecutionException: Task
> org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$
> Lambda$31/1702259632@fb4e5b7 rejected from
> org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@
> 63f2ab25[Terminated, pool size = 0, active threads = 0, queued tasks = 0,
> completed tasks = 76]
>    [junit4]   2>      at
> java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(Thre
> adPoolExecutor.java:2047)
>    [junit4]   2>      at
> java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823
> )
>    [junit4]   2>      at
> java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1
> 369)
>    [junit4]   2>      at
> org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.e
> xecute(ExecutorUtil.java:214)
>    [junit4]   2>      at
> java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService
> .java:112)
>    [junit4]   2>      at
> org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
>    [junit4]   2>      at
> org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.jav
> a:522)
>    [junit4]   2>      at
> org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
>    [junit4]   2> 4563396 INFO  (TEST-
> CdcrReplicationDistributedZkTest.testBatchAddsWithDelete-
> seed#[EDCA8B6884E218E5]) [    ] o.a.s.c.ZkTestServer connecting to
> 127.0.0.1:59829 59829
>    [junit4]   2> 4563397 INFO  (Thread-55326) [    ] o.a.s.c.ZkTestServer
> connecting to 127.0.0.1:59829 59829
>    [junit4]   2> 4563400 WARN  (Thread-55326) [    ] o.a.s.c.ZkTestServer 
> Watch
> limit violations:
>    [junit4]   2> Maximum concurrent create/delete watches above limit:
>    [junit4]   2>
>    [junit4]   2>      28      /solr/aliases.json
>    [junit4]   2>      16      /solr/configs/conf1
>    [junit4]   2>      8       /solr/collections/tmp_collection/state.json
>    [junit4]   2>      8       /solr/security.json
>    [junit4]   2>      3
>       /solr/collections/target_collection/leaders/shard2/leader
>    [junit4]   2>      3
>       /solr/collections/target_collection/leaders/shard1/leader
>    [junit4]   2>      2
>       /solr/collections/source_collection/leaders/shard1/leader
>    [junit4]   2>      2
>       /solr/collections/source_collection/leaders/shard2/leader
>    [junit4]   2>      2
>       /solr/collections/tmp_collection/leaders/shard2/leader
>    [junit4]   2>      2
>       /solr/collections/tmp_collection/leaders/shard1/leader
>    [junit4]   2>
>    [junit4]   2> Maximum concurrent data watches above limit:
>    [junit4]   2>
>    [junit4]   2>      28      /solr/clusterprops.json
>    [junit4]   2>      28      /solr/clusterstate.json
>    [junit4]   2>      8       
> /solr/collections/tmp_collection/cdcr/state/process
>    [junit4]   2>      8       
> /solr/collections/tmp_collection/cdcr/state/buffer
>    [junit4]   2>      6       
> /solr/collections/target_collection/cdcr/state/buffer
>    [junit4]   2>      6       
> /solr/collections/target_collection/cdcr/state/process
>    [junit4]   2>      5
>       /solr/collections/source_collection/cdcr/state/process
>    [junit4]   2>      4       /solr/collections/source_collection/state.json
>    [junit4]   2>      4       
> /solr/collections/source_collection/cdcr/state/buffer
>    [junit4]   2>      4       /solr/collections/target_collection/state.json
>    [junit4]   2>
>    [junit4]   2> Maximum concurrent children watches above limit:
>    [junit4]   2>
>    [junit4]   2>      79      /solr/overseer/queue
>    [junit4]   2>      42      /solr/overseer/collection-queue-work
>    [junit4]   2>      28      /solr/live_nodes
>    [junit4]   2>      28      /solr/collections
>    [junit4]   2>      19      /solr/overseer/queue-work
>    [junit4]   2>
>    [junit4]   2> 4563401 INFO  (SUITE-CdcrReplicationDistributedZkTest-
> seed#[EDCA8B6884E218E5]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
>    [junit4]   2> NOTE: leaving temporary files on disk at: 
> /x1/jenkins/jenkins-
> slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-
> core/test/J1/temp/solr.cloud.CdcrReplicationDistributedZkTest_EDCA8B6884
> E218E5-001
>    [junit4]   2> Aug 16, 2016 7:33:39 AM
> com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
>    [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked
> thread(s).
>    [junit4]   2> NOTE: test params are: codec=Lucene62, sim=ClassicSimilarity,
> locale=be, timezone=Asia/Amman
>    [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
> 1.8.0_102 (64-bit)/cpus=4,threads=1,free=123997104,total=503316480
>    [junit4]   2> NOTE: All tests run in this JVM: [SolrCmdDistributorTest,
> ConvertedLegacyTest, TestReplicationHandlerBackup, TestCodecSupport,
> TestDocBasedVersionConstraints, TestBM25SimilarityFactory,
> CloudExitableDirectoryReaderTest, DirectoryFactoryTest,
> TestXmlQParserPlugin, ZkControllerTest, TestHashPartitioner,
> TestSubQueryTransformer, TestUseDocValuesAsStored2,
> CollectionsAPIDistributedZkTest, SolrPluginUtilsTest, TestNumericTerms64,
> TestSolr4Spatial2, TestExpandComponent, TestShardHandlerFactory,
> TestSimpleTrackingShardHandler, LoggingHandlerTest,
> FastVectorHighlighterTest, LeaderFailoverAfterPartitionTest,
> ClassificationUpdateProcessorFactoryTest, TestHashQParserPlugin,
> MoreLikeThisHandlerTest, OverriddenZkACLAndCredentialsProvidersTest,
> TestMissingGroups, TestLFUCache, OpenExchangeRatesOrgProviderTest,
> TestPartialUpdateDeduplication, SolrInfoMBeanTest, TestQueryTypes,
> TermVectorComponentTest, TestMiniSolrCloudClusterSSL,
> ShardRoutingCustomTest, TestClassicSimilarityFactory, BlockCacheTest,
> HdfsBasicDistributedZkTest, SpellingQueryConverterTest,
> TestCursorMarkWithoutUniqueKey, SolrCLIZkUtilsTest, QueryResultKeyTest,
> NotRequiredUniqueKeyTest, TestLeaderInitiatedRecoveryThread,
> TestOrdValues, FullHLLTest, CreateCollectionCleanupTest,
> TestDynamicLoading, SharedFSAutoReplicaFailoverTest, SimplePostToolTest,
> TestBulkSchemaConcurrent, SmileWriterTest, TestFieldCacheWithThreads,
> TestFieldCollectionResource, TestEmbeddedSolrServerConstructors,
> TestQuerySenderNoQuery, DirectSolrSpellCheckerTest,
> HdfsCollectionsAPIDistributedZkTest, JavabinLoaderTest,
> SuggestComponentContextFilterQueryTest, TestAuthenticationFramework,
> CoreAdminCreateDiscoverTest, NumericFieldsTest,
> ChaosMonkeySafeLeaderTest, TestSchemaSimilarityResource,
> SSLMigrationTest, TestExclusionRuleCollectionAccess,
> TestLMJelinekMercerSimilarityFactory, CdcrVersionReplicationTest, TestTrie,
> TestDistributedGrouping, TestSolrCloudWithKerberosAlt, SparseHLLTest,
> DistribDocExpirationUpdateProcessorTest, TestCloudSchemaless,
> TestReRankQParserPlugin, MBeansHandlerTest,
> DeleteLastCustomShardedReplicaTest, AnalysisErrorHandlingTest,
> TestRuleBasedAuthorizationPlugin, TestInitParams, TestStressUserVersions,
> TestMiniSolrCloudCluster, TimeZoneUtilsTest, DocumentBuilderTest,
> TestJsonRequest, TestManagedSchemaAPI, TestSolrQueryResponse,
> DistributedTermsComponentTest, TestDFRSimilarityFactory,
> TestBulkSchemaAPI, HighlighterTest, TestRandomRequestDistribution,
> BasicFunctionalityTest, DistributedDebugComponentTest,
> DistributedFacetPivotLongTailTest, TestSQLHandler,
> TestCollapseQParserPlugin, ZkSolrClientTest, TestFiltering,
> TestTolerantUpdateProcessorCloud, UniqFieldsUpdateProcessorFactoryTest,
> BooleanFieldTest, BasicDistributedZk2Test, OpenCloseCoreStressTest,
> ShardRoutingTest, ClusterStateUpdateTest, ZkCLITest, TestRecovery,
> DistributedSpellCheckComponentTest, TestRealTimeGet, TestStressReorder,
> TestReload, TestCoreContainer, StatsComponentTest, PeerSyncTest,
> TestFunctionQuery, DirectUpdateHandlerTest, TestBadConfig,
> TestIndexSearcher, CurrencyFieldOpenExchangeTest,
> CurrencyFieldXmlFileTest, SolrIndexSplitterTest, TestCoreDiscovery,
> SignatureUpdateProcessorFactoryTest, SpellCheckCollatorTest,
> CoreAdminHandlerTest, SpatialFilterTest, WordBreakSolrSpellCheckerTest,
> SchemaVersionSpecificBehaviorTest, SolrCoreCheckLockOnStartupTest,
> TestPseudoReturnFields, TestUpdate, TestAtomicUpdateErrorCases,
> TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest,
> DefaultValueUpdateProcessorTest, SortByFunctionTest,
> TestRemoteStreaming, DocValuesMultiTest, DistanceFunctionTest,
> TestSolrDeletionPolicy1, CacheHeaderTest, IndexBasedSpellCheckerTest,
> TestSurroundQueryParser, DisMaxRequestHandlerTest,
> TestReversedWildcardFilterFactory, DocumentAnalysisRequestHandlerTest,
> TestOmitPositions, TestValueSourceCache, TestIndexingPerformance,
> IndexSchemaTest, TestCollationField, UpdateRequestProcessorFactoryTest,
> TestCSVResponseWriter, BinaryUpdateRequestHandlerTest,
> CSVRequestHandlerTest, TestComponentsName, TestBinaryResponseWriter,
> HighlighterConfigTest, SOLR749Test, TestQuerySenderListener,
> AlternateDirectoryTest, CopyFieldTest, SolrIndexConfigTest,
> BadComponentTest, TestStressRecovery, TestSystemIdResolver,
> PrimUtilsTest, TestSuggestSpellingConverter, DateFieldTest, DOMUtilTest,
> TestLRUCache, TestUtils, TestDocumentBuilder, SliceStateTest,
> SystemInfoHandlerTest, FileUtilsTest, CircularListTest,
> DistributedMLTComponentTest, DistributedIntervalFacetingTest,
> SolrTestCaseJ4Test, TestDistributedMissingSort,
> TestHighlightDedupGrouping, ConnectionReuseTest, ActionThrottleTest,
> AliasIntegrationTest, BaseCdcrDistributedZkTest,
> CdcrReplicationDistributedZkTest]
>    [junit4] Completed [554/629 (3!)] on J1 in 1844.51s, 11 tests, 1 error <<<
> FAILURES!
> 
> [...truncated 60316 lines...]
> BUILD FAILED
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/build.xml:771: The following error occurred while executing
> this line:
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/build.xml:643: The following error occurred while executing
> this line:
> /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-
> 6.x/checkout/build.xml:630: Source checkout is dirty (unversioned/missing
> files) after running tests!!! Offending files:
> * solr/contrib/dataimporthandler-extras/src/test-
> files/dihextras/solr/collection1/conf/dataimport.properties
> 
> Total time: 272 minutes 44 seconds
> Build step 'Invoke Ant' marked build as failure
> Archiving artifacts
> Recording test results
> Email was triggered for: Failure - Any
> Sending email for trigger: Failure - Any
> 
> 



---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to