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/08/29 15:32:14 UTC
[JENKINS] Lucene-Solr-trunk-Linux (32bit/jdk1.8.0_60) - Build #
14042 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/14042/
Java: 32bit/jdk1.8.0_60 -client -XX:+UseParallelGC
All tests passed
Build Log:
[...truncated 54616 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:775: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:655: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:638: The following files are missing svn:eol-style (or binary svn:mime-type):
* ./solr/webapp/web/css/angular/dashboard.css
* ./solr/webapp/web/js/angular/controllers/collection-overview.js
* ./solr/webapp/web/partials/collection_overview.html
Total time: 54 minutes 13 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
[JENKINS-EA] Lucene-Solr-trunk-Linux (32bit/jdk1.9.0-ea-b78) -
Build # 14044 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/14044/
Java: 32bit/jdk1.9.0-ea-b78 -client -XX:+UseG1GC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SaslZkACLProviderTest
Error Message:
6 threads leaked from SUITE scope at org.apache.solr.cloud.SaslZkACLProviderTest: 1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746) 2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:516) at java.util.TimerThread.mainLoop(Timer.java:526) at java.util.TimerThread.run(Timer.java:505) 3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746) 4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746) 5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746) 6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460) at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362) at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 6 threads leaked from SUITE scope at org.apache.solr.cloud.SaslZkACLProviderTest:
1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:516)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
at __randomizedtesting.SeedInfo.seed([BD0AF747D6DCDA97]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.SaslZkACLProviderTest
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746) 2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest] at java.lang.Object.wait(Native Method) at java.lang.Object.wait(Object.java:516) at java.util.TimerThread.mainLoop(Timer.java:526) at java.util.TimerThread.run(Timer.java:505) 3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746) 4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746) 5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093) at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746) 6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460) at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362) at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941) at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:746)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest]
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:516)
at java.util.TimerThread.mainLoop(Timer.java:526)
at java.util.TimerThread.run(Timer.java:505)
3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:746)
at __randomizedtesting.SeedInfo.seed([BD0AF747D6DCDA97]:0)
FAILED: org.apache.solr.cloud.SaslZkACLProviderTest.testSaslZkACLProvider
Error Message:
java.net.BindException: Address already in use
Stack Trace:
java.lang.RuntimeException: java.net.BindException: Address already in use
at org.apache.solr.cloud.SaslZkACLProviderTest$SaslZkTestServer.run(SaslZkACLProviderTest.java:211)
at org.apache.solr.cloud.SaslZkACLProviderTest.setUp(SaslZkACLProviderTest.java:81)
at sun.reflect.GeneratedMethodAccessor11.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:504)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
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:746)
Caused by: java.net.BindException: Address already in use
at sun.nio.ch.Net.bind0(Native Method)
at sun.nio.ch.Net.bind(Net.java:433)
at sun.nio.ch.Net.bind(Net.java:425)
at sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:223)
at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)
at org.apache.mina.transport.socket.nio.NioSocketAcceptor.open(NioSocketAcceptor.java:252)
at org.apache.mina.transport.socket.nio.NioSocketAcceptor.open(NioSocketAcceptor.java:49)
at org.apache.mina.core.polling.AbstractPollingIoAcceptor.registerHandles(AbstractPollingIoAcceptor.java:525)
at org.apache.mina.core.polling.AbstractPollingIoAcceptor.access$200(AbstractPollingIoAcceptor.java:67)
at org.apache.mina.core.polling.AbstractPollingIoAcceptor$Acceptor.run(AbstractPollingIoAcceptor.java:409)
at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:65)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
... 1 more
Build Log:
[...truncated 10433 lines...]
[junit4] Suite: org.apache.solr.cloud.SaslZkACLProviderTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SaslZkACLProviderTest_BD0AF747D6DCDA97-001/init-core-data-001
[junit4] 2> 1230786 INFO (SUITE-SaslZkACLProviderTest-seed#[BD0AF747D6DCDA97]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1230789 INFO (TEST-SaslZkACLProviderTest.testSaslZkACLProvider-seed#[BD0AF747D6DCDA97]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSaslZkACLProvider
[junit4] 2> 1230790 INFO (TEST-SaslZkACLProviderTest.testSaslZkACLProvider-seed#[BD0AF747D6DCDA97]) [ ] o.a.s.c.SaslZkACLProviderTest ####SETUP_START testSaslZkACLProvider
[junit4] 2> 1230790 INFO (TEST-SaslZkACLProviderTest.testSaslZkACLProvider-seed#[BD0AF747D6DCDA97]) [ ] o.a.s.c.SaslZkACLProviderTest ZooKeeper dataDir:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SaslZkACLProviderTest_BD0AF747D6DCDA97-001/tempDir-002/zookeeper/server1/data
[junit4] 2> 1236259 WARN (TEST-SaslZkACLProviderTest.testSaslZkACLProvider-seed#[BD0AF747D6DCDA97]) [ ] o.a.d.s.c.DefaultDirectoryService You didn't change the admin password of directory service instance 'DefaultKrbServer'. Please update the admin password as soon as possible to prevent a possible security breach.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SaslZkACLProviderTest -Dtests.method=testSaslZkACLProvider -Dtests.seed=BD0AF747D6DCDA97 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en_BZ -Dtests.timezone=Europe/Vaduz -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 7.73s J1 | SaslZkACLProviderTest.testSaslZkACLProvider <<<
[junit4] > Throwable #1: java.lang.RuntimeException: java.net.BindException: Address already in use
[junit4] > at org.apache.solr.cloud.SaslZkACLProviderTest$SaslZkTestServer.run(SaslZkACLProviderTest.java:211)
[junit4] > at org.apache.solr.cloud.SaslZkACLProviderTest.setUp(SaslZkACLProviderTest.java:81)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > Caused by: java.net.BindException: Address already in use
[junit4] > at sun.nio.ch.Net.bind0(Native Method)
[junit4] > at sun.nio.ch.Net.bind(Net.java:433)
[junit4] > at sun.nio.ch.Net.bind(Net.java:425)
[junit4] > at sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:223)
[junit4] > at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)
[junit4] > at org.apache.mina.transport.socket.nio.NioSocketAcceptor.open(NioSocketAcceptor.java:252)
[junit4] > at org.apache.mina.transport.socket.nio.NioSocketAcceptor.open(NioSocketAcceptor.java:49)
[junit4] > at org.apache.mina.core.polling.AbstractPollingIoAcceptor.registerHandles(AbstractPollingIoAcceptor.java:525)
[junit4] > at org.apache.mina.core.polling.AbstractPollingIoAcceptor.access$200(AbstractPollingIoAcceptor.java:67)
[junit4] > at org.apache.mina.core.polling.AbstractPollingIoAcceptor$Acceptor.run(AbstractPollingIoAcceptor.java:409)
[junit4] > at org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:65)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > ... 1 moreThrowable #2: java.lang.NullPointerException
[junit4] > at org.apache.solr.cloud.ZkTestServer$ZKServerMain.shutdown(ZkTestServer.java:334)
[junit4] > at org.apache.solr.cloud.ZkTestServer.shutdown(ZkTestServer.java:526)
[junit4] > at org.apache.solr.cloud.SaslZkACLProviderTest$SaslZkTestServer.shutdown(SaslZkACLProviderTest.java:218)
[junit4] > at org.apache.solr.cloud.SaslZkACLProviderTest.tearDown(SaslZkACLProviderTest.java:116)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 1238515 INFO (SUITE-SaslZkACLProviderTest-seed#[BD0AF747D6DCDA97]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.SaslZkACLProviderTest_BD0AF747D6DCDA97-001
[junit4] 2> Aug 29, 2015 5:18:00 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 6 leaked thread(s).
[junit4] 2> Aug 29, 2015 5:18:20 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 6 threads leaked from SUITE scope at org.apache.solr.cloud.SaslZkACLProviderTest:
[junit4] 2> 1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:516)
[junit4] 2> at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] 2> at java.util.TimerThread.run(Timer.java:505)
[junit4] 2> 3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] 2> at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
[junit4] 2> at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> Aug 29, 2015 5:18:20 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> 2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> 3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> 4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> 5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> 6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> Aug 29, 2015 5:18:23 PM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be terminated:
[junit4] 2> 1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> at java.lang.Object.wait(Object.java:516)
[junit4] 2> at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] 2> at java.util.TimerThread.run(Timer.java:505)
[junit4] 2> 3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] 2> at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
[junit4] 2> at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=en_BZ, timezone=Europe/Vaduz
[junit4] 2> NOTE: Linux 3.19.0-26-generic i386/Oracle Corporation 1.9.0-ea (32-bit)/cpus=12,threads=7,free=161746048,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestSchemaManager, TestReplicationHandlerBackup, FastVectorHighlighterTest, TestFreeTextSuggestions, TestStressUserVersions, DistribJoinFromCollectionTest, SSLMigrationTest, SolrInfoMBeanTest, ShardRoutingTest, TestRuleBasedAuthorizationPlugin, TestFileDictionaryLookup, TestManagedSchema, HdfsLockFactoryTest, TestCrossCoreJoin, TestJettySolrRunner, TestFiltering, TestReloadAndDeleteDocs, JavabinLoaderTest, CollectionsAPIDistributedZkTest, SpellCheckCollatorTest, TestQuerySenderListener, DocExpirationUpdateProcessorFactoryTest, ChaosMonkeySafeLeaderTest, DistributedFacetPivotLongTailTest, TestScoreJoinQPScore, SimpleCollectionCreateDeleteTest, MultiTermTest, TestMaxScoreQueryParser, MBeansHandlerTest, UniqFieldsUpdateProcessorFactoryTest, TestQueryUtils, TestLMJelinekMercerSimilarityFactory, DocumentBuilderTest, TestObjectReleaseTracker, DistribDocExpirationUpdateProcessorTest, TestRTGBase, SolrCloudExampleTest, AddSchemaFieldsUpdateProcessorFactoryTest, CustomCollectionTest, TestFieldTypeResource, CircularListTest, ZkStateReaderTest, DOMUtilTest, CollectionTooManyReplicasTest, RuleEngineTest, LoggingHandlerTest, TestSQLHandler, TestAuthenticationFramework, HdfsRecoverLeaseTest, DistributedFacetPivotWhiteBoxTest, QueryResultKeyTest, TestBlendedInfixSuggestions, SolrIndexSplitterTest, VMParamsZkACLAndCredentialsProvidersTest, ClusterStateUpdateTest, BadCopyFieldTest, TestTolerantSearch, ChangedSchemaMergeTest, TestCloudPivotFacet, TermVectorComponentTest, TestLFUCache, DistanceFunctionTest, IndexBasedSpellCheckerTest, OpenCloseCoreStressTest, SimplePostToolTest, TestBM25SimilarityFactory, TestCoreContainer, DocValuesMissingTest, TestRemoveLastDynamicCopyField, TestJmxMonitoredMap, TestConfigOverlay, TestSolrQueryParserResource, CoreAdminRequestStatusTest, TestChildDocTransformer, TestSchemaNameResource, SortByFunctionTest, DistributedExpandComponentTest, DirectSolrSpellCheckerTest, TestQueryTypes, SpatialFilterTest, SuggesterFSTTest, TestConfigSetsAPIExclusivity, SoftAutoCommitTest, SpellCheckComponentTest, ZkSolrClientTest, TestZkChroot, ZkCLITest, TestDistributedSearch, TestDocumentBuilder, SolrTestCaseJ4Test, TestCursorMarkWithoutUniqueKey, TestSimpleTrackingShardHandler, AsyncCallRequestStatusResponseTest, CdcrReplicationHandlerTest, DistributedVersionInfoTest, RemoteQueryErrorTest, SaslZkACLProviderTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SaslZkACLProviderTest -Dtests.seed=BD0AF747D6DCDA97 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en_BZ -Dtests.timezone=Europe/Vaduz -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J1 | SaslZkACLProviderTest (suite) <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 6 threads leaked from SUITE scope at org.apache.solr.cloud.SaslZkACLProviderTest:
[junit4] > 1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > 2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Object.wait(Object.java:516)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > 3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > 4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > 5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > 6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] > at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
[junit4] > at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > at __randomizedtesting.SeedInfo.seed([BD0AF747D6DCDA97]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=8442, name=changePwdReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > 2) Thread[id=8440, name=apacheds, state=WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.lang.Object.wait(Object.java:516)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:526)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > 3) Thread[id=8444, name=groupCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > 4) Thread[id=8443, name=kdcReplayCache.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > 5) Thread[id=8441, name=ou=system.data, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > 6) Thread[id=8445, name=pool-5-thread-1, state=TIMED_WAITING, group=TGRP-SaslZkACLProviderTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at java.util.concurrent.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] > at java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
[junit4] > at java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1066)
[junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] > at __randomizedtesting.SeedInfo.seed([BD0AF747D6DCDA97]:0)
[junit4] Completed [430/543] on J1 in 30.90s, 1 test, 3 errors <<< FAILURES!
[...truncated 376 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:775: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:719: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:514: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1432: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:987: There were test failures: 543 suites, 2145 tests, 2 suite-level errors, 1 error, 339 ignored (35 assumptions)
Total time: 43 minutes 58 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
[JENKINS-EA] Lucene-Solr-trunk-Linux (32bit/jdk1.9.0-ea-b78) -
Build # 14043 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/14043/
Java: 32bit/jdk1.9.0-ea-b78 -client -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.cloud.TestConfigSetsAPIExclusivity.testAPIExclusivity
Error Message:
Unexpected exception: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:44224/solr: create the configset time out:300s expected:<0> but was:<1>
Stack Trace:
java.lang.AssertionError: Unexpected exception: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:44224/solr: create the configset time out:300s expected:<0> but was:<1>
at __randomizedtesting.SeedInfo.seed([E9D6BE77C304A043:94A3A78C9AA0190A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.cloud.TestConfigSetsAPIExclusivity.testAPIExclusivity(TestConfigSetsAPIExclusivity.java:95)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:504)
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:746)
Build Log:
[...truncated 10710 lines...]
[junit4] Suite: org.apache.solr.cloud.TestConfigSetsAPIExclusivity
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_E9D6BE77C304A043-001/init-core-data-001
[junit4] 2> 1376860 INFO (SUITE-TestConfigSetsAPIExclusivity-seed#[E9D6BE77C304A043]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false)
[junit4] 2> 1376862 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAPIExclusivity
[junit4] 2> 1376862 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1376863 INFO (Thread-4578) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1376863 INFO (Thread-4578) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1376963 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.ZkTestServer start zk server on port:48514
[junit4] 2> 1376963 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1376963 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1376965 INFO (zkCallback-1577-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@188d32 name:ZooKeeperConnection Watcher:127.0.0.1:48514 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1376965 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1376965 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1376966 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 1376967 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/clusterprops.json
[junit4] 2> 1376969 INFO (jetty-launcher-1576-thread-1) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 1376970 INFO (jetty-launcher-1576-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d16b25{/solr,null,AVAILABLE}
[junit4] 2> 1376978 INFO (jetty-launcher-1576-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@9612c8{SSL-http/1.1}{127.0.0.1:44224}
[junit4] 2> 1376978 INFO (jetty-launcher-1576-thread-1) [ ] o.e.j.s.Server Started @1378476ms
[junit4] 2> 1376978 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44224}
[junit4] 2> 1376978 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@181c5f3
[junit4] 2> 1376978 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_E9D6BE77C304A043-001/tempDir-001/'
[junit4] 2> 1376988 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1376988 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1376989 INFO (zkCallback-1578-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1df63d4 name:ZooKeeperConnection Watcher:127.0.0.1:48514/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1376989 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1376990 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1376990 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1376995 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_E9D6BE77C304A043-001/tempDir-001/.
[junit4] 2> 1376995 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 12574245
[junit4] 2> 1376995 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_E9D6BE77C304A043-001/tempDir-001/]
[junit4] 2> 1376995 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_E9D6BE77C304A043-001/tempDir-001/lib
[junit4] 2> 1376996 WARN (jetty-launcher-1576-thread-1) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_E9D6BE77C304A043-001/tempDir-001/lib).
[junit4] 2> 1377001 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1377002 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1377003 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1377004 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1377004 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48514/solr
[junit4] 2> 1377004 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1377004 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1377004 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1377005 INFO (zkCallback-1580-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@cbfb6d name:ZooKeeperConnection Watcher:127.0.0.1:48514 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1377005 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1377006 INFO (jetty-launcher-1576-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1377007 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1377008 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b6f790 name:ZooKeeperConnection Watcher:127.0.0.1:48514/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1377008 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1377008 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1377009 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 1377011 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 1377012 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 1377013 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 1377014 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1377014 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 1377015 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1377016 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1377016 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1377016 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44224_solr
[junit4] 2> 1377017 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:44224_solr
[junit4] 2> 1377018 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1377018 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 1377019 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1377019 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94428299874140163-127.0.0.1:44224_solr-n_0000000000
[junit4] 2> 1377020 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:44224_solr
[junit4] 2> 1377020 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1377021 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.Overseer Overseer (id=94428299874140163-127.0.0.1:44224_solr-n_0000000000) starting
[junit4] 2> 1377021 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1377024 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1377024 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations
[junit4] 2> 1377024 INFO (OverseerStateUpdate-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1377024 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1377084 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1377084 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1377085 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.CoresLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_E9D6BE77C304A043-001/tempDir-001/.
[junit4] 2> 1377086 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.c.CoresLocator Found 0 core definitions
[junit4] 2> 1377086 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4] 2> 1377086 INFO (jetty-launcher-1576-thread-1) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1377087 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1377087 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1377088 INFO (zkCallback-1582-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@49cd27 name:ZooKeeperConnection Watcher:127.0.0.1:48514 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1377088 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1377089 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1377092 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1377092 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1377093 INFO (zkCallback-1584-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@45b941 name:ZooKeeperConnection Watcher:127.0.0.1:48514/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1377093 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1377093 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1377094 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/grandBaseConfigSet1/solrconfig.xml
[junit4] 2> 1377095 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/grandBaseConfigSet1/schema.xml
[junit4] 2> 1377167 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377169 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2
[junit4] 2> 1377169 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_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> "operation":"configsets:delete"}
[junit4] 2> 1377170 INFO (OverseerThreadFactory-5574-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377170 ERROR (OverseerThreadFactory-5574-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377171 INFO (OverseerThreadFactory-5574-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_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: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377172 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000000 state SyncConnected
[junit4] 2> 1377173 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000002 message:{
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "baseConfigSet":"grandBaseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377173 INFO (OverseerThreadFactory-5574-thread-2-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "baseConfigSet":"grandBaseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377173 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377174 INFO (OverseerThreadFactory-5574-thread-2-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/grandBaseConfigSet1/schema.xml to /configs/baseConfigSet1/schema.xml
[junit4] 2> 1377175 INFO (OverseerThreadFactory-5574-thread-2-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet1/schema.xml
[junit4] 2> 1377176 INFO (OverseerThreadFactory-5574-thread-2-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/grandBaseConfigSet1/solrconfig.xml to /configs/baseConfigSet1/solrconfig.xml
[junit4] 2> 1377177 INFO (OverseerThreadFactory-5574-thread-2-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.c.SolrZkClient makePath: /configs/baseConfigSet1/solrconfig.xml
[junit4] 2> 1377178 INFO (qtp8834446-11489) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377178 INFO (OverseerThreadFactory-5574-thread-2-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000002 complete, response:{}
[junit4] 2> 1377179 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000002 state SyncConnected
[junit4] 2> 1377180 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=0 QTime=11
[junit4] 2> 1377180 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000004 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377180 INFO (OverseerThreadFactory-5574-thread-3-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377181 ERROR (OverseerThreadFactory-5574-thread-3-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377181 INFO (OverseerThreadFactory-5574-thread-3-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000004 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377182 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000004 state SyncConnected
[junit4] 2> 1377182 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2
[junit4] 2> 1377183 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000006 message:{
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "baseConfigSet":"grandBaseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377184 INFO (qtp8834446-11489) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377184 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "baseConfigSet":"grandBaseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377184 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377185 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000006 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377185 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000006 state SyncConnected
[junit4] 2> 1377186 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377187 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377188 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000008 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377188 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377188 ERROR (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377189 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000008 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377189 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000008 state SyncConnected
[junit4] 2> 1377190 INFO (qtp8834446-11489) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :create with params baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2
[junit4] 2> 1377191 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377191 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000010 message:{
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "baseConfigSet":"grandBaseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377191 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "baseConfigSet":"grandBaseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377192 ERROR (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: create failed:org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:289)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377192 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000010 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377193 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377194 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000012 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377195 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377195 ERROR (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377196 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000012 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377196 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000012 state SyncConnected
[junit4] 2> 1377198 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=4
[junit4] 2> 1377200 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377202 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000014 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377202 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377203 ERROR (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377203 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000014 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377204 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000014 state SyncConnected
[junit4] 2> 1377205 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=4
[junit4] 2> 1377206 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=baseConfigSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377207 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000016 message:{
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377207 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377208 INFO (qtp8834446-11456) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377208 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler no existing ConfigSet properties found
[junit4] 2> 1377209 INFO (qtp8834446-11458) [n:127.0.0.1:44224_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> 1377209 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000016 complete, response:{}
[junit4] 2> 1377210 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000016 state SyncConnected
[junit4] 2> 1377211 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=baseConfigSet1&action=DELETE&wt=javabin&version=2} status=0 QTime=5
[junit4] 2> 1377211 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000018 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377212 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377212 ERROR (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377213 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000018 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377213 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000018 state SyncConnected
[junit4] 2> 1377213 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=baseConfigSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377215 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000020 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377215 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377215 INFO (qtp8834446-11456) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=7
[junit4] 2> 1377216 ERROR (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: create failed:org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:294)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377217 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000020 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1,exception={msg=Base ConfigSet does not exist: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377217 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000020 state SyncConnected
[junit4] 2> 1377217 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377218 INFO (qtp8834446-11458) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=9
[junit4] 2> 1377219 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000022 message:{
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377219 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000024 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377219 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377219 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377219 ERROR (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377220 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377220 INFO (OverseerThreadFactory-5574-thread-5-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000022 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1,exception={msg=ConfigSet does not exist to delete: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377220 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000022 state SyncConnected
[junit4] 2> 1377221 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000024 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377221 INFO (qtp8834446-11456) [n:127.0.0.1:44224_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> 1377222 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=baseConfigSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=8
[junit4] 2> 1377222 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000024 state SyncConnected
[junit4] 2> 1377223 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000026 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377223 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377224 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=6
[junit4] 2> 1377224 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: create failed:org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:294)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377224 INFO (qtp8834446-11458) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=baseConfigSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377225 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000026 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1,exception={msg=Base ConfigSet does not exist: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377225 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000026 state SyncConnected
[junit4] 2> 1377226 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377226 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000028 message:{
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377226 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377226 INFO (qtp8834446-11456) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377227 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377228 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000028 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1,exception={msg=ConfigSet does not exist to delete: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377228 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000028 state SyncConnected
[junit4] 2> 1377229 INFO (qtp8834446-11488) [n:127.0.0.1:44224_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> 1377229 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000030 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377229 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377229 INFO (qtp8834446-11458) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=baseConfigSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377230 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377230 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000030 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377231 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000030 state SyncConnected
[junit4] 2> 1377232 INFO (qtp8834446-11456) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=baseConfigSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377232 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000032 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377232 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377232 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=6
[junit4] 2> 1377233 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: create failed:org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:294)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377233 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000032 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1,exception={msg=Base ConfigSet does not exist: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377234 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000032 state SyncConnected
[junit4] 2> 1377235 INFO (qtp8834446-11458) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377235 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000034 message:{
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377235 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=6
[junit4] 2> 1377235 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377236 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377236 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000034 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1,exception={msg=ConfigSet does not exist to delete: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377237 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000034 state SyncConnected
[junit4] 2> 1377237 INFO (qtp8834446-11457) [n:127.0.0.1:44224_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> 1377238 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000036 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377238 INFO (qtp8834446-11456) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=baseConfigSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=6
[junit4] 2> 1377238 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377239 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377239 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000036 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377240 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000036 state SyncConnected
[junit4] 2> 1377240 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=baseConfigSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377240 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000038 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377241 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377241 INFO (qtp8834446-11458) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377241 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: create failed:org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:294)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377242 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000038 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1,exception={msg=Base ConfigSet does not exist: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377242 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000038 state SyncConnected
[junit4] 2> 1377243 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000040 message:{
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377243 INFO (qtp8834446-11456) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377243 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"baseConfigSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377243 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377243 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: baseConfigSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377244 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000040 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: baseConfigSet1,exception={msg=ConfigSet does not exist to delete: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377244 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000040 state SyncConnected
[junit4] 2> 1377245 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000042 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377245 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : delete , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "operation":"configsets:delete"}
[junit4] 2> 1377245 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=baseConfigSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377245 INFO (qtp8834446-11458) [n:127.0.0.1:44224_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> 1377246 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: delete failed:org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:351)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.deleteConfigSet(OverseerConfigSetMessageHandler.java:345)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:115)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377247 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000042 complete, response:{Operation delete caused exception:=org.apache.solr.common.SolrException: ConfigSet does not exist to delete: configSet1,exception={msg=ConfigSet does not exist to delete: configSet1,rspCode=400}}
[junit4] 2> 1377247 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000042 state SyncConnected
[junit4] 2> 1377248 INFO (qtp8834446-11457) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=baseConfigSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377248 INFO (OverseerCollectionConfigSetProcessor-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000044 message:{
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377249 INFO (qtp8834446-11456) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={name=configSet1&action=DELETE&wt=javabin&version=2} status=400 QTime=5
[junit4] 2> 1377249 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler OverseerConfigSetMessageHandler.processMessage : create , {
[junit4] 2> "name":"configSet1",
[junit4] 2> "baseConfigSet":"baseConfigSet1",
[junit4] 2> "operation":"configsets:create"}
[junit4] 2> 1377249 ERROR (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerConfigSetMessageHandler ConfigSet: configSet1 operation: create failed:org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.createConfigSet(OverseerConfigSetMessageHandler.java:294)
[junit4] 2> at org.apache.solr.cloud.OverseerConfigSetMessageHandler.processMessage(OverseerConfigSetMessageHandler.java:112)
[junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:434)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:210)
[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:746)
[junit4] 2>
[junit4] 2> 1377250 INFO (OverseerThreadFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000044 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: Base ConfigSet does not exist: baseConfigSet1,exception={msg=Base ConfigSet does not exist: baseConfigSet1,rspCode=400}}
[junit4] 2> 1377250 INFO (zkCallback-1581-thread-1-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000044 state SyncConnected
[junit4] 2> 1377251 INFO (qtp8834446-11488) [n:127.0.0.1:44224_solr ] o.a.s.h.a.ConfigSetsHandler Invoked ConfigSet Action :delete with params name=configSet1&action=DELETE&wt=javabin&version=2
[junit4] 2> 1377252 INFO (qtp8834446-11458) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=baseConfigSet1&name=configSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=6
[junit4] 2> 1377252 INFO (OverseerCollectionC
[...truncated too long message...]
readFactory-5574-thread-4-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskProcessor Overseer ConfigSet Message Handler: Message id:/overseer/collection-queue-work/qn-0000000158 complete, response:{Operation create caused exception:=org.apache.solr.common.SolrException: ConfigSet already exists: baseConfigSet1,exception={msg=ConfigSet already exists: baseConfigSet1,rspCode=400}}
[junit4] 2> 1677307 INFO (zkCallback-1581-thread-3-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.OverseerTaskQueue NodeDataChanged fired on path /overseer/collection-queue-work/qnr-0000000158 state SyncConnected
[junit4] 2> 1677308 INFO (qtp8834446-11456) [n:127.0.0.1:44224_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/configs params={baseConfigSet=grandBaseConfigSet1&name=baseConfigSet1&action=CREATE&wt=javabin&version=2} status=400 QTime=4
[junit4] 2> 1677313 INFO (jetty-launcher-1576-thread-2) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@9612c8{SSL-http/1.1}{127.0.0.1:0}
[junit4] 2> 1677314 INFO (jetty-launcher-1576-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=12574245
[junit4] 2> 1677315 INFO (jetty-launcher-1576-thread-2) [ ] o.a.s.c.Overseer Overseer (id=94428299874140163-127.0.0.1:44224_solr-n_0000000000) closing
[junit4] 2> 1677315 INFO (OverseerStateUpdate-94428299874140163-127.0.0.1:44224_solr-n_0000000000) [n:127.0.0.1:44224_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:44224_solr
[junit4] 2> 1677316 INFO (zkCallback-1581-thread-3-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_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> 1677316 WARN (zkCallback-1581-thread-3-processing-n:127.0.0.1:44224_solr) [n:127.0.0.1:44224_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 1677317 INFO (jetty-launcher-1576-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d16b25{/solr,null,UNAVAILABLE}
[junit4] 2> 1677318 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:48514 48514
[junit4] 2> 1677339 INFO (Thread-4578) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:48514 48514
[junit4] 2> 1677340 INFO (TEST-TestConfigSetsAPIExclusivity.testAPIExclusivity-seed#[E9D6BE77C304A043]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testAPIExclusivity
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestConfigSetsAPIExclusivity -Dtests.method=testAPIExclusivity -Dtests.seed=E9D6BE77C304A043 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr_CD -Dtests.timezone=SystemV/YST9 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 300s J0 | TestConfigSetsAPIExclusivity.testAPIExclusivity <<<
[junit4] > Throwable #1: java.lang.AssertionError: Unexpected exception: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:44224/solr: create the configset time out:300s expected:<0> but was:<1>
[junit4] > at __randomizedtesting.SeedInfo.seed([E9D6BE77C304A043:94A3A78C9AA0190A]:0)
[junit4] > at org.apache.solr.cloud.TestConfigSetsAPIExclusivity.testAPIExclusivity(TestConfigSetsAPIExclusivity.java:95)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 1677347 INFO (SUITE-TestConfigSetsAPIExclusivity-seed#[E9D6BE77C304A043]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestConfigSetsAPIExclusivity_E9D6BE77C304A043-001
[junit4] 2> Aug 29, 2015 3:23:29 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=1, maxDocsPerChunk=2, blockSize=9), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=1, blockSize=9)), sim=DefaultSimilarity, locale=fr_CD, timezone=SystemV/YST9
[junit4] 2> NOTE: Linux 3.19.0-26-generic i386/Oracle Corporation 1.9.0-ea (32-bit)/cpus=12,threads=1,free=211697552,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestConfigSetsAPIZkFailure, TestRestManager, TestExactStatsCache, TestRandomMergePolicy, TestRangeQuery, TestFunctionQuery, EchoParamsTest, AliasIntegrationTest, DistributedQueryComponentOptimizationTest, TestSerializedLuceneMatchVersion, CoreMergeIndexesAdminHandlerTest, SynonymTokenizerTest, TestIntervalFaceting, PrimUtilsTest, CollectionStateFormat2Test, TestMergePolicyConfig, QueryElevationComponentTest, TestRandomDVFaceting, TestPKIAuthenticationPlugin, TestEmbeddedSolrServerConstructors, TestBinaryField, TestAtomicUpdateErrorCases, SolrCoreTest, TestDistribIDF, TestBadConfig, TestPivotHelperCode, TimeZoneUtilsTest, DistributedIntervalFacetingTest, TestStandardQParsers, TestComplexPhraseQParserPlugin, DocumentAnalysisRequestHandlerTest, BigEndianAscendingWordSerializerTest, HdfsBasicDistributedZk2Test, DeleteShardTest, TestHdfsUpdateLog, ZkStateWriterTest, TestRandomFaceting, SOLR749Test, FacetPivotSmallTest, TestSimpleTrackingShardHandler, TestFieldCollectionResource, DistributedFacetPivotSmallTest, TestJoin, TestCollationFieldDocValues, ExternalFileFieldSortTest, TestSolrConfigHandlerCloud, InfoHandlerTest, ResourceLoaderTest, SolrXmlInZkTest, TestArbitraryIndexDir, TestFoldingMultitermQuery, TestMissingGroups, TestCSVLoader, DeleteInactiveReplicaTest, SmileWriterTest, TestComponentsName, XsltUpdateRequestHandlerTest, IndexSchemaRuntimeFieldTest, RollingRestartTest, DisMaxRequestHandlerTest, SpellingQueryConverterTest, HighlighterMaxOffsetTest, TestMiniSolrCloudClusterSSL, TestDynamicFieldResource, PeerSyncTest, SolrTestCaseJ4Test, HttpPartitionTest, ReplicationFactorTest, TestRemoteStreaming, IndexSchemaTest, TestSolr4Spatial, FileUtilsTest, TestAnalyzedSuggestions, PolyFieldTest, TestLMDirichletSimilarityFactory, TestSimpleQParserPlugin, ExitableDirectoryReaderTest, DeleteLastCustomShardedReplicaTest, DateFieldTest, HdfsUnloadDistributedZkTest, SaslZkACLProviderTest, TestRawResponseWriter, TestExceedMaxTermLength, OpenExchangeRatesOrgProviderTest, TestTrackingShardHandlerFactory, JSONWriterTest, ReturnFieldsTest, BasicDistributedZkTest, SyncSliceTest, BasicZkTest, TestReplicationHandler, ZkSolrClientTest, AutoCommitTest, TestDistributedGrouping, TestFaceting, TestRecovery, TestHashPartitioner, DistributedSpellCheckComponentTest, TestRealTimeGet, TestStressReorder, TestCoreContainer, SimpleFacetsTest, BadIndexSchemaTest, ConvertedLegacyTest, BasicFunctionalityTest, TestLazyCores, CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, SimplePostToolTest, TestCoreDiscovery, AnalysisAfterCoreReloadTest, SignatureUpdateProcessorFactoryTest, SpellCheckCollatorTest, SolrRequestParserTest, DocValuesTest, TestStressLucene, SuggesterWFSTTest, TestPseudoReturnFields, QueryEqualityTest, DebugComponentTest, CacheHeaderTest, TestWriterPerf, TestReversedWildcardFilterFactory, TestQueryTypes, FileBasedSpellCheckerTest, TestValueSourceCache, TermVectorComponentTest, RequiredFieldsTest, FastVectorHighlighterTest, RegexBoostProcessorTest, TestJmxIntegration, TestCSVResponseWriter, JsonLoaderTest, PingRequestHandlerTest, UpdateParamsTest, TestSolrIndexConfig, CopyFieldTest, SolrIndexConfigTest, TestSolrDeletionPolicy2, SampleTest, TestDocSet, NumericFieldsTest, MinimalSchemaTest, TestConfig, TestFuzzyAnalyzedSuggestions, TestSolrCoreProperties, TestCharFilters, TestDFRSimilarityFactory, TestIBSimilarityFactory, ScriptEngineTest, PluginInfoTest, PreAnalyzedFieldTest, RAMDirectoryFactoryTest, TestSolrJ, TestUtils, ZkNodePropsTest, DistributedMLTComponentTest, TestCrossCoreJoin, TestDistributedMissingSort, TestHighlightDedupGrouping, AsyncCallRequestStatusResponseTest, BaseCdcrDistributedZkTest, CdcrReplicationHandlerTest, ConcurrentDeleteAndCreateCollectionTest, ConnectionManagerTest, DeleteReplicaTest, DistributedQueueTest, LeaderInitiatedRecoveryOnCommitTest, OverseerStatusTest, OverseerTaskQueueTest, RecoveryAfterSoftCommitTest, TestCloudInspectUtil, TestCloudPivotFacet, TestConfigSetsAPIExclusivity]
[junit4] Completed [469/543] on J0 in 300.76s, 1 test, 1 failure <<< FAILURES!
[...truncated 250 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:775: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:719: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:514: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1432: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:987: There were test failures: 543 suites, 2145 tests, 1 failure, 71 ignored (35 assumptions)
Total time: 49 minutes 1 second
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