Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/14183/ Java: 64bit/jdk1.8.0_60 -XX:-UseCompressedOops -XX:+UseG1GC
2 tests failed. FAILED: org.apache.solr.cloud.CustomCollectionTest.test Error Message: Error from server at http://127.0.0.1:40367/af_h/xw: collection already exists: testCreateShardRepFactor Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:40367/af_h/xw: collection already exists: testCreateShardRepFactor at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1574) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1528) at org.apache.solr.cloud.CustomCollectionTest.testCreateShardRepFactor(CustomCollectionTest.java:386) at org.apache.solr.cloud.CustomCollectionTest.test(CustomCollectionTest.java:97) 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:497) 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:963) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) 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) FAILED: org.apache.solr.cloud.TestConfigSetsAPIExclusivity.testAPIExclusivity Error Message: Unexpected exception: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:34299/solr: delete the configset time out:300s expected:<0> but was:<1> Stack Trace: java.lang.AssertionError: Unexpected exception: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:34299/solr: delete the configset time out:300s expected:<0> but was:<1> at __randomizedtesting.SeedInfo.seed([FCDE45D1F602FFAC:81AB5C2AAFA646E5]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.apache.solr.cloud.TestConfigSetsAPIExclusivity.testAPIExclusivity(TestConfigSetsAPIExclusivity.java:95) 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:497) 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) Build Log: [...truncated 9707 lines...] [junit4] Suite: org.apache.solr.cloud.TestConfigSetsAPIExclusivity [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_FCDE45D1F602FFAC-001/init-core-data-001 [junit4] 2> 240076 INFO (SUITE-TestConfigSetsAPIExclusivity-seed#[FCDE45D1F602FFAC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 240078 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAPIExclusivity [junit4] 2> 240079 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 240089 INFO (Thread-504) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 240089 INFO (Thread-504) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 240189 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.ZkTestServer start zk server on port:52301 [junit4] 2> 240189 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 240212 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 240233 INFO (zkCallback-309-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6121bca4 name:ZooKeeperConnection Watcher:127.0.0.1:52301 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 240233 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 240233 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 240234 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml [junit4] 2> 240255 INFO (jetty-launcher-308-thread-1) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 240291 INFO (jetty-launcher-308-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6e94e373{/solr,null,AVAILABLE} [junit4] 2> 240297 INFO (jetty-launcher-308-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@31741214{HTTP/1.1}{127.0.0.1:34299} [junit4] 2> 240297 INFO (jetty-launcher-308-thread-1) [ ] o.e.j.s.Server Started @242346ms [junit4] 2> 240297 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34299} [junit4] 2> 240297 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 240297 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_FCDE45D1F602FFAC-001/tempDir-001/' [junit4] 2> 240313 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 240325 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 240326 INFO (zkCallback-310-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@44a8b8a9 name:ZooKeeperConnection Watcher:127.0.0.1:52301/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 240326 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 240326 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 240326 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 240338 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_FCDE45D1F602FFAC-001/tempDir-001/. [junit4] 2> 240338 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 2037443447 [junit4] 2> 240338 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_FCDE45D1F602FFAC-001/tempDir-001/] [junit4] 2> 240338 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_FCDE45D1F602FFAC-001/tempDir-001/lib [junit4] 2> 240338 WARN (jetty-launcher-308-thread-1) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_FCDE45D1F602FFAC-001/tempDir-001/lib). [junit4] 2> 240347 INFO (jetty-launcher-308-thread-1) [ ] 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> 240349 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 240350 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 240350 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 240350 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52301/solr [junit4] 2> 240350 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 240350 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 240351 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 240352 INFO (zkCallback-312-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@65f22bae name:ZooKeeperConnection Watcher:127.0.0.1:52301 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 240353 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 240353 INFO (jetty-launcher-308-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 240354 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 240355 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@198ef158 name:ZooKeeperConnection Watcher:127.0.0.1:52301/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 240355 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 240357 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 240358 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 240359 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 240360 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 240361 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 240363 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 240363 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 240364 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 240365 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 240366 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 240366 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34299_solr [junit4] 2> 240366 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:34299_solr [junit4] 2> 240367 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 240369 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 240370 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 240370 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94499637494022147-127.0.0.1:34299_solr-n_0000000000 [junit4] 2> 240370 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34299_solr [junit4] 2> 240370 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 240371 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.Overseer Overseer (id=94499637494022147-127.0.0.1:34299_solr-n_0000000000) starting [junit4] 2> 240372 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 240374 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 240375 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 240375 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 240375 INFO (OverseerStateUpdate-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 240392 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 240393 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 240393 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.CoresLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_FCDE45D1F602FFAC-001/tempDir-001/. [junit4] 2> 240394 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.c.CoresLocator Found 0 core definitions [junit4] 2> 240397 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0 [junit4] 2> 240397 INFO (jetty-launcher-308-thread-1) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 240397 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 240398 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 240399 INFO (zkCallback-314-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@dbb4e34 name:ZooKeeperConnection Watcher:127.0.0.1:52301 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 240399 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 240400 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 240402 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 240402 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 240403 INFO (zkCallback-316-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7e0b110c name:ZooKeeperConnection Watcher:127.0.0.1:52301/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 240403 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 240403 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 240404 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/grandBaseConfigSet1/solrconfig.xml [junit4] 2> 240419 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[FCDE45D1F602FFAC]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/grandBaseConfigSet1/schema.xml [junit4] 2> 240446 INFO (qtp1414551923-1442) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=baseConfigSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240446 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240450 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240450 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240451 INFO (OverseerThreadFactory-464-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240453 ERROR (OverseerThreadFactory-464-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240446 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240454 INFO (OverseerThreadFactory-464-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000000 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1,exception={msg=ConfigSet does not exist to delete: baseConfigSet1,rspCode=400}} [junit4] 2> 240454 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000001 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240455 INFO (OverseerThreadFactory-464-thread-2-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240455 ERROR (OverseerThreadFactory-464-thread-2-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: create failed:org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:294) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240456 INFO (OverseerThreadFactory-464-thread-2-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000001 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1,exception={msg=Base ConfigSet does not exist: baseConfigSet1,rspCode=400}} [junit4] 2> 240461 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000001 state SyncConnected [junit4] 2> 240467 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=21 [junit4] 2> 240467 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000003 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240467 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000005 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240467 INFO (OverseerThreadFactory-464-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , { [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240468 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240468 ERROR (OverseerThreadFactory-464-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240468 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/grandBaseConfigSet1/schema.xml to /configs/baseConfigSet1/schema.xml [junit4] 2> 240469 INFO (OverseerThreadFactory-464-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000003 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}} [junit4] 2> 240469 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet1/schema.xml [junit4] 2> 240470 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240470 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000003 state SyncConnected [junit4] 2> 240472 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=21 [junit4] 2> 240477 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240483 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/grandBaseConfigSet1/solrconfig.xml to /configs/baseConfigSet1/solrconfig.xml [junit4] 2> 240484 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet1/solrconfig.xml [junit4] 2> 240485 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000005 complete, response:{} [junit4] 2> 240496 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000005 state SyncConnected [junit4] 2> 240500 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=54 [junit4] 2> 240506 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240507 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000008 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240507 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240525 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/schema.xml to /configs/configSet1/schema.xml [junit4] 2> 240531 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/schema.xml [junit4] 2> 240533 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/solrconfig.xml to /configs/configSet1/solrconfig.xml [junit4] 2> 240533 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/solrconfig.xml [junit4] 2> 240534 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000008 complete, response:{} [junit4] 2> 240534 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000010 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240534 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , { [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240534 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000008 state SyncConnected [junit4] 2> 240534 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found [junit4] 2> 240535 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=65 [junit4] 2> 240535 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000010 complete, response:{} [junit4] 2> 240538 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240542 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000010 state SyncConnected [junit4] 2> 240544 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=0 QTime=66 [junit4] 2> 240549 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240552 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000012 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240553 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240554 ERROR (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240555 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000012 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}} [junit4] 2> 240555 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000012 state SyncConnected [junit4] 2> 240556 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000014 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240556 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240556 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=50 [junit4] 2> 240557 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/schema.xml to /configs/configSet1/schema.xml [junit4] 2> 240557 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/schema.xml [junit4] 2> 240558 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/solrconfig.xml to /configs/configSet1/solrconfig.xml [junit4] 2> 240558 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/solrconfig.xml [junit4] 2> 240559 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000014 complete, response:{} [junit4] 2> 240562 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240570 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000014 state SyncConnected [junit4] 2> 240572 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=34 [junit4] 2> 240574 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000016 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240574 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000018 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240574 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , { [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240574 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240575 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240575 ERROR (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240575 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000018 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}} [junit4] 2> 240576 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found [junit4] 2> 240577 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000018 state SyncConnected [junit4] 2> 240578 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000016 complete, response:{} [junit4] 2> 240578 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=16 [junit4] 2> 240584 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240585 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000016 state SyncConnected [junit4] 2> 240586 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=0 QTime=36 [junit4] 2> 240587 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000020 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240587 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240588 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240588 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/schema.xml to /configs/configSet1/schema.xml [junit4] 2> 240589 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/schema.xml [junit4] 2> 240590 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/solrconfig.xml to /configs/configSet1/solrconfig.xml [junit4] 2> 240590 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/solrconfig.xml [junit4] 2> 240591 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000020 complete, response:{} [junit4] 2> 240592 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000020 state SyncConnected [junit4] 2> 240593 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=18 [junit4] 2> 240593 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000022 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240593 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240596 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240600 ERROR (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240601 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000022 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}} [junit4] 2> 240603 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000022 state SyncConnected [junit4] 2> 240605 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=20 [junit4] 2> 240619 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240646 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000024 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240646 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000028 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240647 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , { [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240647 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240650 ERROR (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240652 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000028 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}} [junit4] 2> 240652 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found [junit4] 2> 240654 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000028 state SyncConnected [junit4] 2> 240656 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000024 complete, response:{} [junit4] 2> 240657 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000026 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240658 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240660 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/schema.xml to /configs/configSet1/schema.xml [junit4] 2> 240661 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/schema.xml [junit4] 2> 240662 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=42 [junit4] 2> 240664 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/solrconfig.xml to /configs/configSet1/solrconfig.xml [junit4] 2> 240665 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/solrconfig.xml [junit4] 2> 240666 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240667 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000026 complete, response:{} [junit4] 2> 240692 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000024 state SyncConnected [junit4] 2> 240694 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000030 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240694 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240694 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=0 QTime=106 [junit4] 2> 240694 ERROR (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240695 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000030 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}} [junit4] 2> 240696 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240697 INFO (zkCallback-313-thread-1-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000030 state SyncConnected [junit4] 2> 240697 INFO (zkCallback-313-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000026 state SyncConnected [junit4] 2> 240698 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=101 [junit4] 2> 240698 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=32 [junit4] 2> 240699 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000032 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240699 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , { [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240699 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found [junit4] 2> 240700 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240700 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240701 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000032 complete, response:{} [junit4] 2> 240702 INFO (zkCallback-313-thread-2-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000032 state SyncConnected [junit4] 2> 240722 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000034 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240723 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240724 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/schema.xml to /configs/configSet1/schema.xml [junit4] 2> 240724 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/schema.xml [junit4] 2> 240726 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/solrconfig.xml to /configs/configSet1/solrconfig.xml [junit4] 2> 240726 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/solrconfig.xml [junit4] 2> 240729 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000034 complete, response:{} [junit4] 2> 240729 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=0 QTime=32 [junit4] 2> 240730 INFO (zkCallback-313-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000034 state SyncConnected [junit4] 2> 240730 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000035 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240731 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240731 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=31 [junit4] 2> 240731 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240732 ERROR (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240733 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000035 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}} [junit4] 2> 240733 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240734 INFO (zkCallback-313-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000035 state SyncConnected [junit4] 2> 240735 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000038 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240735 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , { [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240735 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=35 [junit4] 2> 240736 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found [junit4] 2> 240737 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000038 complete, response:{} [junit4] 2> 240738 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000040 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240738 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240738 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240739 INFO (zkCallback-313-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000038 state SyncConnected [junit4] 2> 240739 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/schema.xml to /configs/configSet1/schema.xml [junit4] 2> 240740 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/schema.xml [junit4] 2> 240740 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=0 QTime=8 [junit4] 2> 240742 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240749 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/solrconfig.xml to /configs/configSet1/solrconfig.xml [junit4] 2> 240749 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/solrconfig.xml [junit4] 2> 240750 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000040 complete, response:{} [junit4] 2> 240751 INFO (zkCallback-313-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000040 state SyncConnected [junit4] 2> 240752 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=18 [junit4] 2> 240752 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000042 message:{ [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240752 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000044 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240752 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"baseConfigSet1", [junit4] 2> "baseConfigSet":"grandBaseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240753 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , { [junit4] 2> "name":"configSet1", [junit4] 2> "operation":"configsets:delete"} [junit4] 2> 240753 ERROR (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1 [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289) [junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 240754 INFO (OverseerThreadFactory-464-thread-5-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000042 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}} [junit4] 2> 240754 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found [junit4] 2> 240754 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240755 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000044 complete, response:{} [junit4] 2> 240756 INFO (zkCallback-313-thread-2-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000044 state SyncConnected [junit4] 2> 240756 INFO (zkCallback-313-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000042 state SyncConnected [junit4] 2> 240757 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000046 message:{ [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240758 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=19 [junit4] 2> 240758 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , { [junit4] 2> "name":"configSet1", [junit4] 2> "baseConfigSet":"baseConfigSet1", [junit4] 2> "operation":"configsets:create"} [junit4] 2> 240761 INFO (qtp1414551923-1474) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2 [junit4] 2> 240781 INFO (qtp1414551923-1475) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=0 QTime=38 [junit4] 2> 240781 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/schema.xml to /configs/configSet1/schema.xml [junit4] 2> 240782 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/schema.xml [junit4] 2> 240783 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/solrconfig.xml to /configs/configSet1/solrconfig.xml [junit4] 2> 240783 INFO (qtp1414551923-1444) [n:127.0.0.1:34299_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2 [junit4] 2> 240784 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/solrconfig.xml [junit4] 2> 240785 INFO (OverseerThreadFactory-464-thread-4-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000046 complete, response:{} [junit4] 2> 240785 INFO (zkCallback-313-thread-3-processing-n:127.0.0.1:34299_solr) [n:127.0.0.1:34299_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000046 state SyncConnected [junit4] 2> 240786 INFO (qtp1414551923-1443) [n:127.0.0.1:34299_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=31 [junit4] 2> 240786 INFO (OverseerCollectionConfigSetProcessor-94499637494022147-127.0.0.1:34299_solr-n_0000000000) [n:127.0.0.1:34299_solr ] o.a [...truncated too long message...] [junit4] 2> 12 /solr/live_nodes [junit4] 2> 12 /solr/collections [junit4] 2> 5 /solr/overseer/queue [junit4] 2> 5 /solr/overseer/collection-queue-work [junit4] 2> 4 /solr/overseer/queue-work [junit4] 2> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=CustomCollectionTest -Dtests.method=test -Dtests.seed=FCDE45D1F602FFAC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=iw_IL -Dtests.timezone=America/Metlakatla -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 6924s J0 | CustomCollectionTest.test <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:40367/af_h/xw: collection already exists: testCreateShardRepFactor [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1574) [junit4] > at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1528) [junit4] > at org.apache.solr.cloud.CustomCollectionTest.testCreateShardRepFactor(CustomCollectionTest.java:386) [junit4] > at org.apache.solr.cloud.CustomCollectionTest.test(CustomCollectionTest.java:97) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938) [junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=7920, name=RecoveryThread-routeFieldColl_shard3_replica1, state=RUNNABLE, group=TGRP-CustomCollectionTest] [junit4] > Caused by: java.lang.OutOfMemoryError: Java heap space [junit4] > at __randomizedtesting.SeedInfo.seed([FCDE45D1F602FFAC]:0) [junit4] > at org.apache.solr.handler.IndexFetcher$FileFetcher.<init>(IndexFetcher.java:1325) [junit4] > at org.apache.solr.handler.IndexFetcher$DirectoryFileFetcher.<init>(IndexFetcher.java:1575) [junit4] > at org.apache.solr.handler.IndexFetcher.downloadIndexFiles(IndexFetcher.java:842) [junit4] > at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:437) [junit4] > at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:265) [junit4] > at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:385) [junit4] > at org.apache.solr.cloud.RecoveryStrategy.replicate(RecoveryStrategy.java:162) [junit4] > at org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:437) [junit4] > at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:227)Throwable #3: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=7922, name=RecoveryThread-routeFieldColl_shard1_replica1, state=RUNNABLE, group=TGRP-CustomCollectionTest] [junit4] > Caused by: java.lang.OutOfMemoryError: Java heap space [junit4] 2> 8162223 INFO (SUITE-CustomCollectionTest-seed#[FCDE45D1F602FFAC]-worker) [n:127.0.0.1:40235_af_h%2Fxw c:testCreateShardRepFactor s:a r:core_node1 x:testCreateShardRepFactor_a_replica1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.CustomCollectionTest_FCDE45D1F602FFAC-001 [junit4] 2> Sep 11, 2015 7:52:37 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {shard_s=PostingsFormat(name=Memory doPackFST= false), other_tl1=PostingsFormat(name=Direct), range_facet_l_dv=PostingsFormat(name=Asserting), multiDefault=PostingsFormat(name=Memory doPackFST= false), intDefault=PostingsFormat(name=Direct), a_i1=PostingsFormat(name=Memory doPackFST= false), range_facet_l=PostingsFormat(name=Memory doPackFST= false), _version_=PostingsFormat(name=Direct), a_t=PostingsFormat(name=Memory doPackFST= false), id=PostingsFormat(name=Asserting), range_facet_i_dv=PostingsFormat(name=Memory doPackFST= false), text=Lucene50(blocksize=128), _route_=Lucene50(blocksize=128), timestamp=PostingsFormat(name=Memory doPackFST= false)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), range_facet_i_dv=DocValuesFormat(name=Lucene50), timestamp=DocValuesFormat(name=Lucene50)}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=iw_IL, timezone=America/Metlakatla [junit4] 2> NOTE: Linux 3.19.0-26-generic amd64/Oracle Corporation 1.8.0_60 (64-bit)/cpus=12,threads=1,free=206663416,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [TestConfigSetImmutable, CdcrReplicationHandlerTest, ExternalFileFieldSortTest, TestRandomFaceting, TestStressLucene, TestDocumentBuilder, CollectionTooManyReplicasTest, TestCollationFieldDocValues, DocumentAnalysisRequestHandlerTest, ExitableDirectoryReaderTest, PeerSyncTest, TestConfigSetsAPIZkFailure, SmileWriterTest, TestAnalyzedSuggestions, TestConfigSetsAPIExclusivity, TestComplexPhraseQParserPlugin, TestReplicaProperties, TestMiniSolrCloudClusterSSL, CoreMergeIndexesAdminHandlerTest, SolrCoreTest, RollingRestartTest, DistributedSuggestComponentTest, VersionInfoTest, TestBlobHandler, DisMaxRequestHandlerTest, AnalysisAfterCoreReloadTest, DateMathParserTest, TestDocSet, SolrRequestParserTest, AliasIntegrationTest, ConnectionManagerTest, SynonymTokenizerTest, BasicDistributedZkTest, TestCloudInspectUtil, TestDistributedMissingSort, TestHighlightDedupGrouping, DeleteInactiveReplicaTest, EchoParamsTest, TestRandomMergePolicy, TestConfig, ResponseLogComponentTest, SOLR749Test, TestTrackingShardHandlerFactory, TestLMDirichletSimilarityFactory, SimpleCollectionCreateDeleteTest, PathHierarchyTokenizerFactoryTest, TestDistributedSearch, TestDynamicFieldResource, TestInitQParser, OpenExchangeRatesOrgProviderTest, TestPhraseSuggestions, CursorPagingTest, TestRestManager, TestRealTimeGet, TestRandomDVFaceting, DistributedQueryComponentOptimizationTest, DistributedVersionInfoTest, DistributedFacetPivotLargeTest, TestJoin, ChangedSchemaMergeTest, CdcrReplicationDistributedZkTest, SaslZkACLProviderTest, JavabinLoaderTest, TestRawResponseWriter, TestRecoveryHdfs, XsltUpdateRequestHandlerTest, TestInitParams, IndexSchemaRuntimeFieldTest, OutOfBoxZkACLAndCredentialsProvidersTest, TestCSVLoader, TestOmitPositions, TestValueSourceCache, TestInfoStreamLogging, TestSolrQueryParserDefaultOperatorResource, HdfsUnloadDistributedZkTest, JsonLoaderTest, SpatialHeatmapFacetsTest, TestSimpleQParserPlugin, SpellingQueryConverterTest, TestManagedSchemaFieldResource, LeaderInitiatedRecoveryOnCommitTest, TestExactStatsCache, TestPseudoReturnFields, StandardRequestHandlerTest, DefaultValueUpdateProcessorTest, TestExceedMaxTermLength, TestChildDocTransformer, TimeZoneUtilsTest, IndexSchemaTest, CustomCollectionTest] [junit4] Completed [545/545] on J0 in 6925.36s, 1 test, 1 error <<< FAILURES! [...truncated 1 lines...] [junit4] JVM J0: stdout was not empty, see: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/temp/junit4-J0-20150911_053632_829.sysout [junit4] >>> JVM J0: stdout (verbatim) ---- [junit4] java.lang.OutOfMemoryError: Java heap space [junit4] Dumping heap to /home/jenkins/workspace/Lucene-Solr-trunk-Linux/heapdumps/java_pid22208.hprof ... [junit4] Heap dump file created [552183142 bytes in 2.524 secs] [junit4] <<< JVM J0: EOF ---- [...truncated 11 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:775: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:719: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:59: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:233: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:514: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1432: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:987: There were test failures: 545 suites, 2143 tests, 1 error, 1 failure, 71 ignored (35 assumptions) Total time: 155 minutes 0 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
