You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/09/18 21:44:11 UTC
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.8.0_60) - Build #
5266 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/5266/
Java: 64bit/jdk1.8.0_60 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.cloud.TestConfigSetsAPI.testDeleteErrors
Error Message:
Expected exception message to contain: Requested delete of immutable ConfigSet got: Error from server at http://127.0.0.1:59369/solr: delete the configset time out:300s
Stack Trace:
java.lang.AssertionError: Expected exception message to contain: Requested delete of immutable ConfigSet got: Error from server at http://127.0.0.1:59369/solr: delete the configset time out:300s
at __randomizedtesting.SeedInfo.seed([4D12A66A20B3625C:44F07947A5C56348]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.cloud.TestConfigSetsAPI.verifyException(TestConfigSetsAPI.java:268)
at org.apache.solr.cloud.TestConfigSetsAPI.testDeleteErrors(TestConfigSetsAPI.java:257)
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 9550 lines...]
[junit4] Suite: org.apache.solr.cloud.TestConfigSetsAPI
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\init-core-data-001
[junit4] 2> 143543 INFO (SUITE-TestConfigSetsAPI-seed#[4D12A66A20B3625C]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 143545 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDelete
[junit4] 2> 143550 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 143551 INFO (Thread-241) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 143551 INFO (Thread-241) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 143658 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer start zk server on port:59336
[junit4] 2> 143658 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143660 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143666 INFO (zkCallback-86-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4957811f name:ZooKeeperConnection Watcher:127.0.0.1:59336 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143666 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143666 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143667 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 143673 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x14fe1ce7f9a0000, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 143680 INFO (jetty-launcher-85-thread-1) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 143682 INFO (jetty-launcher-85-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4d6c17bf{/solr,null,AVAILABLE}
[junit4] 2> 143685 INFO (jetty-launcher-85-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@11621332{HTTP/1.1}{127.0.0.1:59341}
[junit4] 2> 143686 INFO (jetty-launcher-85-thread-1) [ ] o.e.j.s.Server Started @147337ms
[junit4] 2> 143686 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59341}
[junit4] 2> 143686 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 143686 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-001\'
[junit4] 2> 143732 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143734 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143736 INFO (zkCallback-87-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@562cb167 name:ZooKeeperConnection Watcher:127.0.0.1:59336/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143736 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143736 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143737 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 143749 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-001\.
[junit4] 2> 143750 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 130204332
[junit4] 2> 143750 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-001\]
[junit4] 2> 143750 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-001\lib
[junit4] 2> 143751 WARN (jetty-launcher-85-thread-1) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-001\lib).
[junit4] 2> 143760 INFO (jetty-launcher-85-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> 143763 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 143766 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 143766 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 143766 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59336/solr
[junit4] 2> 143766 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 143766 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143769 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143772 INFO (zkCallback-89-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@66a2e4e7 name:ZooKeeperConnection Watcher:127.0.0.1:59336 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143772 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143772 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143775 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143779 INFO (zkCallback-90-thread-1-processing-n:127.0.0.1:59341_solr) [n:127.0.0.1:59341_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5d78655b name:ZooKeeperConnection Watcher:127.0.0.1:59336/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143779 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143781 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 143784 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 143789 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 143794 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 143797 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 143800 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 143802 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 143804 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 143805 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 143807 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 143812 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59341_solr
[junit4] 2> 143813 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:59341_solr
[junit4] 2> 143815 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 143818 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 143820 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 143821 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94542394218381315-127.0.0.1:59341_solr-n_0000000000
[junit4] 2> 143821 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59341_solr
[junit4] 2> 143821 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 143823 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.Overseer Overseer (id=94542394218381315-127.0.0.1:59341_solr-n_0000000000) starting
[junit4] 2> 143826 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 143835 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 143835 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 143835 INFO (OverseerCollectionConfigSetProcessor-94542394218381315-127.0.0.1:59341_solr-n_0000000000) [n:127.0.0.1:59341_solr ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 143836 INFO (OverseerStateUpdate-94542394218381315-127.0.0.1:59341_solr-n_0000000000) [n:127.0.0.1:59341_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 143857 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 143857 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 143859 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-001\.
[junit4] 2> 143870 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.c.CoresLocator Found 0 core definitions
[junit4] 2> 143871 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 143871 INFO (jetty-launcher-85-thread-1) [n:127.0.0.1:59341_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 143872 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143873 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143877 INFO (zkCallback-91-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@72a4a30b name:ZooKeeperConnection Watcher:127.0.0.1:59336 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143877 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143877 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143885 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143889 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143890 INFO (zkCallback-93-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7f38a06d name:ZooKeeperConnection Watcher:127.0.0.1:59336/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143890 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143890 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143895 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet/schema.xml
[junit4] 2> 143899 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet/solrconfig.xml
[junit4] 2> 143902 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 143904 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 143907 INFO (zkCallback-94-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7a3cf556 name:ZooKeeperConnection Watcher:127.0.0.1:59336/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 143907 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 143907 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 143927 INFO (qtp121480609-694) [n:127.0.0.1:59341_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet&action=DELETE&wt=javabin&version=2
[junit4] 2> 143931 INFO (OverseerCollectionConfigSetProcessor-94542394218381315-127.0.0.1:59341_solr-n_0000000000) [n:127.0.0.1:59341_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "name":"configSet",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 143932 INFO (OverseerThreadFactory-334-thread-1-processing-n:127.0.0.1:59341_solr) [n:127.0.0.1:59341_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 143937 INFO (OverseerThreadFactory-334-thread-1-processing-n:127.0.0.1:59341_solr) [n:127.0.0.1:59341_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found
[junit4] 2> 143941 INFO (OverseerThreadFactory-334-thread-1-processing-n:127.0.0.1:59341_solr) [n:127.0.0.1:59341_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000000 complete, response:{}
[junit4] 2> 143942 INFO (zkCallback-90-thread-1-processing-n:127.0.0.1:59341_solr) [n:127.0.0.1:59341_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000000 state SyncConnected
[junit4] 2> 143944 INFO (qtp121480609-694) [n:127.0.0.1:59341_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet&action=DELETE&wt=javabin&version=2} status=0 QTime=25
[junit4] 2> 143951 INFO (jetty-launcher-85-thread-1) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@11621332{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 143951 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=130204332
[junit4] 2> 143951 INFO (jetty-launcher-85-thread-1) [ ] o.a.s.c.Overseer Overseer (id=94542394218381315-127.0.0.1:59341_solr-n_0000000000) closing
[junit4] 2> 143951 INFO (OverseerStateUpdate-94542394218381315-127.0.0.1:59341_solr-n_0000000000) [n:127.0.0.1:59341_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:59341_solr
[junit4] 2> 143955 INFO (zkCallback-90-thread-1-processing-n:127.0.0.1:59341_solr) [n:127.0.0.1:59341_solr ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 143955 WARN (zkCallback-90-thread-1-processing-n:127.0.0.1:59341_solr) [n:127.0.0.1:59341_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 143956 INFO (jetty-launcher-85-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4d6c17bf{/solr,null,UNAVAILABLE}
[junit4] 2> 143959 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59336 59336
[junit4] 2> 146388 INFO (Thread-241) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59336 59336
[junit4] 2> 146390 INFO (TEST-TestConfigSetsAPI.testDelete-seed#[4D12A66A20B3625C]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDelete
[junit4] 2> 146396 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDeleteErrors
[junit4] 2> 146401 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 146402 INFO (Thread-254) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 146402 INFO (Thread-254) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 146510 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer start zk server on port:59365
[junit4] 2> 146510 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 146511 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 146515 INFO (zkCallback-96-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6c73c785 name:ZooKeeperConnection Watcher:127.0.0.1:59365 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 146515 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146515 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 146516 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 146523 INFO (jetty-launcher-95-thread-1) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 146526 INFO (jetty-launcher-95-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@af36b9b{/solr,null,AVAILABLE}
[junit4] 2> 146527 INFO (jetty-launcher-95-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@784890aa{HTTP/1.1}{127.0.0.1:59369}
[junit4] 2> 146528 INFO (jetty-launcher-95-thread-1) [ ] o.e.j.s.Server Started @149980ms
[junit4] 2> 146528 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=59369}
[junit4] 2> 146528 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 146529 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-002\'
[junit4] 2> 146541 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 146542 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 146544 INFO (zkCallback-97-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@34b14a8b name:ZooKeeperConnection Watcher:127.0.0.1:59365/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 146544 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146544 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 146545 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 146551 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-002\.
[junit4] 2> 146552 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 716651915
[junit4] 2> 146552 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-002\]
[junit4] 2> 146552 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-002\lib
[junit4] 2> 146552 WARN (jetty-launcher-95-thread-1) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-002\lib).
[junit4] 2> 146559 INFO (jetty-launcher-95-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> 146561 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 146561 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 146562 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 146562 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:59365/solr
[junit4] 2> 146562 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 146562 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 146563 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 146565 INFO (zkCallback-99-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6161c5d name:ZooKeeperConnection Watcher:127.0.0.1:59365 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 146566 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146566 INFO (jetty-launcher-95-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 146569 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 146571 INFO (zkCallback-100-thread-1-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16bc8ad3 name:ZooKeeperConnection Watcher:127.0.0.1:59365/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 146571 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146572 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 146575 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 146578 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 146581 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 146583 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 146586 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 146588 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 146589 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 146591 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 146591 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 146591 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:59369_solr
[junit4] 2> 146591 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:59369_solr
[junit4] 2> 146596 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 146598 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 146599 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 146601 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94542394405158915-127.0.0.1:59369_solr-n_0000000000
[junit4] 2> 146601 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:59369_solr
[junit4] 2> 146601 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 146603 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.Overseer Overseer (id=94542394405158915-127.0.0.1:59369_solr-n_0000000000) starting
[junit4] 2> 146606 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 146613 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 146614 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 146614 INFO (OverseerCollectionConfigSetProcessor-94542394405158915-127.0.0.1:59369_solr-n_0000000000) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 146614 INFO (OverseerStateUpdate-94542394405158915-127.0.0.1:59369_solr-n_0000000000) [n:127.0.0.1:59369_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 146632 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 146632 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 146633 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-002\.
[junit4] 2> 146644 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.c.CoresLocator Found 0 core definitions
[junit4] 2> 146645 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 146645 INFO (jetty-launcher-95-thread-1) [n:127.0.0.1:59369_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 146645 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 146646 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 146648 INFO (zkCallback-101-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@79654342 name:ZooKeeperConnection Watcher:127.0.0.1:59365 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 146649 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146650 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 146653 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x14fe1ce8abc0004, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 146662 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 146663 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 146665 INFO (zkCallback-103-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@d3048da name:ZooKeeperConnection Watcher:127.0.0.1:59365/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 146665 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146665 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 146666 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet/configsetprops.json
[junit4] 2> 146670 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet/schema.xml
[junit4] 2> 146672 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet/solrconfig.xml
[junit4] 2> 146676 INFO (qtp589677729-742) [n:127.0.0.1:59369_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params action=DELETE&wt=javabin&version=2
[junit4] 2> 146677 ERROR (qtp589677729-742) [n:127.0.0.1:59369_solr ] o.a.s.c.SolrCore org.apache.solr.common.SolrException: Missing required parameter: name
[junit4] 2> at org.apache.solr.common.params.RequiredSolrParams.getParams(RequiredSolrParams.java:91)
[junit4] 2> at org.apache.solr.common.params.SolrParams.getAll(SolrParams.java:377)
[junit4] 2> at org.apache.solr.handler.admin.ConfigSetsHandler$ConfigSetOperation$2.call(ConfigSetsHandler.java:171)
[junit4] 2> at org.apache.solr.handler.admin.ConfigSetsHandler.handleRequestBody(ConfigSetsHandler.java:97)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:673)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:441)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:214)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:179)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
[junit4] 2> at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:499)
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 146678 INFO (qtp589677729-742) [n:127.0.0.1:59369_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={action=DELETE&wt=javabin&version=2} status=400 QTime=1
[junit4] 2> 146684 INFO (qtp589677729-743) [n:127.0.0.1:59369_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSetBogus&action=DELETE&wt=javabin&version=2
[junit4] 2> 146686 INFO (OverseerCollectionConfigSetProcessor-94542394405158915-127.0.0.1:59369_solr-n_0000000000) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "name":"configSetBogus",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 146689 INFO (OverseerThreadFactory-341-thread-1-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSetBogus",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 146690 ERROR (OverseerThreadFactory-341-thread-1-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSetBogus operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSetBogus
[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> 146695 INFO (OverseerThreadFactory-341-thread-1-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_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: configSetBogus,exception={msg=ConfigSet does not exist to delete: configSetBogus,rspCode=400}}
[junit4] 2> 146697 INFO (zkCallback-100-thread-1-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000000 state SyncConnected
[junit4] 2> 146701 INFO (qtp589677729-743) [n:127.0.0.1:59369_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSetBogus&action=DELETE&wt=javabin&version=2} status=400 QTime=16
[junit4] 2> 146704 INFO (qtp589677729-744) [n:127.0.0.1:59369_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet&action=DELETE&wt=javabin&version=2
[junit4] 2> 146706 INFO (OverseerCollectionConfigSetProcessor-94542394405158915-127.0.0.1:59369_solr-n_0000000000) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000002 message:{
[junit4] 2> "name":"configSet",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 146707 INFO (OverseerThreadFactory-341-thread-2-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 146710 ERROR (OverseerThreadFactory-341-thread-2-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet operation: delete failed:org.apache.solr.common.SolrException: Requested delete of immutable ConfigSet: configSet
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:360)
[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> 146711 INFO (OverseerThreadFactory-341-thread-2-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000002 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: Requested delete of immutable ConfigSet: configSet,exception={msg=Requested delete of immutable ConfigSet: configSet,rspCode=400}}
[junit4] 2> 449748 ERROR (qtp589677729-744) [n:127.0.0.1:59369_solr ] o.a.s.c.SolrCore org.apache.solr.common.SolrException: delete the configset time out:300s
[junit4] 2> at org.apache.solr.handler.admin.ConfigSetsHandler.handleResponse(ConfigSetsHandler.java:129)
[junit4] 2> at org.apache.solr.handler.admin.ConfigSetsHandler.handleRequestBody(ConfigSetsHandler.java:103)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:673)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:441)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:214)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:179)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
[junit4] 2> at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:499)
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 449748 INFO (zkCallback-100-thread-2-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.OverseerTaskQueue NodeDeleted fired on path /overseer/collection-queue-work/qnr-0000000002 state SyncConnected
[junit4] 2> 449749 INFO (qtp589677729-744) [n:127.0.0.1:59369_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet&action=DELETE&wt=javabin&version=2} status=500 QTime=301567
[junit4] 2> 449756 ERROR (qtp589677729-744) [n:127.0.0.1:59369_solr ] o.a.s.s.SolrDispatchFilter null:org.apache.solr.common.SolrException: delete the configset time out:300s
[junit4] 2> at org.apache.solr.handler.admin.ConfigSetsHandler.handleResponse(ConfigSetsHandler.java:129)
[junit4] 2> at org.apache.solr.handler.admin.ConfigSetsHandler.handleRequestBody(ConfigSetsHandler.java:103)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:673)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:441)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:214)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:179)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:109)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
[junit4] 2> at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:364)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:499)
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 449761 INFO (jetty-launcher-95-thread-2) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@784890aa{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 449762 INFO (jetty-launcher-95-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=716651915
[junit4] 2> 449763 INFO (jetty-launcher-95-thread-2) [ ] o.a.s.c.Overseer Overseer (id=94542394405158915-127.0.0.1:59369_solr-n_0000000000) closing
[junit4] 2> 449763 INFO (OverseerStateUpdate-94542394405158915-127.0.0.1:59369_solr-n_0000000000) [n:127.0.0.1:59369_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:59369_solr
[junit4] 2> 449768 INFO (zkCallback-100-thread-2-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live nodes size: 1)
[junit4] 2> 449768 WARN (zkCallback-100-thread-2-processing-n:127.0.0.1:59369_solr) [n:127.0.0.1:59369_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 449769 INFO (jetty-launcher-95-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@af36b9b{/solr,null,UNAVAILABLE}
[junit4] 2> 449771 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59365 59365
[junit4] 2> 451881 INFO (Thread-254) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59365 59365
[junit4] 2> 451883 INFO (TEST-TestConfigSetsAPI.testDeleteErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDeleteErrors
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestConfigSetsAPI -Dtests.method=testDeleteErrors -Dtests.seed=4D12A66A20B3625C -Dtests.slow=true -Dtests.locale=sr_ME -Dtests.timezone=Antarctica/Casey -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 305s J0 | TestConfigSetsAPI.testDeleteErrors <<<
[junit4] > Throwable #1: java.lang.AssertionError: Expected exception message to contain: Requested delete of immutable ConfigSet got: Error from server at http://127.0.0.1:59369/solr: delete the configset time out:300s
[junit4] > at __randomizedtesting.SeedInfo.seed([4D12A66A20B3625C:44F07947A5C56348]:0)
[junit4] > at org.apache.solr.cloud.TestConfigSetsAPI.verifyException(TestConfigSetsAPI.java:268)
[junit4] > at org.apache.solr.cloud.TestConfigSetsAPI.testDeleteErrors(TestConfigSetsAPI.java:257)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 451890 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCreate
[junit4] 2> 451891 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 451892 INFO (Thread-266) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 451892 INFO (Thread-266) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 451983 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer start zk server on port:60280
[junit4] 2> 451983 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 451987 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 451990 INFO (zkCallback-105-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@79639e22 name:ZooKeeperConnection Watcher:127.0.0.1:60280 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 451990 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 451990 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 451991 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 451997 INFO (jetty-launcher-104-thread-1) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 451999 INFO (jetty-launcher-104-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@ab76986{/solr,null,AVAILABLE}
[junit4] 2> 452000 INFO (jetty-launcher-104-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@30e4b0f6{HTTP/1.1}{127.0.0.1:60284}
[junit4] 2> 452000 INFO (jetty-launcher-104-thread-1) [ ] o.e.j.s.Server Started @454125ms
[junit4] 2> 452000 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=60284}
[junit4] 2> 452001 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 452002 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-004\'
[junit4] 2> 452036 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452039 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452046 INFO (zkCallback-106-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4df69f3f name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452046 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452046 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452047 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 452055 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.CoresLocator Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-004\.
[junit4] 2> 452055 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 1952412311
[junit4] 2> 452055 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-004\]
[junit4] 2> 452055 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.CoreContainer loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-004\lib
[junit4] 2> 452055 WARN (jetty-launcher-104-thread-1) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-004\lib).
[junit4] 2> 452061 INFO (jetty-launcher-104-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> 452064 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 452064 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 452064 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 452064 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:60280/solr
[junit4] 2> 452065 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 452065 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452065 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452067 INFO (zkCallback-108-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@40c7479d name:ZooKeeperConnection Watcher:127.0.0.1:60280 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452068 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452068 INFO (jetty-launcher-104-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452073 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452076 INFO (zkCallback-109-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@78a43d72 name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452076 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452078 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 452080 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 452085 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 452089 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 452089 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 452093 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 452097 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 452098 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 452102 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 452104 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 452105 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60284_solr
[junit4] 2> 452106 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:60284_solr
[junit4] 2> 452107 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 452109 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 452110 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 452112 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94542414425817091-127.0.0.1:60284_solr-n_0000000000
[junit4] 2> 452112 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60284_solr
[junit4] 2> 452113 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 452114 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.Overseer Overseer (id=94542414425817091-127.0.0.1:60284_solr-n_0000000000) starting
[junit4] 2> 452115 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 452122 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 452122 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 452123 INFO (OverseerStateUpdate-94542414425817091-127.0.0.1:60284_solr-n_0000000000) [n:127.0.0.1:60284_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 452125 INFO (OverseerCollectionConfigSetProcessor-94542414425817091-127.0.0.1:60284_solr-n_0000000000) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 452172 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 452172 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 452175 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.CoresLocator Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001\tempDir-004\.
[junit4] 2> 452183 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.c.CoresLocator Found 0 core definitions
[junit4] 2> 452185 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.s.SolrDispatchFilter user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 452185 INFO (jetty-launcher-104-thread-1) [n:127.0.0.1:60284_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 452185 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452196 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452198 INFO (zkCallback-110-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@71654a1c name:ZooKeeperConnection Watcher:127.0.0.1:60280 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452198 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452198 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452208 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452213 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452215 INFO (zkCallback-112-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@418e3b6b name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452215 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452216 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452217 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet1/schema.xml
[junit4] 2> 452222 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet1/solrconfig.xml
[junit4] 2> 452226 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452228 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452234 INFO (zkCallback-113-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4c4fc491 name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452234 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452235 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452238 INFO (qtp299062618-790) [n:127.0.0.1:60284_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> 452241 INFO (OverseerCollectionConfigSetProcessor-94542414425817091-127.0.0.1:60284_solr-n_0000000000) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 452242 INFO (OverseerThreadFactory-348-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 452243 INFO (OverseerThreadFactory-348-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/schema.xml to /configs/configSet1/schema.xml
[junit4] 2> 452244 INFO (OverseerThreadFactory-348-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/schema.xml
[junit4] 2> 452246 INFO (OverseerThreadFactory-348-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet1/solrconfig.xml to /configs/configSet1/solrconfig.xml
[junit4] 2> 452247 INFO (OverseerThreadFactory-348-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet1/solrconfig.xml
[junit4] 2> 452249 INFO (OverseerThreadFactory-348-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000000 complete, response:{}
[junit4] 2> 452251 INFO (zkCallback-109-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000000 state SyncConnected
[junit4] 2> 452252 INFO (qtp299062618-790) [n:127.0.0.1:60284_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=14
[junit4] 2> 452259 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452260 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452263 INFO (zkCallback-114-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2a86105b name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452263 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452263 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452265 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet2/schema.xml
[junit4] 2> 452270 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet2/solrconfig.xml
[junit4] 2> 452274 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452277 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452280 INFO (zkCallback-115-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2a8c633b name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452280 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452280 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452283 INFO (qtp299062618-792) [n:127.0.0.1:60284_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet2&configSetProp.key1=value1&name=configSet2&action=CREATE&configSetProp.immutable=true&wt=javabin&version=2
[junit4] 2> 452286 INFO (OverseerCollectionConfigSetProcessor-94542414425817091-127.0.0.1:60284_solr-n_0000000000) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000002 message:{
[junit4] 2> "name":"configSet2",
[junit4] 2> "baseConfigSet":"baseConfigSet2",
[junit4] 2> "configSetProp.key1":"value1",
[junit4] 2> "configSetProp.immutable":"true",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 452286 INFO (OverseerThreadFactory-348-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"configSet2",
[junit4] 2> "baseConfigSet":"baseConfigSet2",
[junit4] 2> "configSetProp.key1":"value1",
[junit4] 2> "configSetProp.immutable":"true",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 452288 INFO (OverseerThreadFactory-348-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found
[junit4] 2> 452288 INFO (OverseerThreadFactory-348-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet2/schema.xml to /configs/configSet2/schema.xml
[junit4] 2> 452289 INFO (OverseerThreadFactory-348-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet2/schema.xml
[junit4] 2> 452292 INFO (OverseerThreadFactory-348-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet2/solrconfig.xml to /configs/configSet2/solrconfig.xml
[junit4] 2> 452293 INFO (OverseerThreadFactory-348-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet2/solrconfig.xml
[junit4] 2> 452294 INFO (OverseerThreadFactory-348-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet2/configsetprops.json
[junit4] 2> 452299 INFO (OverseerThreadFactory-348-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000002 complete, response:{}
[junit4] 2> 452302 INFO (zkCallback-109-thread-1-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000002 state SyncConnected
[junit4] 2> 452302 INFO (qtp299062618-792) [n:127.0.0.1:60284_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet2&configSetProp.key1=value1&name=configSet2&action=CREATE&configSetProp.immutable=true&wt=javabin&version=2} status=0 QTime=21
[junit4] 2> 452304 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x14fe1d3340f0008, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 452309 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452310 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452316 INFO (zkCallback-116-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@7bd45e54 name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452316 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452317 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452318 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet3/configsetprops.json
[junit4] 2> 452325 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet3/schema.xml
[junit4] 2> 452326 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet3/solrconfig.xml
[junit4] 2> 452329 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452330 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452336 INFO (zkCallback-117-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@61b3934f name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452336 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 452336 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 452339 INFO (qtp299062618-794) [n:127.0.0.1:60284_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet3&name=configSet3&action=CREATE&wt=javabin&version=2
[junit4] 2> 452342 INFO (OverseerCollectionConfigSetProcessor-94542414425817091-127.0.0.1:60284_solr-n_0000000000) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000004 message:{
[junit4] 2> "name":"configSet3",
[junit4] 2> "baseConfigSet":"baseConfigSet3",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 452346 INFO (OverseerThreadFactory-348-thread-3-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"configSet3",
[junit4] 2> "baseConfigSet":"baseConfigSet3",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 452351 INFO (OverseerThreadFactory-348-thread-3-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet3/schema.xml to /configs/configSet3/schema.xml
[junit4] 2> 452352 INFO (OverseerThreadFactory-348-thread-3-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet3/schema.xml
[junit4] 2> 452356 INFO (OverseerThreadFactory-348-thread-3-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet3/configsetprops.json to /configs/configSet3/configsetprops.json
[junit4] 2> 452372 INFO (OverseerThreadFactory-348-thread-3-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet3/configsetprops.json
[junit4] 2> 452377 INFO (OverseerThreadFactory-348-thread-3-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/baseConfigSet3/solrconfig.xml to /configs/configSet3/solrconfig.xml
[junit4] 2> 452378 INFO (OverseerThreadFactory-348-thread-3-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/configSet3/solrconfig.xml
[junit4] 2> 452380 INFO (OverseerThreadFactory-348-thread-3-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000004 complete, response:{}
[junit4] 2> 452381 INFO (zkCallback-109-thread-2-processing-n:127.0.0.1:60284_solr) [n:127.0.0.1:60284_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000004 state SyncConnected
[junit4] 2> 452383 INFO (qtp299062618-794) [n:127.0.0.1:60284_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet3&name=configSet3&action=CREATE&wt=javabin&version=2} status=0 QTime=47
[junit4] 2> 452389 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 452391 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 452393 INFO (zkCallback-118-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@53a28138 name:ZooKeeperConnection Watcher:127.0.0.1:60280/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 452393 INFO (TEST-TestConfigSetsAPI.testCreate-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 4523
[...truncated too long message...]
igSet already exists: configSet
[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> 454754 INFO (OverseerThreadFactory-355-thread-1-processing-n:127.0.0.1:60334_solr) [n:127.0.0.1:60334_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000000 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: configSet,exception={msg=ConfigSet already exists: configSet,rspCode=400}}
[junit4] 2> 454755 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:60334_solr) [n:127.0.0.1:60334_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000000 state SyncConnected
[junit4] 2> 454758 INFO (qtp1727079110-862) [n:127.0.0.1:60334_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet&name=configSet&action=CREATE&wt=javabin&version=2} status=400 QTime=11
[junit4] 2> 454760 INFO (qtp1727079110-863) [n:127.0.0.1:60334_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=baseConfigSet&name=newConfigSet&action=CREATE&wt=javabin&version=2
[junit4] 2> 454763 INFO (OverseerCollectionConfigSetProcessor-94542414597652483-127.0.0.1:60334_solr-n_0000000000) [n:127.0.0.1:60334_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000002 message:{
[junit4] 2> "name":"newConfigSet",
[junit4] 2> "baseConfigSet":"baseConfigSet",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 454764 INFO (OverseerThreadFactory-355-thread-2-processing-n:127.0.0.1:60334_solr) [n:127.0.0.1:60334_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"newConfigSet",
[junit4] 2> "baseConfigSet":"baseConfigSet",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 454765 ERROR (OverseerThreadFactory-355-thread-2-processing-n:127.0.0.1:60334_solr) [n:127.0.0.1:60334_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: newConfigSet operation: create failed:org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet
[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> 454766 INFO (OverseerThreadFactory-355-thread-2-processing-n:127.0.0.1:60334_solr) [n:127.0.0.1:60334_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000002 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet,exception={msg=Base ConfigSet does not exist: baseConfigSet,rspCode=400}}
[junit4] 2> 454767 INFO (zkCallback-125-thread-1-processing-n:127.0.0.1:60334_solr) [n:127.0.0.1:60334_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000002 state SyncConnected
[junit4] 2> 454768 INFO (qtp1727079110-863) [n:127.0.0.1:60334_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet&name=newConfigSet&action=CREATE&wt=javabin&version=2} status=400 QTime=9
[junit4] 2> 454771 INFO (jetty-launcher-120-thread-1) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@70d647c6{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 454771 INFO (jetty-launcher-120-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=971320193
[junit4] 2> 454772 INFO (jetty-launcher-120-thread-1) [ ] o.a.s.c.Overseer Overseer (id=94542414597652483-127.0.0.1:60334_solr-n_0000000000) closing
[junit4] 2> 454772 INFO (OverseerStateUpdate-94542414597652483-127.0.0.1:60334_solr-n_0000000000) [n:127.0.0.1:60334_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60334_solr
[junit4] 2> 454775 ERROR (jetty-launcher-120-thread-1-EventThread) [n:127.0.0.1:60334_solr ] o.a.z.ClientCnxn Error while calling watcher
[junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1@20fea42d rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@24c134ea[Shutting down, pool size = 1, active threads = 0, queued tasks = 0, completed tasks = 7]
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214)
[junit4] 2> at java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498)
[junit4] 2> 454775 INFO (jetty-launcher-120-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@343a78f8{/solr,null,UNAVAILABLE}
[junit4] 2> 454776 INFO (TEST-TestConfigSetsAPI.testCreateErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60330 60330
[junit4] 2> 456835 INFO (Thread-278) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:60330 60330
[junit4] 2> 456836 INFO (TEST-TestConfigSetsAPI.testCreateErrors-seed#[4D12A66A20B3625C]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateErrors
[junit4] 2> 456836 INFO (SUITE-TestConfigSetsAPI-seed#[4D12A66A20B3625C]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestConfigSetsAPI_4D12A66A20B3625C-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=sr_ME, timezone=Antarctica/Casey
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_60 (64-bit)/cpus=3,threads=1,free=30275088,total=126820352
[junit4] 2> NOTE: All tests run in this JVM: [XmlUpdateRequestHandlerTest, TestShardHandlerFactory, SystemInfoHandlerTest, JsonLoaderTest, TestSolrDeletionPolicy1, AsyncMigrateRouteKeyTest, TestDFRSimilarityFactory, HighlighterTest, FileUtilsTest, DocValuesMultiTest, FacetPivotSmallTest, TestFileDictionaryLookup, TestCSVLoader, TestTrackingShardHandlerFactory, DocumentAnalysisRequestHandlerTest, ZkControllerTest, ExternalFileFieldSortTest, DistributedFacetPivotSmallTest, TestCodecSupport, TestCollapseQParserPlugin, TestHashPartitioner, TestConfigSetsAPI]
[junit4] Completed [74/546] on J0 in 313.32s, 4 tests, 1 failure <<< FAILURES!
[...truncated 1509 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:775: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:719: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:59: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:233: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:514: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1432: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:987: There were test failures: 546 suites, 2145 tests, 1 failure, 81 ignored (45 assumptions)
Total time: 69 minutes 49 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