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 2013/11/23 02:24:49 UTC
[JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.8.0-ea-b116) -
Build # 3496 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/3496/
Java: 32bit/jdk1.8.0-ea-b116 -server -XX:+UseConcMarkSweepGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
Error Message:
9 threads leaked from SUITE scope at org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest: 1) Thread[id=7622, name=HashSessionScavenger-235, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] at java.lang.Object.wait(Native Method) at java.util.TimerThread.mainLoop(Timer.java:552) at java.util.TimerThread.run(Timer.java:505) 2) Thread[id=7625, name=qtp12074201-7625, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] 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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342) at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526) at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) at java.lang.Thread.run(Thread.java:744) 3) Thread[id=7626, name=qtp12074201-7626, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] 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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342) at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526) at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) at java.lang.Thread.run(Thread.java:744) 4) Thread[id=7629, name=qtp12074201-7629, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] 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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342) at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526) at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) at java.lang.Thread.run(Thread.java:744) 5) Thread[id=7627, name=qtp12074201-7627, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] 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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342) at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526) at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) at java.lang.Thread.run(Thread.java:744) 6) Thread[id=7630, name=qtp12074201-7630, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] 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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342) at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526) at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) at java.lang.Thread.run(Thread.java:744) 7) Thread[id=7623, name=qtp12074201-7623 Acceptor0 SelectChannelConnector@127.0.0.1:59532, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest] at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method) at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:241) at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109) at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543) at java.lang.Thread.run(Thread.java:744) 8) Thread[id=7624, name=qtp12074201-7624, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] 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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342) at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526) at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572) at java.lang.Thread.run(Thread.java:744) 9) Thread[id=7628, name=qtp12074201-7628 Selector0, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest] at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method) at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296) at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278) at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86) at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97) at org.eclipse.jetty.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:569) at org.eclipse.jetty.io.nio.SelectorManager$1.run(SelectorManager.java:290) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543) at java.lang.Thread.run(Thread.java:744)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 9 threads leaked from SUITE scope at org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest:
1) Thread[id=7622, name=HashSessionScavenger-235, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
at java.lang.Object.wait(Native Method)
at java.util.TimerThread.mainLoop(Timer.java:552)
at java.util.TimerThread.run(Timer.java:505)
2) Thread[id=7625, name=qtp12074201-7625, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:744)
3) Thread[id=7626, name=qtp12074201-7626, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:744)
4) Thread[id=7629, name=qtp12074201-7629, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:744)
5) Thread[id=7627, name=qtp12074201-7627, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:744)
6) Thread[id=7630, name=qtp12074201-7630, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:744)
7) Thread[id=7623, name=qtp12074201-7623 Acceptor0 SelectChannelConnector@127.0.0.1:59532, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:241)
at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:744)
8) Thread[id=7624, name=qtp12074201-7624, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:744)
9) Thread[id=7628, name=qtp12074201-7628 Selector0, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296)
at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278)
at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
at org.eclipse.jetty.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:569)
at org.eclipse.jetty.io.nio.SelectorManager$1.run(SelectorManager.java:290)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:744)
at __randomizedtesting.SeedInfo.seed([4C1E9A235445D8F2]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=7622, name=HashSessionScavenger-235, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest] at java.lang.Object.wait(Native Method) at java.util.TimerThread.mainLoop(Timer.java:552) at java.util.TimerThread.run(Timer.java:505) 2) Thread[id=7623, name=qtp12074201-7623 Acceptor0 SelectChannelConnector@127.0.0.1:59532, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest] at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543) at java.lang.Thread.run(Thread.java:744) 3) Thread[id=7628, name=qtp12074201-7628 Selector0, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest] at sun.nio.ch.WindowsSelectorImpl.setWakeupSocket0(Native Method) at sun.nio.ch.WindowsSelectorImpl.setWakeupSocket(WindowsSelectorImpl.java:464) at sun.nio.ch.WindowsSelectorImpl.wakeup(WindowsSelectorImpl.java:606) at java.nio.channels.spi.AbstractSelector$1.interrupt(AbstractSelector.java:213) at java.nio.channels.spi.AbstractSelector.begin(AbstractSelector.java:219) at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:157) at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86) at sun.nio.ch.SelectorImpl.selectNow(SelectorImpl.java:105) at org.eclipse.jetty.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:536) at org.eclipse.jetty.io.nio.SelectorManager$1.run(SelectorManager.java:290) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608) at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543) at java.lang.Thread.run(Thread.java:744)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=7622, name=HashSessionScavenger-235, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
at java.lang.Object.wait(Native Method)
at java.util.TimerThread.mainLoop(Timer.java:552)
at java.util.TimerThread.run(Timer.java:505)
2) Thread[id=7623, name=qtp12074201-7623 Acceptor0 SelectChannelConnector@127.0.0.1:59532, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:744)
3) Thread[id=7628, name=qtp12074201-7628 Selector0, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
at sun.nio.ch.WindowsSelectorImpl.setWakeupSocket0(Native Method)
at sun.nio.ch.WindowsSelectorImpl.setWakeupSocket(WindowsSelectorImpl.java:464)
at sun.nio.ch.WindowsSelectorImpl.wakeup(WindowsSelectorImpl.java:606)
at java.nio.channels.spi.AbstractSelector$1.interrupt(AbstractSelector.java:213)
at java.nio.channels.spi.AbstractSelector.begin(AbstractSelector.java:219)
at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:157)
at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
at sun.nio.ch.SelectorImpl.selectNow(SelectorImpl.java:105)
at org.eclipse.jetty.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:536)
at org.eclipse.jetty.io.nio.SelectorManager$1.run(SelectorManager.java:290)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:744)
at __randomizedtesting.SeedInfo.seed([4C1E9A235445D8F2]:0)
FAILED: org.apache.solr.analytics.NoFacetTest.stddevTest
Error Message:
Oops: (double raws) 4631318898052956160 - 4628496337733101339 < 4442235333156365461 Calculated diff 4625071700926640586 Let's see what the JVM thinks these bits are. FloatResult: 43.5 floatTest: 27.72225134241226 Diff 15.77774865758774
Stack Trace:
java.lang.AssertionError: Oops: (double raws) 4631318898052956160 - 4628496337733101339 < 4442235333156365461 Calculated diff 4625071700926640586 Let's see what the JVM thinks these bits are. FloatResult: 43.5 floatTest: 27.72225134241226 Diff 15.77774865758774
at __randomizedtesting.SeedInfo.seed([4C1E9A235445D8F2:49DEDA966426DCFD]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.analytics.NoFacetTest.stddevTest(NoFacetTest.java:227)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:483)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
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 org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
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:358)
at java.lang.Thread.run(Thread.java:744)
Build Log:
[...truncated 10063 lines...]
[junit4] Suite: org.apache.solr.analytics.NoFacetTest
[junit4] 2> 246236 T1549 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-NoFacetTest-1385167774804
[junit4] 2> 246239 T1549 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 246244 T1549 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 246247 T1549 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 246466 T1549 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 246471 T1549 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 246474 T1549 oass.IndexSchema.readSchema Reading Solr Schema from schema-analytics.xml
[junit4] 2> 246481 T1549 oass.IndexSchema.readSchema [null] Schema name=schema-docValues
[junit4] 2> 246496 T1549 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 246497 T1549 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 246500 T1549 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 246500 T1549 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 246601 T1549 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 246601 T1549 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr
[junit4] 2> 246601 T1549 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\'
[junit4] 2> 246642 T1549 oasc.CoreContainer.<init> New CoreContainer 2274433
[junit4] 2> 246642 T1549 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\]
[junit4] 2> 246644 T1549 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 246644 T1549 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 246644 T1549 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 246644 T1549 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 246646 T1549 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 246646 T1549 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 246646 T1549 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 246646 T1549 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 246646 T1549 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 246655 T1549 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 246655 T1549 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 246656 T1549 oasc.CoreContainer.load Host Name:
[junit4] 2> 246670 T1550 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1
[junit4] 2> 246670 T1550 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\'
[junit4] 2> 246670 T1550 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 246670 T1550 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 246727 T1550 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4] 2> 246733 T1550 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-basic.xml
[junit4] 2> 246733 T1550 oass.IndexSchema.readSchema Reading Solr Schema from schema-analytics.xml
[junit4] 2> 246742 T1550 oass.IndexSchema.readSchema [collection1] Schema name=schema-docValues
[junit4] 2> 246771 T1550 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 246774 T1550 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 246775 T1550 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-NoFacetTest-1385167774804\
[junit4] 2> 246775 T1550 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4] 2> 246778 T1550 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-NoFacetTest-1385167774804\
[junit4] 2> 246778 T1550 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-NoFacetTest-1385167774804\index/
[junit4] 2> 246778 T1550 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-NoFacetTest-1385167774804\index' doesn't exist. Creating new index...
[junit4] 2> 246794 T1550 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-NoFacetTest-1385167774804\index
[junit4] 2> 246794 T1550 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=82.23046875, floorSegmentMB=1.0654296875, forceMergeDeletesPctAllowed=3.029623864189511, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.22763952928783696
[junit4] 2> 246794 T1550 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_1,generation=1}
[junit4] 2> 246794 T1550 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 246797 T1550 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 246797 T1550 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 246798 T1550 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 246809 T1550 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 246809 T1550 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 246809 T1550 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 246810 T1550 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=72.5771484375, floorSegmentMB=0.6220703125, forceMergeDeletesPctAllowed=6.8864847320383955, segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 246810 T1550 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_1,generation=1}
[junit4] 2> 246810 T1550 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 246810 T1550 oass.SolrIndexSearcher.<init> Opening Searcher@8897da main
[junit4] 2> 246810 T1550 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 246817 T1549 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> ASYNC NEW_CORE C804 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 246819 T1549 C804 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 246819 T1549 C804 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 2
[junit4] 2> 246823 T1549 C804 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10000]} 0 2
[junit4] 2> 246828 T1549 C804 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 246831 T1549 C804 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_2,generation=2}
[junit4] 2> 246839 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8897da main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 246839 T1549 C804 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 246840 T1549 C804 oass.SolrIndexSearcher.<init> Opening Searcher@3b376a main
[junit4] 2> 246842 T1549 C804 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 246843 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3b376a main{StandardDirectoryReader(segments_2:4:nrt _0(5.0):c1)}
[junit4] 2> 246843 T1549 C804 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 16
[junit4] 2> 246850 T1549 C804 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10001]} 0 7
[junit4] 2> 246851 T1549 C804 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 246931 T1549 C804 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_3,generation=3}
[junit4] 2> 246931 T1549 C804 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 246933 T1549 C804 oass.SolrIndexSearcher.<init> Opening Searcher@abf0a5 main
[junit4] 2> 246933 T1549 C804 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 246935 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@abf0a5 main{StandardDirectoryReader(segments_3:6:nrt _0(5.0):c1 _1(5.0):c1)}
[junit4] 2> 246935 T1549 C804 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 84
[junit4] 2> 246935 T1549 C804 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10002]} 0 0
[junit4] 2> 246939 T1549 C804 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 246940 T1549 C804 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_4,generation=4}
[junit4] 2> 246942 T1549 C804 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4
[junit4] 2> 246942 T1549 C804 oass.SolrIndexSearcher.<init> Opening Searcher@1bcd614 main
[junit4] 2> 246942 T1549 C804 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 246942 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1bcd614 main{StandardDirectoryReader(segments_4:8:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1)}
[junit4] 2> 246942 T1549 C804 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
[junit4] 2> ASYNC NEW_CORE C805 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 246954 T1549 C805 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10003]} 0 3
[junit4] 2> 246955 T1549 C805 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 246959 T1549 C805 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_5,generation=5}
[junit4] 2> 246960 T1549 C805 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 246960 T1549 C805 oass.SolrIndexSearcher.<init> Opening Searcher@1589929 main
[junit4] 2> 246960 T1549 C805 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 246966 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1589929 main{StandardDirectoryReader(segments_5:10:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1)}
[junit4] 2> 246967 T1549 C805 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4] 2> 246969 T1549 C805 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10004]} 0 2
[junit4] 2> 246971 T1549 C805 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 246977 T1549 C805 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_5,generation=5}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_6,generation=6}
[junit4] 2> 246977 T1549 C805 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6
[junit4] 2> 246978 T1549 C805 oass.SolrIndexSearcher.<init> Opening Searcher@1cd429c main
[junit4] 2> 246981 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1cd429c main{StandardDirectoryReader(segments_6:12:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1)}
[junit4] 2> 246981 T1549 C805 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 246981 T1549 C805 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
[junit4] 2> 246983 T1549 C805 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10005]} 0 1
[junit4] 2> 246988 T1549 C805 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 246993 T1549 C805 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_6,generation=6}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_7,generation=7}
[junit4] 2> 246993 T1549 C805 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7
[junit4] 2> 246996 T1549 C805 oass.SolrIndexSearcher.<init> Opening Searcher@c8399b main
[junit4] 2> 246998 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c8399b main{StandardDirectoryReader(segments_7:14:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1)}
[junit4] 2> 246998 T1549 C805 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 246998 T1549 C805 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4] 2> 247001 T1549 C805 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10006]} 0 1
[junit4] 2> 247004 T1549 C805 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C806 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247016 T1549 C806 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_7,generation=7}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_8,generation=8}
[junit4] 2> 247016 T1549 C806 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8
[junit4] 2> 247020 T1549 C806 oass.SolrIndexSearcher.<init> Opening Searcher@2f3da2 main
[junit4] 2> 247021 T1549 C806 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247023 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2f3da2 main{StandardDirectoryReader(segments_8:16:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1)}
[junit4] 2> 247023 T1549 C806 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 21
[junit4] 2> 247025 T1549 C806 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10007]} 0 1
[junit4] 2> 247028 T1549 C806 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247032 T1549 C806 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_8,generation=8}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_9,generation=9}
[junit4] 2> 247033 T1549 C806 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9
[junit4] 2> 247036 T1549 C806 oass.SolrIndexSearcher.<init> Opening Searcher@2882ae main
[junit4] 2> 247036 T1549 C806 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247038 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2882ae main{StandardDirectoryReader(segments_9:18:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1)}
[junit4] 2> 247038 T1549 C806 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
[junit4] 2> 247040 T1549 C806 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10008]} 0 1
[junit4] 2> 247043 T1549 C806 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247047 T1549 C806 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_9,generation=9}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_a,generation=10}
[junit4] 2> 247048 T1549 C806 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10
[junit4] 2> 247052 T1549 C806 oass.SolrIndexSearcher.<init> Opening Searcher@d41da2 main
[junit4] 2> 247052 T1549 C806 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247054 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d41da2 main{StandardDirectoryReader(segments_a:20:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1)}
[junit4] 2> 247054 T1549 C806 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4] 2> 247056 T1549 C806 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[10009]} 0 2
[junit4] 2> 247059 T1549 C806 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247063 T1549 C806 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_a,generation=10}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_b,generation=11}
[junit4] 2> 247063 T1549 C806 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11
[junit4] 2> 247063 T1549 C806 oass.SolrIndexSearcher.<init> Opening Searcher@1087030 main
[junit4] 2> 247067 T1549 C806 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247069 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1087030 main{StandardDirectoryReader(segments_b:22:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1)}
[junit4] 2> 247069 T1549 C806 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
[junit4] 2> 247070 T1549 C806 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100010]} 0 1
[junit4] 2> ASYNC NEW_CORE C807 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247093 T1549 C807 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247100 T1549 C807 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_b,generation=11}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_c,generation=12}
[junit4] 2> 247100 T1549 C807 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12
[junit4] 2> 247101 T1549 C807 oass.SolrIndexSearcher.<init> Opening Searcher@1c0b7d4 main
[junit4] 2> 247101 T1549 C807 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247105 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c0b7d4 main{StandardDirectoryReader(segments_c:24:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1)}
[junit4] 2> 247105 T1549 C807 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4] 2> 247106 T1549 C807 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100011]} 0 1
[junit4] 2> 247111 T1549 C807 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247166 T1549 C807 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_c,generation=12}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_d,generation=13}
[junit4] 2> 247166 T1549 C807 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13
[junit4] 2> 247189 T1549 C807 oass.SolrIndexSearcher.<init> Opening Searcher@29832d main
[junit4] 2> 247189 T1549 C807 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247192 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@29832d main{StandardDirectoryReader(segments_d:26:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1)}
[junit4] 2> 247193 T1549 C807 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 84
[junit4] 2> 247194 T1549 C807 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100012]} 0 1
[junit4] 2> 247197 T1549 C807 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247202 T1549 C807 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_d,generation=13}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_e,generation=14}
[junit4] 2> 247202 T1549 C807 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14
[junit4] 2> 247205 T1549 C807 oass.SolrIndexSearcher.<init> Opening Searcher@7f36de main
[junit4] 2> 247205 T1549 C807 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247209 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7f36de main{StandardDirectoryReader(segments_e:28:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1)}
[junit4] 2> 247209 T1549 C807 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 13
[junit4] 2> 247211 T1549 C807 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100013]} 0 2
[junit4] 2> 247213 T1549 C807 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247221 T1549 C807 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_e,generation=14}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_f,generation=15}
[junit4] 2> 247221 T1549 C807 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15
[junit4] 2> 247223 T1549 C807 oass.SolrIndexSearcher.<init> Opening Searcher@11d2490 main
[junit4] 2> 247227 T1549 C807 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247228 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@11d2490 main{StandardDirectoryReader(segments_f:30:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1)}
[junit4] 2> 247228 T1549 C807 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 15
[junit4] 2> ASYNC NEW_CORE C808 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247239 T1549 C808 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100014]} 0 1
[junit4] 2> 247242 T1549 C808 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247247 T1549 C808 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_f,generation=15}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_g,generation=16}
[junit4] 2> 247248 T1549 C808 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 16
[junit4] 2> 247251 T1549 C808 oass.SolrIndexSearcher.<init> Opening Searcher@1a40fb2 main
[junit4] 2> 247252 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a40fb2 main{StandardDirectoryReader(segments_g:32:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1)}
[junit4] 2> 247254 T1549 C808 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247254 T1549 C808 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 14
[junit4] 2> 247256 T1549 C808 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100015]} 0 2
[junit4] 2> 247258 T1549 C808 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247262 T1549 C808 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_g,generation=16}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_h,generation=17}
[junit4] 2> 247262 T1549 C808 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 17
[junit4] 2> 247262 T1549 C808 oass.SolrIndexSearcher.<init> Opening Searcher@d0da3b main
[junit4] 2> 247266 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d0da3b main{StandardDirectoryReader(segments_h:34:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1)}
[junit4] 2> 247266 T1549 C808 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247266 T1549 C808 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 247267 T1549 C808 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100016]} 0 1
[junit4] 2> 247270 T1549 C808 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247277 T1549 C808 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_h,generation=17}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_i,generation=18}
[junit4] 2> 247279 T1549 C808 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 18
[junit4] 2> 247281 T1549 C808 oass.SolrIndexSearcher.<init> Opening Searcher@68d4fd main
[junit4] 2> 247281 T1549 C808 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247285 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@68d4fd main{StandardDirectoryReader(segments_i:36:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1)}
[junit4] 2> 247286 T1549 C808 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 17
[junit4] 2> 247292 T1549 C808 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100017]} 0 6
[junit4] 2> 247294 T1549 C808 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C809 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247308 T1549 C809 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_i,generation=18}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_j,generation=19}
[junit4] 2> 247308 T1549 C809 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 19
[junit4] 2> 247311 T1549 C809 oass.SolrIndexSearcher.<init> Opening Searcher@3774a6 main
[junit4] 2> 247311 T1549 C809 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247312 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3774a6 main{StandardDirectoryReader(segments_j:38:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1)}
[junit4] 2> 247313 T1549 C809 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 20
[junit4] 2> 247315 T1549 C809 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100018]} 0 2
[junit4] 2> 247316 T1549 C809 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247320 T1549 C809 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_j,generation=19}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_k,generation=20}
[junit4] 2> 247320 T1549 C809 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 20
[junit4] 2> 247321 T1549 C809 oass.SolrIndexSearcher.<init> Opening Searcher@a5cbec main
[junit4] 2> 247321 T1549 C809 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247323 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a5cbec main{StandardDirectoryReader(segments_k:40:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1)}
[junit4] 2> 247324 T1549 C809 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 247327 T1549 C809 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100019]} 0 2
[junit4] 2> 247328 T1549 C809 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247331 T1549 C809 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_k,generation=20}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_l,generation=21}
[junit4] 2> 247331 T1549 C809 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 21
[junit4] 2> 247335 T1549 C809 oass.SolrIndexSearcher.<init> Opening Searcher@3bbfc3 main
[junit4] 2> 247335 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3bbfc3 main{StandardDirectoryReader(segments_l:42:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1)}
[junit4] 2> 247335 T1549 C809 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247335 T1549 C809 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4] 2> 247339 T1549 C809 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100020]} 0 3
[junit4] 2> 247340 T1549 C809 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247361 T1549 C809 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_l,generation=21}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_m,generation=22}
[junit4] 2> 247361 T1549 C809 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 22
[junit4] 2> 247381 T1549 C809 oass.SolrIndexSearcher.<init> Opening Searcher@18030d0 main
[junit4] 2> 247381 T1549 C809 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247382 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@18030d0 main{StandardDirectoryReader(segments_m:44:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1)}
[junit4] 2> 247384 T1549 C809 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 45
[junit4] 2> ASYNC NEW_CORE C810 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247393 T1549 C810 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100021]} 0 1
[junit4] 2> 247396 T1549 C810 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247401 T1549 C810 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_m,generation=22}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_n,generation=23}
[junit4] 2> 247401 T1549 C810 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 23
[junit4] 2> 247407 T1549 C810 oass.SolrIndexSearcher.<init> Opening Searcher@74d307 main
[junit4] 2> 247407 T1549 C810 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247408 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@74d307 main{StandardDirectoryReader(segments_n:46:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1)}
[junit4] 2> 247408 T1549 C810 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 14
[junit4] 2> 247409 T1549 C810 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100022]} 0 1
[junit4] 2> 247413 T1549 C810 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247423 T1549 C810 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_n,generation=23}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_o,generation=24}
[junit4] 2> 247423 T1549 C810 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 24
[junit4] 2> 247434 T1549 C810 oass.SolrIndexSearcher.<init> Opening Searcher@c2aee8 main
[junit4] 2> 247434 T1549 C810 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247435 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c2aee8 main{StandardDirectoryReader(segments_o:48:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1)}
[junit4] 2> 247435 T1549 C810 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 23
[junit4] 2> 247436 T1549 C810 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100023]} 0 0
[junit4] 2> 247439 T1549 C810 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247442 T1549 C810 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_o,generation=24}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_p,generation=25}
[junit4] 2> 247442 T1549 C810 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 25
[junit4] 2> 247444 T1549 C810 oass.SolrIndexSearcher.<init> Opening Searcher@b726e9 main
[junit4] 2> 247444 T1549 C810 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247446 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b726e9 main{StandardDirectoryReader(segments_p:50:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1)}
[junit4] 2> 247447 T1549 C810 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
[junit4] 2> 247448 T1549 C810 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100024]} 0 1
[junit4] 2> 247451 T1549 C810 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C811 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247462 T1549 C811 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_p,generation=25}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_q,generation=26}
[junit4] 2> 247462 T1549 C811 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 26
[junit4] 2> 247462 T1549 C811 oass.SolrIndexSearcher.<init> Opening Searcher@d3f93e main
[junit4] 2> 247462 T1549 C811 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247465 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d3f93e main{StandardDirectoryReader(segments_q:52:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1)}
[junit4] 2> 247465 T1549 C811 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 15
[junit4] 2> 247466 T1549 C811 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100025]} 0 0
[junit4] 2> 247469 T1549 C811 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247473 T1549 C811 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_q,generation=26}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_r,generation=27}
[junit4] 2> 247473 T1549 C811 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 27
[junit4] 2> 247473 T1549 C811 oass.SolrIndexSearcher.<init> Opening Searcher@196bf69 main
[junit4] 2> 247473 T1549 C811 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247478 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@196bf69 main{StandardDirectoryReader(segments_r:54:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1)}
[junit4] 2> 247478 T1549 C811 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
[junit4] 2> 247480 T1549 C811 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100026]} 0 2
[junit4] 2> 247481 T1549 C811 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247484 T1549 C811 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_r,generation=27}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_s,generation=28}
[junit4] 2> 247486 T1549 C811 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 28
[junit4] 2> 247486 T1549 C811 oass.SolrIndexSearcher.<init> Opening Searcher@15f1cc2 main
[junit4] 2> 247489 T1549 C811 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247490 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15f1cc2 main{StandardDirectoryReader(segments_s:56:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1)}
[junit4] 2> 247490 T1549 C811 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9
[junit4] 2> 247493 T1549 C811 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100027]} 0 3
[junit4] 2> 247494 T1549 C811 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247497 T1549 C811 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_s,generation=28}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_t,generation=29}
[junit4] 2> 247500 T1549 C811 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 29
[junit4] 2> 247500 T1549 C811 oass.SolrIndexSearcher.<init> Opening Searcher@1c011ad main
[junit4] 2> 247504 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c011ad main{StandardDirectoryReader(segments_t:58:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1 _r(5.0):c1)}
[junit4] 2> 247504 T1549 C811 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247504 T1549 C811 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
[junit4] 2> ASYNC NEW_CORE C812 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247519 T1549 C812 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100028]} 0 2
[junit4] 2> 247521 T1549 C812 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247528 T1549 C812 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_t,generation=29}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_u,generation=30}
[junit4] 2> 247528 T1549 C812 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 30
[junit4] 2> 247532 T1549 C812 oass.SolrIndexSearcher.<init> Opening Searcher@194e2b3 main
[junit4] 2> 247532 T1549 C812 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247535 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@194e2b3 main{StandardDirectoryReader(segments_u:60:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1 _r(5.0):c1 _s(5.0):c1)}
[junit4] 2> 247536 T1549 C812 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 16
[junit4] 2> 247538 T1549 C812 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100029]} 0 2
[junit4] 2> 247540 T1549 C812 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247547 T1549 C812 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_u,generation=30}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_v,generation=31}
[junit4] 2> 247547 T1549 C812 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 31
[junit4] 2> 247547 T1549 C812 oass.SolrIndexSearcher.<init> Opening Searcher@187d61f main
[junit4] 2> 247551 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@187d61f main{StandardDirectoryReader(segments_v:62:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1)}
[junit4] 2> 247551 T1549 C812 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247551 T1549 C812 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
[junit4] 2> 247554 T1549 C812 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100030]} 0 3
[junit4] 2> 247555 T1549 C812 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247559 T1549 C812 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_v,generation=31}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_w,generation=32}
[junit4] 2> 247561 T1549 C812 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 32
[junit4] 2> 247561 T1549 C812 oass.SolrIndexSearcher.<init> Opening Searcher@1dec1f main
[junit4] 2> 247563 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1dec1f main{StandardDirectoryReader(segments_w:64:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1)}
[junit4] 2> 247565 T1549 C812 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247565 T1549 C812 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
[junit4] 2> 247566 T1549 C812 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100031]} 0 1
[junit4] 2> ASYNC NEW_CORE C813 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247574 T1549 C813 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247578 T1549 C813 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_w,generation=32}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_x,generation=33}
[junit4] 2> 247578 T1549 C813 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 33
[junit4] 2> 247578 T1549 C813 oass.SolrIndexSearcher.<init> Opening Searcher@1908c85 main
[junit4] 2> 247584 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1908c85 main{StandardDirectoryReader(segments_x:66:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1)}
[junit4] 2> 247584 T1549 C813 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247584 T1549 C813 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 10
[junit4] 2> 247585 T1549 C813 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100032]} 0 0
[junit4] 2> 247588 T1549 C813 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247590 T1549 C813 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_x,generation=33}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_y,generation=34}
[junit4] 2> 247594 T1549 C813 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 34
[junit4] 2> 247594 T1549 C813 oass.SolrIndexSearcher.<init> Opening Searcher@519a93 main
[junit4] 2> 247596 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@519a93 main{StandardDirectoryReader(segments_y:68:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1)}
[junit4] 2> 247597 T1549 C813 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247597 T1549 C813 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
[junit4] 2> 247600 T1549 C813 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100033]} 0 3
[junit4] 2> 247601 T1549 C813 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 247605 T1549 C813 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_y,generation=34}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_z,generation=35}
[junit4] 2> 247605 T1549 C813 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 35
[junit4] 2> 247605 T1549 C813 oass.SolrIndexSearcher.<init> Opening Searcher@9f7e90 main
[junit4] 2> 247611 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9f7e90 main{StandardDirectoryReader(segments_z:70:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5.0):c1 _v(5.0):c1 _w(5.0):c1 _x(5.0):c1)}
[junit4] 2> 247611 T1549 C813 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 247611 T1549 C813 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11
[junit4] 2> 247612 T1549 C813 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[100034]} 0 0
[junit4] 2> 247615 T1549 C813 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C814 name=collection1 org.apache.solr.core.SolrCore@46695
[junit4] 2> 247623 T1549 C814 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_z,generation=35}
[junit4] 2> commit{dir=MockDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1ed3648 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cdaa4f),segFN=segments_10,generation=36}
[junit4] 2> 247627 T1549 C814 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 36
[junit4] 2> 247628 T1549 C814 oass.SolrIndexSearcher.<init> Opening Searcher@cd1b6d main
[junit4] 2> 247630 T1551 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@cd1b6d main{StandardDirectoryReader(segments_10:72:nrt _0(5.0):c1 _1(5.0):c1 _2(5.0):c1 _3(5.0):c1 _4(5.0):c1 _5(5.0):c1 _6(5.0):c1 _7(5.0):c1 _8(5.0):c1 _9(5.0):c1 _a(5.0):c1 _b(5.0):c1 _c(5.0):c1 _d(5.0):c1 _e(5.0):c1 _f(5.0):c1 _g(5.0):c1 _h(5.0):c1 _i(5.0):c1 _j(5.0):c1 _k(5.0):c1 _l(5.0):c1 _m(5.0):c1 _n(5.0):c1 _o(5.0):c1 _p(5.0):c1 _q(5.0):c1 _r(5.0):c1 _s(5.0):c1 _t(5.0):c1 _u(5
[...truncated too long message...]
ead[id=7629, name=qtp12074201-7629, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > 5) Thread[id=7627, name=qtp12074201-7627, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > 6) Thread[id=7630, name=qtp12074201-7630, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > 7) Thread[id=7623, name=qtp12074201-7623 Acceptor0 SelectChannelConnector@127.0.0.1:59532, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] > at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4] > at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:241)
[junit4] > at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4] > at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > 8) Thread[id=7624, name=qtp12074201-7624, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[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 org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:342)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:526)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.access$600(QueuedThreadPool.java:44)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > 9) Thread[id=7628, name=qtp12074201-7628 Selector0, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] > at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
[junit4] > at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(WindowsSelectorImpl.java:296)
[junit4] > at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(WindowsSelectorImpl.java:278)
[junit4] > at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:159)
[junit4] > at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] > at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] > at org.eclipse.jetty.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:569)
[junit4] > at org.eclipse.jetty.io.nio.SelectorManager$1.run(SelectorManager.java:290)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > at __randomizedtesting.SeedInfo.seed([4C1E9A235445D8F2]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4] > 1) Thread[id=7622, name=HashSessionScavenger-235, state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at java.util.TimerThread.mainLoop(Timer.java:552)
[junit4] > at java.util.TimerThread.run(Timer.java:505)
[junit4] > 2) Thread[id=7623, name=qtp12074201-7623 Acceptor0 SelectChannelConnector@127.0.0.1:59532, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] > at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > 3) Thread[id=7628, name=qtp12074201-7628 Selector0, state=RUNNABLE, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] > at sun.nio.ch.WindowsSelectorImpl.setWakeupSocket0(Native Method)
[junit4] > at sun.nio.ch.WindowsSelectorImpl.setWakeupSocket(WindowsSelectorImpl.java:464)
[junit4] > at sun.nio.ch.WindowsSelectorImpl.wakeup(WindowsSelectorImpl.java:606)
[junit4] > at java.nio.channels.spi.AbstractSelector$1.interrupt(AbstractSelector.java:213)
[junit4] > at java.nio.channels.spi.AbstractSelector.begin(AbstractSelector.java:219)
[junit4] > at sun.nio.ch.WindowsSelectorImpl.doSelect(WindowsSelectorImpl.java:157)
[junit4] > at sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] > at sun.nio.ch.SelectorImpl.selectNow(SelectorImpl.java:105)
[junit4] > at org.eclipse.jetty.io.nio.SelectorManager$SelectSet.doSelect(SelectorManager.java:536)
[junit4] > at org.eclipse.jetty.io.nio.SelectorManager$1.run(SelectorManager.java:290)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > at __randomizedtesting.SeedInfo.seed([4C1E9A235445D8F2]:0)
[junit4] Completed in 167.70s, 1 test, 2 errors <<< FAILURES!
[...truncated 184 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:420: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:400: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:489: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1272: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:908: There were test failures: 349 suites, 1551 tests, 2 suite-level errors, 1 failure, 201 ignored (11 assumptions)
Total time: 64 minutes 40 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.8.0-ea-b116 -server -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure