Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/707/
3 tests failed. REGRESSION: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=8367, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=8367, name=collection2, state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:35452/ongl/co: collection already exists: awholynewstresscollection_collection2_5 at __randomizedtesting.SeedInfo.seed([D208EC5C0F92D0EF]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1570) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1591) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895) REGRESSION: org.apache.solr.search.TestSearcherReuse.test Error Message: expected same:<Searcher@14d9dc99[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1) Uninverting(_2(6.0.0):c2)))}> was not:<Searcher@149ecefe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1) Uninverting(_2(6.0.0):c2)))}> Stack Trace: java.lang.AssertionError: expected same:<Searcher@14d9dc99[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1) Uninverting(_2(6.0.0):c2)))}> was not:<Searcher@149ecefe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1) Uninverting(_2(6.0.0):c2)))}> at __randomizedtesting.SeedInfo.seed([D208EC5C0F92D0EF:5A5CD386A16EBD17]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotSame(Assert.java:641) at org.junit.Assert.assertSame(Assert.java:580) at org.junit.Assert.assertSame(Assert.java:593) at org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247) at org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) REGRESSION: org.apache.solr.search.mlt.CloudMLTQParserTest.test Error Message: arrays first differed at element [1]; expected:<13> but was:<20> Stack Trace: arrays first differed at element [1]; expected:<13> but was:<20> at __randomizedtesting.SeedInfo.seed([D208EC5C0F92D0EF:5A5CD386A16EBD17]:0) at org.junit.internal.ComparisonCriteria.arrayEquals(ComparisonCriteria.java:52) at org.junit.Assert.internalArrayEquals(Assert.java:416) at org.junit.Assert.assertArrayEquals(Assert.java:292) at org.junit.Assert.assertArrayEquals(Assert.java:305) at org.apache.solr.search.mlt.CloudMLTQParserTest.test(CloudMLTQParserTest.java:108) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 9957 lines...] [junit4] Suite: org.apache.solr.search.TestSearcherReuse [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001 [junit4] 2> 258297 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 258299 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 258299 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/' [junit4] 2> 258359 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 258362 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 258368 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml [junit4] 2> 258369 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-id-and-version-fields-only.xml instead [junit4] 2> 258369 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml [junit4] 2> 258371 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=id-and-version-fields-only [junit4] 2> 258374 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 258375 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.s.IndexSchema Upgraded to managed schema at /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 258394 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml.bak [junit4] 2> 258395 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 258395 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001 [junit4] 2> 258395 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/' [junit4] 2> 258420 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 2037208388 [junit4] 2> 258420 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/] [junit4] 2> 258420 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/lib [junit4] 2> 258420 WARN (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/lib). [junit4] 2> 258434 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 258436 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 258437 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 258437 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 258437 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 258438 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig-managed-schema.xml, transient=false, schema=managed-schema, loadOnStartup=true, instanceDir=collection1, collection=collection1, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/, dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001, shard=shard1} [junit4] 2> 258439 INFO (coreLoadExecutor-948-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/' [junit4] 2> 258470 INFO (coreLoadExecutor-948-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 258476 INFO (coreLoadExecutor-948-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 258495 INFO (coreLoadExecutor-948-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml [junit4] 2> 258495 INFO (coreLoadExecutor-948-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 258498 INFO (coreLoadExecutor-948-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=id-and-version-fields-only [junit4] 2> 258512 INFO (coreLoadExecutor-948-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 258513 INFO (coreLoadExecutor-948-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/ [junit4] 2> 258513 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.NRTCachingDirectoryFactory [junit4] 2> 258513 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/], dataDir=[null] [junit4] 2> 258513 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 258514 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001 [junit4] 2> 258514 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index/ [junit4] 2> 258514 WARN (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index' doesn't exist. Creating new index... [junit4] 2> 258514 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index [junit4] 2> 258515 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@d0934ec [junit4] 2> 258521 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 258521 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 258552 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-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/ [junit4] 2> 258554 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 258554 WARN (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}} [junit4] 2> 258556 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 258557 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 258557 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 258558 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 258559 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file [junit4] 2> 258560 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 258561 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 258561 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 258561 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.26171875, noCFSRatio=0.2872362572213708] [junit4] 2> 258562 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 258562 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 258563 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@5fd4c65e[collection1] main [junit4] 2> 258563 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/conf [junit4] 2> 258563 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/conf} [junit4] 2> 258563 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/tempDir-001/collection1/conf [junit4] 2> 258563 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 258563 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 258564 INFO (coreLoadExecutor-948-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 258565 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 258575 INFO (searcherExecutor-949-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5fd4c65e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 258576 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 258577 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 1 [junit4] 2> 258579 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 258599 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2} [junit4] 2> 258600 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore newest commit generation = 2 [junit4] 2> 258601 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@2c8c154[collection1] main [junit4] 2> 258602 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258602 INFO (searcherExecutor-949-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2c8c154[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)))} [junit4] 2> 258605 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 26 [junit4] 2> 258617 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[2]} 0 11 [junit4] 2> 258621 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 258659 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2} [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3} [junit4] 2> 258660 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore newest commit generation = 3 [junit4] 2> 258660 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@74fa22b5[collection1] main [junit4] 2> 258661 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258661 INFO (searcherExecutor-949-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@74fa22b5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1)))} [junit4] 2> 258661 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 42 [junit4] 2> 258662 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[3]} 0 1 [junit4] 2> 258663 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[4]} 0 0 [junit4] 2> 258663 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 258683 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3} [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_4,generation=4} [junit4] 2> 258684 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore newest commit generation = 4 [junit4] 2> 258684 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@14d9dc99[collection1] main [junit4] 2> 258685 INFO (searcherExecutor-949-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14d9dc99[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1) Uninverting(_2(6.0.0):c2)))} [junit4] 2> 258685 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258685 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 22 [junit4] 2> 258687 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=4 status=0 QTime=1 [junit4] 2> 258689 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 258690 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit. [junit4] 2> 258696 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 258696 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258697 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 8 [junit4] 2> 258705 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 258706 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit. [junit4] 2> 258706 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 258706 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258706 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1 [junit4] 2> 258707 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 258708 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 258708 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258708 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1 [junit4] 2> 258708 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 258709 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 258709 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258709 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1 [junit4] 2> 258710 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=id:match_no_documents} 0 1 [junit4] 2> 258711 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 258732 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_4,generation=4} [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_5,generation=5} [junit4] 2> 258732 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore newest commit generation = 5 [junit4] 2> 258733 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@149ecefe[collection1] main [junit4] 2> 258734 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258734 INFO (searcherExecutor-949-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@149ecefe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1) Uninverting(_2(6.0.0):c2)))} [junit4] 2> 258734 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 23 [junit4] 2> 258735 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test [junit4] 2> 258736 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 258736 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1 [junit4] 2> 258736 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 258740 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_5,generation=5} [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1c41860c; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_6,generation=6} [junit4] 2> 258740 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrCore newest commit generation = 6 [junit4] 2> 258741 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@2c6578e0[collection1] main [junit4] 2> 258741 INFO (searcherExecutor-949-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2c6578e0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 258741 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 258742 INFO (TEST-TestSearcherReuse.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 6 [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=TestSearcherReuse -Dtests.method=test -Dtests.seed=D208EC5C0F92D0EF -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt -Dtests.locale=mt -Dtests.timezone=America/Thule -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 0.22s J1 | TestSearcherReuse.test <<< [junit4] > Throwable #1: java.lang.AssertionError: expected same:<Searcher@14d9dc99[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1) Uninverting(_2(6.0.0):c2)))}> was not:<Searcher@149ecefe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1) Uninverting(_1(6.0.0):c1) Uninverting(_2(6.0.0):c2)))}> [junit4] > at __randomizedtesting.SeedInfo.seed([D208EC5C0F92D0EF:5A5CD386A16EBD17]:0) [junit4] > at org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247) [junit4] > at org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 258787 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 258787 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2037208388 [junit4] 2> 258788 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7fc42cd8 [junit4] 2> 258788 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.u.UpdateHandler closing DirectUpdateHandler2{commits=9,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0} [junit4] 2> 258788 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 258788 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 258788 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 258789 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request. [junit4] 2> 258789 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing NRTCachingDirectoryFactory - 2 directories currently being tracked [junit4] 2> 258789 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001 [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001;done=false>>] [junit4] 2> 258789 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001 [junit4] 2> 258789 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index;done=false>>] [junit4] 2> 258789 INFO (SUITE-TestSearcherReuse-seed#[D208EC5C0F92D0EF]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001/init-core-data-001/index [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_D208EC5C0F92D0EF-001 [junit4] 2> NOTE: test params are: codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=8, maxDocsPerChunk=9, blockSize=9), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=8, blockSize=9)), sim=DefaultSimilarity, locale=mt, timezone=America/Thule [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_25 (64-bit)/cpus=4,threads=1,free=240508400,total=438304768 [junit4] 2> NOTE: All tests run in this JVM: [TestRebalanceLeaders, ReturnFieldsTest, DocumentBuilderTest, TestRandomRequestDistribution, TestFastLRUCache, TestElisionMultitermQuery, QueryResultKeyTest, TestAnalyzedSuggestions, TestSolrXml, TestSimpleQParserPlugin, AnalyticsMergeStrategyTest, TestHashPartitioner, ParsingFieldUpdateProcessorsTest, TestReplicationHandlerBackup, AnalysisAfterCoreReloadTest, TestSolrCoreProperties, TestRTGBase, AtomicUpdatesTest, StatelessScriptUpdateProcessorFactoryTest, RequiredFieldsTest, ZkCLITest, TestFieldTypeResource, TestSolrConfigHandler, TestDistribDocBasedVersion, TestRequestStatusCollectionAPI, BadComponentTest, BaseCdcrDistributedZkTest, TestCoreContainer, OverriddenZkACLAndCredentialsProvidersTest, TestSortingResponseWriter, SuggesterTSTTest, FieldAnalysisRequestHandlerTest, DocValuesMultiTest, TestManagedSchemaFieldResource, SpellPossibilityIteratorTest, TestSearcherReuse] [junit4] Completed [58/506] on J1 in 0.54s, 1 test, 1 failure <<< FAILURES! [...truncated 509 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/init-core-data-001 [junit4] 2> 1142611 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) [junit4] 2> 1142611 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[D208EC5C0F92D0EF]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /ongl/co [junit4] 2> 1142615 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1142627 INFO (Thread-2456) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1142627 INFO (Thread-2456) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1142723 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.ZkTestServer start zk server on port:59872 [junit4] 2> 1142723 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1142724 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1142728 INFO (zkCallback-1582-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@14383d44 name:ZooKeeperConnection Watcher:127.0.0.1:59872 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1142728 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1142728 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1142728 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1142731 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1142732 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1142732 INFO (zkCallback-1583-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5b95ca0b name:ZooKeeperConnection Watcher:127.0.0.1:59872/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1142733 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1142733 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1142733 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 1142735 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 1142736 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 1142737 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 1142739 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 1142739 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 1142741 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 1142741 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 1142743 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1142743 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1142745 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 1142745 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 1142746 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 1142747 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 1142748 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 1142748 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 1142750 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 1142750 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 1142751 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 1142752 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 1142753 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1142753 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1142754 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 1142755 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 1142756 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 1142756 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 1142758 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1142759 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1142760 INFO (zkCallback-1584-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7fc6d726 name:ZooKeeperConnection Watcher:127.0.0.1:59872 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1142760 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1142760 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1142760 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1142762 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1142762 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1142768 INFO (zkCallback-1585-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@576e7a18 name:ZooKeeperConnection Watcher:127.0.0.1:59872/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1142768 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1142768 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1142768 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf2/solrconfig.xml [junit4] 2> 1142769 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml [junit4] 2> 1142772 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf2/schema.xml [junit4] 2> 1142772 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml [junit4] 2> 1142773 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf2/enumsConfig.xml [junit4] 2> 1142774 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml [junit4] 2> 1142775 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1142775 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1142777 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf2/stopwords.txt [junit4] 2> 1142777 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt [junit4] 2> 1142778 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf2/protwords.txt [junit4] 2> 1142779 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt [junit4] 2> 1142780 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf2/currency.xml [junit4] 2> 1142780 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml [junit4] 2> 1142782 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf2/open-exchange-rates.json [junit4] 2> 1142782 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json [junit4] 2> 1142783 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 1142783 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 1142785 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf2/old_synonyms.txt [junit4] 2> 1142785 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt [junit4] 2> 1142786 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf2/synonyms.txt [junit4] 2> 1142786 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt [junit4] 2> 1142788 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/elevate.xml to /configs/conf2/elevate.xml [junit4] 2> 1142788 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml [junit4] 2> 1143083 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/cores/collection1 [junit4] 2> 1143095 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.e.j.s.Server jetty-9.2.10.v20150310 [junit4] 2> 1143097 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@42095345{/ongl/co,null,AVAILABLE} [junit4] 2> 1143098 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.e.j.s.ServerConnector Started ServerConnector@9e856c3{HTTP/1.1}{127.0.0.1:40634} [junit4] 2> 1143098 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.e.j.s.Server Started @1146383ms [junit4] 2> 1143098 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/tempDir-001/control/data, hostContext=/ongl/co, hostPort=40634, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/cores} [junit4] 2> 1143099 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@c387f44 [junit4] 2> 1143099 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/' [junit4] 2> 1143121 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/solr.xml [junit4] 2> 1143128 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/cores [junit4] 2> 1143128 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.CoreContainer New CoreContainer 1225899532 [junit4] 2> 1143128 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/] [junit4] 2> 1143128 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.CoreContainer loading shared library: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/lib [junit4] 2> 1143129 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/lib). [junit4] 2> 1143137 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] 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, [junit4] 2> 1143138 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1143139 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1143139 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1143139 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59872/solr [junit4] 2> 1143139 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 1143140 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1143141 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1143141 INFO (zkCallback-1587-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@20e3d03b name:ZooKeeperConnection Watcher:127.0.0.1:59872 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1143142 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1143142 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1143147 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1143147 INFO (zkCallback-1588-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@f6a1d64 name:ZooKeeperConnection Watcher:127.0.0.1:59872/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1143148 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1143149 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 1143150 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 1143152 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 1143153 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 1143155 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 1143157 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1143158 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1143159 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1143160 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40634_ongl%2Fco [junit4] 2> 1143161 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:40634_ongl%2Fco [junit4] 2> 1143162 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 1143163 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 1143164 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 1143165 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:40634_ongl%2Fco [junit4] 2> 1143165 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 1143167 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.Overseer Overseer (id=93973483805343749-127.0.0.1:40634_ongl%2Fco-n_0000000000) starting [junit4] 2> 1143168 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 1143173 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 1143173 INFO (OverseerStateUpdate-93973483805343749-127.0.0.1:40634_ongl%2Fco-n_0000000000) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 1143175 INFO (OverseerCollectionProcessor-93973483805343749-127.0.0.1:40634_ongl%2Fco-n_0000000000) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.OverseerCollectionProcessor Process current queue of collection creations [junit4] 2> 1143176 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1143178 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1143178 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1143179 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.CoresLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/cores [junit4] 2> 1143180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/cores/collection1, collection=control_collection, absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 1143180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.CoresLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/cores/collection1/ [junit4] 2> 1143180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.CoresLocator Found 1 core definitions [junit4] 2> 1143181 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 1143181 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 1143183 INFO (zkCallback-1588-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.DistributedQueue NodeChildrenChanged fired on path /overseer/queue state SyncConnected [junit4] 2> 1143184 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 1143184 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2 [junit4] 2> 1143184 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1143184 INFO (OverseerStateUpdate-93973483805343749-127.0.0.1:40634_ongl%2Fco-n_0000000000) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:40634/ongl/co", [junit4] 2> "node_name":"127.0.0.1:40634_ongl%2Fco", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 1143185 INFO (OverseerStateUpdate-93973483805343749-127.0.0.1:40634_ongl%2Fco-n_0000000000) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:40634/ongl/co", [junit4] 2> "node_name":"127.0.0.1:40634_ongl%2Fco", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 1143185 INFO (OverseerStateUpdate-93973483805343749-127.0.0.1:40634_ongl%2Fco-n_0000000000) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 1143185 INFO (OverseerStateUpdate-93973483805343749-127.0.0.1:40634_ongl%2Fco-n_0000000000) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 1143186 INFO (zkCallback-1588-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 1143188 INFO (zkCallback-1588-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco ] o.a.s.c.c.ZkStateReader Updated cluster state version to 1 [junit4] 2> 1144184 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 1144184 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 1144185 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 1144185 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection [junit4] 2> 1144186 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 1144186 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_D208EC5C0F92D0EF-001/control-001/cores/collection1/' [junit4] 2> 1144200 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 1144203 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1144207 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1144216 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 1144217 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml [junit4] 2> 1144221 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1144319 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1144324 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 1144326 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1144333 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1144335 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1144336 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1144337 WARN (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1144337 WARN (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1144337 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1144338 WARN (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE [junit4] 2> 1144338 WARN (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING [junit4] 2> 1144338 INFO (coreLoadExecutor-2986-thread-1-processing-n:127.0.0.1:40634_ongl%2Fco) [n:127.0.0.1:40634_ongl%2Fco c:control_collection x:collection1] o.a.s.c.CoreContainer Creating Solr [...truncated too long message...] ection1/data/index [CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest_D208EC5C0F92D0EF-001/shard-4-001/cores/collection1/data/index;done=false>>] [junit4] 2> 3285912 INFO (zkCallback-1553-thread-2-processing-n:127.0.0.1:56079_) [n:127.0.0.1:56079_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest_D208EC5C0F92D0EF-001/shard-4-001/cores/collection1/data/index [junit4] 2> 3285913 WARN (zkCallback-1553-thread-2-processing-n:127.0.0.1:56079_) [n:127.0.0.1:56079_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.LeaderElector [junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/collection1/leader_elect/shard1/election/93973622468116492-core_node4-n_0000000002 [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127) [junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51) [junit4] 2> at org.apache.zookeeper.ZooKeeper.delete(ZooKeeper.java:873) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:244) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:241) [junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:61) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.delete(SolrZkClient.java:241) [junit4] 2> at org.apache.solr.cloud.ElectionContext.cancelElection(ElectionContext.java:78) [junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:230) [junit4] 2> at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:198) [junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:159) [junit4] 2> at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:348) [junit4] 2> at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:256) [junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.rejoinLeaderElection(ElectionContext.java:480) [junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:237) [junit4] 2> at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:198) [junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:159) [junit4] 2> at org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:56) [junit4] 2> at org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:390) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3$1.run(SolrZkClient.java:269) [junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:156) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 3285915 INFO (TEST-CloudMLTQParserTest.testInvalidDocument-seed#[D208EC5C0F92D0EF]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@43b2d587{HTTP/1.1}{127.0.0.1:0} [junit4] 2> 3285915 INFO (TEST-CloudMLTQParserTest.testInvalidDocument-seed#[D208EC5C0F92D0EF]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4ac8172e{/,null,UNAVAILABLE} [junit4] 2> 3285917 INFO (TEST-CloudMLTQParserTest.testInvalidDocument-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:56079_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.ChaosMonkey monkey: stop shard! 36300 [junit4] 2> 3285921 INFO (TEST-CloudMLTQParserTest.testInvalidDocument-seed#[D208EC5C0F92D0EF]) [n:127.0.0.1:56079_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53647 53647 [junit4] 2> 3286241 INFO (Thread-77473) [n:127.0.0.1:59778_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.ZkTestServer connecting to 127.0.0.1:53647 53647 [junit4] 2> 3286241 WARN (Thread-77473) [n:127.0.0.1:59778_ c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 6 /solr/aliases.json [junit4] 2> 6 /solr/clusterstate.json [junit4] 2> 5 /solr/configs/conf1 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 6 /solr/live_nodes [junit4] 2> 5 /solr/overseer/collection-queue-work [junit4] 2> 3 /solr/overseer/queue [junit4] 2> [junit4] 2> 3286243 INFO (SUITE-CloudMLTQParserTest-seed#[D208EC5C0F92D0EF]-worker) [n:127.0.0.1:56079_ c:collection1 s:shard1 r:core_node4 x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.search.mlt.CloudMLTQParserTest_D208EC5C0F92D0EF-001 [junit4] 2> Jun 10, 2015 4:08:30 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=DefaultSimilarity, locale=sr_ME_#Latn, timezone=US/Pacific-New [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_25 (64-bit)/cpus=4,threads=1,free=154505768,total=515899392 [junit4] 2> NOTE: All tests run in this JVM: [SolrRequestParserTest, TestSchemaManager, TestCollationFieldDocValues, PingRequestHandlerTest, TestCloudSchemaless, OverseerRolesTest, TestBinaryField, TestSolrDynamicMBean, HighlighterMaxOffsetTest, BasicDistributedZkTest, ClusterStateTest, MigrateRouteKeyTest, TestBlobHandler, TestJsonRequest, TestRangeQuery, UUIDFieldTest, TestNRTOpen, MinimalSchemaTest, DateMathParserTest, TestAuthenticationFramework, RemoteQueryErrorTest, RollingRestartTest, ReplicationFactorTest, TestFaceting, SolrCoreTest, ExternalFileFieldSortTest, TestBulkSchemaConcurrent, TimeZoneUtilsTest, TestCryptoKeys, FastVectorHighlighterTest, InfoHandlerTest, TestPivotHelperCode, DateFieldTest, DistributedFacetPivotSmallAdvancedTest, DistributedFacetPivotWhiteBoxTest, SuggesterFSTTest, TestReloadAndDeleteDocs, TestJmxIntegration, IgnoreCommitOptimizeUpdateProcessorFactoryTest, HttpPartitionTest, TestBadConfig, HdfsBasicDistributedZk2Test, TestBlendedInfixSuggestions, TestSolr4Spatial, TestCodecSupport, TermsComponentTest, RulesTest, TestManagedResource, SyncSliceTest, TestReplicationHandler, CollectionReloadTest, TestRemoteStreaming, TestDocumentBuilder, TestConfig, BlockDirectoryTest, URLClassifyProcessorTest, SpatialRPTFieldTypeTest, TestTolerantSearch, HighlighterTest, MBeansHandlerTest, TestComplexPhraseQParserPlugin, TestRandomMergePolicy, HdfsCollectionsAPIDistributedZkTest, RequestLoggingTest, TestPhraseSuggestions, TestRecoveryHdfs, TestSolrIndexConfig, UpdateRequestProcessorFactoryTest, RuleEngineTest, TestPostingsSolrHighlighter, HighlighterConfigTest, TestInfoStreamLogging, TestDistributedSearch, StandardRequestHandlerTest, TestRestoreCore, TestDFRSimilarityFactory, TestAnalyzeInfixSuggestions, StressHdfsTest, FacetPivotSmallTest, SpatialHeatmapFacetsTest, TestDynamicFieldResource, TestFieldTypeCollectionResource, TestManagedSchemaFieldTypeResource, TestRemoveLastDynamicCopyField, TestSchemaNameResource, TestSchemaResource, TestSchemaSimilarityResource, TestSchemaVersionResource, TestSerializedLuceneMatchVersion, TestSolrQueryParserDefaultOperatorResource, TestUniqueKeyFieldResource, BadCopyFieldTest, DocValuesMissingTest, AnalyticsQueryTest, CursorMarkTest, MergeStrategyTest, TestSolr4Spatial2, TestOrdValues, BJQParserTest, CloudMLTQParserTest] [junit4] Completed [491/506] on J0 in 42.84s, 2 tests, 1 failure <<< FAILURES! [...truncated 59 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:533: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:474: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:61: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/extra-targets.xml:39: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:230: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:512: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1420: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:975: There were test failures: 506 suites, 1990 tests, 1 error, 2 failures, 20 ignored (10 assumptions) Total time: 161 minutes 13 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org