Looks like a JIRA to me ;) On Tue, Aug 16, 2016 at 1:26 AM, Uwe Schindler <[email protected]> wrote: > 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] >
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
