lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Apache Jenkins Server <jenk...@builds.apache.org>
Subject [JENKINS] Lucene-Solr-NightlyTests-trunk - Build # 84 - Still Failing
Date Thu, 08 Nov 2012 15:15:54 GMT
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/84/

4 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.servlet.NoCacheHeaderTest

Error Message:
4 threads leaked from SUITE scope at org.apache.solr.servlet.NoCacheHeaderTest:     1) Thread[id=206, name=qtp1114673702-206 Acceptor2 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    2) Thread[id=205, name=qtp1114673702-205 Acceptor1 SelectChannelConnector@0.0.0.0:24833, state=RUNNABLE, group=TGRP-NoCacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)    3) Thread[id=204, name=qtp1114673702-204 Acceptor0 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    4) Thread[id=207, name=qtp1114673702-207 Acceptor3 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.solr.servlet.NoCacheHeaderTest: 
   1) Thread[id=206, name=qtp1114673702-206 Acceptor2 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   2) Thread[id=205, name=qtp1114673702-205 Acceptor1 SelectChannelConnector@0.0.0.0:24833, state=RUNNABLE, group=TGRP-NoCacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
   3) Thread[id=204, name=qtp1114673702-204 Acceptor0 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   4) Thread[id=207, name=qtp1114673702-207 Acceptor3 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
	at __randomizedtesting.SeedInfo.seed([6DF939765EEC1D89]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.servlet.NoCacheHeaderTest

Error Message:
There are still zombie threads that couldn't be terminated:    1) Thread[id=206, name=qtp1114673702-206 Acceptor2 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    2) Thread[id=205, name=qtp1114673702-205 Acceptor1 SelectChannelConnector@0.0.0.0:24833, state=RUNNABLE, group=TGRP-NoCacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)    3) Thread[id=204, name=qtp1114673702-204 Acceptor0 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    4) Thread[id=207, name=qtp1114673702-207 Acceptor3 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
   1) Thread[id=206, name=qtp1114673702-206 Acceptor2 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   2) Thread[id=205, name=qtp1114673702-205 Acceptor1 SelectChannelConnector@0.0.0.0:24833, state=RUNNABLE, group=TGRP-NoCacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
   3) Thread[id=204, name=qtp1114673702-204 Acceptor0 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   4) Thread[id=207, name=qtp1114673702-207 Acceptor3 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
	at __randomizedtesting.SeedInfo.seed([6DF939765EEC1D89]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.update.PeerSyncTest

Error Message:
16 threads leaked from SUITE scope at org.apache.solr.update.PeerSyncTest:     1) Thread[id=37, name=qtp548409026-37 Acceptor3 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    2) Thread[id=35, name=qtp548409026-35 Acceptor1 SelectChannelConnector@0.0.0.0:40580, state=RUNNABLE, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)    3) Thread[id=18, name=qtp1491010616-18 Acceptor2 SelectChannelConnector@0.0.0.0:53019, state=RUNNABLE, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)    4) Thread[id=64, name=qtp1674485910-64 Acceptor2 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    5) Thread[id=20, name=qtp1491010616-20 Acceptor3 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    6) Thread[id=17, name=qtp1491010616-17 Acceptor0 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    7) Thread[id=48, name=qtp1891488487-48 Acceptor0 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    8) Thread[id=15, name=qtp1491010616-15 Acceptor1 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    9) Thread[id=36, name=qtp548409026-36 Acceptor2 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   10) Thread[id=63, name=qtp1674485910-63 Acceptor1 SelectChannelConnector@0.0.0.0:55609, state=RUNNABLE, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)   11) Thread[id=49, name=qtp1891488487-49 Acceptor1 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   12) Thread[id=34, name=qtp548409026-34 Acceptor0 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   13) Thread[id=51, name=qtp1891488487-51 Acceptor3 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   14) Thread[id=50, name=qtp1891488487-50 Acceptor2 SelectChannelConnector@0.0.0.0:53370, state=RUNNABLE, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)   15) Thread[id=62, name=qtp1674485910-62 Acceptor0 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   16) Thread[id=65, name=qtp1674485910-65 Acceptor3 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 16 threads leaked from SUITE scope at org.apache.solr.update.PeerSyncTest: 
   1) Thread[id=37, name=qtp548409026-37 Acceptor3 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   2) Thread[id=35, name=qtp548409026-35 Acceptor1 SelectChannelConnector@0.0.0.0:40580, state=RUNNABLE, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
   3) Thread[id=18, name=qtp1491010616-18 Acceptor2 SelectChannelConnector@0.0.0.0:53019, state=RUNNABLE, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
   4) Thread[id=64, name=qtp1674485910-64 Acceptor2 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   5) Thread[id=20, name=qtp1491010616-20 Acceptor3 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   6) Thread[id=17, name=qtp1491010616-17 Acceptor0 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   7) Thread[id=48, name=qtp1891488487-48 Acceptor0 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   8) Thread[id=15, name=qtp1491010616-15 Acceptor1 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   9) Thread[id=36, name=qtp548409026-36 Acceptor2 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  10) Thread[id=63, name=qtp1674485910-63 Acceptor1 SelectChannelConnector@0.0.0.0:55609, state=RUNNABLE, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
  11) Thread[id=49, name=qtp1891488487-49 Acceptor1 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  12) Thread[id=34, name=qtp548409026-34 Acceptor0 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  13) Thread[id=51, name=qtp1891488487-51 Acceptor3 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  14) Thread[id=50, name=qtp1891488487-50 Acceptor2 SelectChannelConnector@0.0.0.0:53370, state=RUNNABLE, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
  15) Thread[id=62, name=qtp1674485910-62 Acceptor0 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  16) Thread[id=65, name=qtp1674485910-65 Acceptor3 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
	at __randomizedtesting.SeedInfo.seed([6DF939765EEC1D89]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.update.PeerSyncTest

Error Message:
There are still zombie threads that couldn't be terminated:    1) Thread[id=37, name=qtp548409026-37 Acceptor3 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    2) Thread[id=18, name=qtp1491010616-18 Acceptor2 SelectChannelConnector@0.0.0.0:53019, state=RUNNABLE, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)    3) Thread[id=35, name=qtp548409026-35 Acceptor1 SelectChannelConnector@0.0.0.0:40580, state=RUNNABLE, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)    4) Thread[id=64, name=qtp1674485910-64 Acceptor2 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    5) Thread[id=20, name=qtp1491010616-20 Acceptor3 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    6) Thread[id=17, name=qtp1491010616-17 Acceptor0 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    7) Thread[id=15, name=qtp1491010616-15 Acceptor1 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    8) Thread[id=48, name=qtp1891488487-48 Acceptor0 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)    9) Thread[id=36, name=qtp548409026-36 Acceptor2 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   10) Thread[id=63, name=qtp1674485910-63 Acceptor1 SelectChannelConnector@0.0.0.0:55609, state=RUNNABLE, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)   11) Thread[id=34, name=qtp548409026-34 Acceptor0 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   12) Thread[id=49, name=qtp1891488487-49 Acceptor1 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   13) Thread[id=51, name=qtp1891488487-51 Acceptor3 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   14) Thread[id=50, name=qtp1891488487-50 Acceptor2 SelectChannelConnector@0.0.0.0:53370, state=RUNNABLE, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)         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:679)   15) Thread[id=62, name=qtp1674485910-62 Acceptor0 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)   16) Thread[id=65, name=qtp1674485910-65 Acceptor3 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)         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:679)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
   1) Thread[id=37, name=qtp548409026-37 Acceptor3 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   2) Thread[id=18, name=qtp1491010616-18 Acceptor2 SelectChannelConnector@0.0.0.0:53019, state=RUNNABLE, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
   3) Thread[id=35, name=qtp548409026-35 Acceptor1 SelectChannelConnector@0.0.0.0:40580, state=RUNNABLE, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
   4) Thread[id=64, name=qtp1674485910-64 Acceptor2 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   5) Thread[id=20, name=qtp1491010616-20 Acceptor3 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   6) Thread[id=17, name=qtp1491010616-17 Acceptor0 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   7) Thread[id=15, name=qtp1491010616-15 Acceptor1 SelectChannelConnector@0.0.0.0:53019, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   8) Thread[id=48, name=qtp1891488487-48 Acceptor0 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
   9) Thread[id=36, name=qtp548409026-36 Acceptor2 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  10) Thread[id=63, name=qtp1674485910-63 Acceptor1 SelectChannelConnector@0.0.0.0:55609, state=RUNNABLE, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
  11) Thread[id=34, name=qtp548409026-34 Acceptor0 SelectChannelConnector@0.0.0.0:40580, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  12) Thread[id=49, name=qtp1891488487-49 Acceptor1 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  13) Thread[id=51, name=qtp1891488487-51 Acceptor3 SelectChannelConnector@0.0.0.0:53370, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  14) Thread[id=50, name=qtp1891488487-50 Acceptor2 SelectChannelConnector@0.0.0.0:53370, state=RUNNABLE, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
        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:679)
  15) Thread[id=62, name=qtp1674485910-62 Acceptor0 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
  16) Thread[id=65, name=qtp1674485910-65 Acceptor3 SelectChannelConnector@0.0.0.0:55609, state=BLOCKED, group=TGRP-PeerSyncTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
        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:679)
	at __randomizedtesting.SeedInfo.seed([6DF939765EEC1D89]:0)




Build Log:
[...truncated 7900 lines...]
[junit4:junit4] Suite: org.apache.solr.update.PeerSyncTest
[junit4:junit4]   2> 324 T10 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> 875 T10 oejs.Server.doStart jetty-8.1.7.v20120910
[junit4:junit4]   2> 1198 T10 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:53019
[junit4:junit4]   2> 1389 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1390 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 1391 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2098 T10 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 2103 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2104 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 2142 T10 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 2147 T10 oasc.CoreContainer.<init> New CoreContainer 2026561073
[junit4:junit4]   2> 2148 T10 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2148 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2241 T10 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2581 T10 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 2582 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 2583 T10 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 2584 T10 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2662 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 2797 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 2836 T10 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2896 T10 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4857 T10 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 4886 T10 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 4890 T10 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5333 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5347 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5352 T10 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5372 T10 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5480 T10 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.update.PeerSyncTest-1352387584657/control/data/
[junit4:junit4]   2> 5480 T10 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 5499 T10 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 5599 T10 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@20c62080 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2f7fc44f) assuming 'simple'
[junit4:junit4]   2> 5605 T10 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/control/data forceNew:false
[junit4:junit4]   2> 5605 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/control/data
[junit4:junit4]   2> 5606 T10 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.update.PeerSyncTest-1352387584657/control/data/index/
[junit4:junit4]   2> 5607 T10 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.update.PeerSyncTest-1352387584657/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 5658 T10 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/control/data/index forceNew:false
[junit4:junit4]   2> 5979 T10 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@445ead9d lockFactory=org.apache.lucene.store.NativeFSLockFactory@eb3ae5c; maxCacheMB=0.9765625 maxMergeSizeMB=0.392578125)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5980 T10 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 5981 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/control/data/index
[junit4:junit4]   2> 6762 T10 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 6780 T10 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 6809 T10 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 6813 T10 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 6939 T10 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 6976 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/control/data
[junit4:junit4]   2> 7032 T10 oass.SolrIndexSearcher.<init> Opening Searcher@7b4189d0 main
[junit4:junit4]   2> 7154 T10 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 7154 T10 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 7287 T10 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 7287 T10 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 7288 T10 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 7288 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 7289 T10 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 7289 T10 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 7290 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 7290 T10 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 7291 T10 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 7342 T10 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 7945 T28 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7b4189d0 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 7948 T10 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 7948 T10 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
[junit4:junit4]   2> 7949 T10 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 8022 T10 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 8054 T10 oejs.Server.doStart jetty-8.1.7.v20120910
[junit4:junit4]   2> 8058 T10 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:40580
[junit4:junit4]   2> 8059 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 8060 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 8060 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 8108 T10 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 8109 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 8110 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 8111 T10 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 8112 T10 oasc.CoreContainer.<init> New CoreContainer 544685315
[junit4:junit4]   2> 8113 T10 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 8114 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 8149 T10 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 8181 T10 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 8183 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 8185 T10 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 8186 T10 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 8243 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 8314 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 8315 T10 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 8379 T10 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 9155 T10 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 9174 T10 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 9180 T10 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 9205 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 9212 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 9218 T10 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 9222 T10 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 9226 T10 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/
[junit4:junit4]   2> 9227 T10 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 9227 T10 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 9236 T10 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for MockDirWrapper(org.apache.lucene.store.RAMDirectory@3600e312 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@743bce70) assuming 'simple'
[junit4:junit4]   2> 9236 T10 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data forceNew:false
[junit4:junit4]   2> 9237 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 9238 T10 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index/
[junit4:junit4]   2> 9239 T10 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 9240 T10 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index forceNew:false
[junit4:junit4]   2> 9250 T10 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 9251 T10 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 9252 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index
[junit4:junit4]   2> 9255 T10 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 9257 T10 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 9259 T10 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 9260 T10 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 9268 T10 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 9274 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 9276 T10 oass.SolrIndexSearcher.<init> Opening Searcher@3b629e96 main
[junit4:junit4]   2> 9277 T10 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 9278 T10 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 9279 T10 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 9280 T10 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 9280 T10 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 9281 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 9282 T10 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 9283 T10 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 9283 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 9284 T10 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 9285 T10 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 9286 T10 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 9313 T42 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3b629e96 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 9313 T10 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 9314 T10 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
[junit4:junit4]   2> 9315 T10 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 9316 T10 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 9330 T10 oejs.Server.doStart jetty-8.1.7.v20120910
[junit4:junit4]   2> 9333 T10 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:53370
[junit4:junit4]   2> 9334 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 9335 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 9336 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 9373 T10 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 9374 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 9374 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 9375 T10 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 9376 T10 oasc.CoreContainer.<init> New CoreContainer 1025542363
[junit4:junit4]   2> 9377 T10 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 9378 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 9409 T10 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 9437 T10 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 9438 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 9440 T10 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 9441 T10 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 9502 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 9566 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 9567 T10 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 9624 T10 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 10432 T10 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 10444 T10 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 10447 T10 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 10464 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 10469 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 10473 T10 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 10475 T10 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 10477 T10 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/
[junit4:junit4]   2> 10478 T10 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 10478 T10 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 10479 T10 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for MockDirWrapper(org.apache.lucene.store.RAMDirectory@64623367 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b1ce2ad) assuming 'simple'
[junit4:junit4]   2> 10480 T10 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data forceNew:false
[junit4:junit4]   2> 10480 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 10481 T10 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index/
[junit4:junit4]   2> 10482 T10 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 10482 T10 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index forceNew:false
[junit4:junit4]   2> 10486 T10 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 10486 T10 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 10487 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index
[junit4:junit4]   2> 10489 T10 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 10490 T10 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 10491 T10 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 10492 T10 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 10498 T10 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 10502 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 10503 T10 oass.SolrIndexSearcher.<init> Opening Searcher@40395aaf main
[junit4:junit4]   2> 10504 T10 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 10505 T10 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 10505 T10 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 10506 T10 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 10506 T10 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 10507 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 10507 T10 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 10508 T10 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 10508 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 10509 T10 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 10509 T10 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 10510 T10 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 10528 T56 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@40395aaf main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 10528 T10 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 10529 T10 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
[junit4:junit4]   2> 10530 T10 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 10530 T10 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 10539 T10 oejs.Server.doStart jetty-8.1.7.v20120910
[junit4:junit4]   2> 10542 T10 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:55609
[junit4:junit4]   2> 10543 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 10543 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 10544 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 10569 T10 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 10570 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 10570 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 10570 T10 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 10571 T10 oasc.CoreContainer.<init> New CoreContainer 1304853332
[junit4:junit4]   2> 10572 T10 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 10572 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 10593 T10 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 10611 T10 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 10612 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 10613 T10 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 10614 T10 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 10651 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 10693 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig-tlog.xml
[junit4:junit4]   2> 10694 T10 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 10727 T10 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 11245 T10 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 11257 T10 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 11260 T10 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 11277 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 11282 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 11286 T10 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 11288 T10 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 11290 T10 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.update.PeerSyncTest-1352387584657/shard2/data/
[junit4:junit4]   2> 11291 T10 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1
[junit4:junit4]   2> 11291 T10 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 11292 T10 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for MockDirWrapper(org.apache.lucene.store.RAMDirectory@2586b11c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2dd5b883) assuming 'simple'
[junit4:junit4]   2> 11293 T10 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard2/data forceNew:false
[junit4:junit4]   2> 11293 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard2/data
[junit4:junit4]   2> 11293 T10 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.update.PeerSyncTest-1352387584657/shard2/data/index/
[junit4:junit4]   2> 11294 T10 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.update.PeerSyncTest-1352387584657/shard2/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 11329 T10 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard2/data/index forceNew:false
[junit4:junit4]   2> 11338 T10 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/index2767827678tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@4c4936f3),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 11340 T10 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 11341 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard2/data/index
[junit4:junit4]   2> 11344 T10 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 11345 T10 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 11347 T10 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 11347 T10 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 11353 T10 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 11359 T10 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard2/data
[junit4:junit4]   2> 11370 T10 oass.SolrIndexSearcher.<init> Opening Searcher@72b398da main
[junit4:junit4]   2> 11371 T10 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 11371 T10 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 11372 T10 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 11372 T10 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 11373 T10 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 11373 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 11373 T10 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 11374 T10 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 11374 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 11375 T10 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 11375 T10 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 11376 T10 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 11393 T70 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@72b398da main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 11393 T10 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 11394 T10 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1
[junit4:junit4]   2> 11395 T10 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 11395 T10 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C0 name=collection1 org.apache.solr.core.SolrCore@3aa620f5
[junit4:junit4]   2> 13032 T39 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 13039 T39 C0 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 13040 T39 C0 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 13437 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=739 
[junit4:junit4]   2> ASYNC  NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@60666a53
[junit4:junit4]   2> 13686 T54 C1 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&connTimeout=30000&socketTimeout=30000&retry=false
[junit4:junit4]   2> 13705 T54 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= START replicas=[127.0.0.1:40580/solr] nUpdates=100
[junit4:junit4]   2> 13715 T54 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= DONE.  We have no versions.  sync failed.
[junit4:junit4]   2> 13715 T54 C1 REQ [collection1] webapp=/solr path=/get params={qt=/get&wt=javabin&sync=127.0.0.1:40580/solr&version=2&getVersions=100} status=0 QTime=84 
[junit4:junit4]   2> 13739 T53 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 13743 T53 C1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 13744 T53 C1 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 13756 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=18 
[junit4:junit4]   2> 13758 T40 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=10 
[junit4:junit4]   2> 13759 T54 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= START replicas=[127.0.0.1:40580/solr] nUpdates=100
[junit4:junit4]   2> 13764 T41 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=0 
[junit4:junit4]   2> 13766 T54 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Received 1 versions from 127.0.0.1:40580/solr
[junit4:junit4]   2> 13766 T54 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Our versions are newer. ourLowThreshold=1 otherHigh=1
[junit4:junit4]   2> 13767 T54 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4:junit4]   2> 13768 T54 C1 REQ [collection1] webapp=/solr path=/get params={qt=/get&wt=javabin&sync=127.0.0.1:40580/solr&version=2&getVersions=100} status=0 QTime=9 
[junit4:junit4]   2> 13782 T39 C0 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 14484 T39 C0 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_2,generation=2,filenames=[_0_MockRandom_0.tib, _0.fnm, _0_MockVariableIntBlock_0.doc, _0_nrm.cfs, _0_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _0_Pulsing41_0.tim, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tip, _0_MockRandom_0.doc, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _0_nrm.cfe, _0_MockVariableIntBlock_0.pos, segments_2, _0.fdx, _0.si, _0_MockVariableIntBlock_0.tii, _0.fdt]
[junit4:junit4]   2> 14485 T39 C0 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0_MockRandom_0.tib, _0.fnm, _0_MockVariableIntBlock_0.doc, _0_nrm.cfs, _0_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _0_Pulsing41_0.tim, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tip, _0_MockRandom_0.doc, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _0_nrm.cfe, _0_MockVariableIntBlock_0.pos, segments_2, _0.fdx, _0.si, _0_MockVariableIntBlock_0.tii, _0.fdt]
[junit4:junit4]   2> 14486 T39 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 14756 T39 C0 oass.SolrIndexSearcher.<init> Opening Searcher@6d01ac1c main
[junit4:junit4]   2> 14760 T39 C0 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 14766 T42 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d01ac1c main{StandardDirectoryReader(segments_2:3 _0(5.0):C1)}
[junit4:junit4]   2> 14766 T42 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index
[junit4:junit4]   2> 14767 T39 C0 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 991
[junit4:junit4]   2> 14771 T55 C1 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 14794 T55 C1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_2,generation=2,filenames=[_0_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _0.fnm, _0_nrm.cfs, _0_MockRandom_0.skp, _0_MockRandom_0.tip, _0_MockRandom_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.doc, _0_nrm.cfe, _0_MockRandom_0.pos, _0_MockVariableIntBlock_0.frq, segments_2, _0.fdx, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, _0.fdt]
[junit4:junit4]   2> 14795 T55 C1 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _0.fnm, _0_nrm.cfs, _0_MockRandom_0.skp, _0_MockRandom_0.tip, _0_MockRandom_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.doc, _0_nrm.cfe, _0_MockRandom_0.pos, _0_MockVariableIntBlock_0.frq, segments_2, _0.fdx, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, _0.fdt]
[junit4:junit4]   2> 14795 T55 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 14803 T55 C1 oass.SolrIndexSearcher.<init> Opening Searcher@7ca53564 main
[junit4:junit4]   2> 14804 T56 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7ca53564 main{StandardDirectoryReader(segments_2:3 _0(5.0):C1)}
[junit4:junit4]   2> 14804 T55 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 14805 T56 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index
[junit4:junit4]   2> 14805 T55 C1 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 34
[junit4:junit4]   2> 15046 T41 C0 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=1 status=0 QTime=224 
[junit4:junit4]   2> 15074 T53 C1 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=1 status=0 QTime=1 
[junit4:junit4]   2> 15107 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=23 
[junit4:junit4]   2> 15112 T54 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= START replicas=[127.0.0.1:40580/solr] nUpdates=100
[junit4:junit4]   2> 15115 T41 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=1 
[junit4:junit4]   2> 15116 T54 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Received 2 versions from 127.0.0.1:40580/solr
[junit4:junit4]   2> 15116 T54 C1 oasu.PeerSync.requestUpdates PeerSync: core=collection1 url= Requesting updates from 127.0.0.1:40580/solrn=1 versions=[2]
[junit4:junit4]   2> 15120 T39 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&getUpdates=2&qt=/get&wt=javabin&version=2} status=0 QTime=0 
[junit4:junit4]   2> 15126 T54 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4:junit4]   2> 15127 T54 C1 REQ [collection1] webapp=/solr path=/get params={qt=/get&wt=javabin&sync=127.0.0.1:40580/solr&version=2&getVersions=100} status=0 QTime=16 
[junit4:junit4]   2> 15131 T40 C0 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 15194 T40 C0 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_2,generation=2,filenames=[_0_MockRandom_0.tib, _0.fnm, _0_MockVariableIntBlock_0.doc, _0_nrm.cfs, _0_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _0_Pulsing41_0.tim, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tip, _0_MockRandom_0.doc, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _0_nrm.cfe, _0_MockVariableIntBlock_0.pos, segments_2, _0.fdx, _0.si, _0_MockVariableIntBlock_0.tii, _0.fdt]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_3,generation=3,filenames=[_1_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.skp, _1_MockRandom_0.pos, _1.fnm, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _0_MockRandom_0.tib, _1_nrm.cfs, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockVariableIntBlock_0.pos, _1_MockRandom_0.tip, _1_Pulsing41_0.doc, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _0_nrm.cfs, _1_Pulsing41_0.pos, _1_MockVariableIntBlock_0.tib, _1_nrm.cfe, _1_MockVariableIntBlock_0.frq, _1.fdx, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _1_Pulsing41_0.tip, _0_MockRandom_0.tiv, _1.fdt, _1_Pulsing41_0.tim, _0_MockRandom_0.doc, _1.si, _0_nrm.cfe, _0_MockRandom_0.pos, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _0.fdx, segments_3, _0.fdt]
[junit4:junit4]   2> 15194 T40 C0 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_1_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.skp, _1_MockRandom_0.pos, _1.fnm, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _0_MockRandom_0.tib, _1_nrm.cfs, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockVariableIntBlock_0.pos, _1_MockRandom_0.tip, _1_Pulsing41_0.doc, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _0_nrm.cfs, _1_Pulsing41_0.pos, _1_MockVariableIntBlock_0.tib, _1_nrm.cfe, _1_MockVariableIntBlock_0.frq, _1.fdx, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _1_Pulsing41_0.tip, _0_MockRandom_0.tiv, _1.fdt, _1_Pulsing41_0.tim, _0_MockRandom_0.doc, _1.si, _0_nrm.cfe, _0_MockRandom_0.pos, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _0.fdx, segments_3, _0.fdt]
[junit4:junit4]   2> 15195 T40 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 15204 T40 C0 oass.SolrIndexSearcher.<init> Opening Searcher@7d846aed main
[junit4:junit4]   2> 15205 T42 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7d846aed main{StandardDirectoryReader(segments_3:5 _0(5.0):C1 _1(5.0):C1)}
[junit4:junit4]   2> 15205 T40 C0 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 15205 T42 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index
[junit4:junit4]   2> 15206 T40 C0 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 75
[junit4:junit4]   2> 15211 T53 C1 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 15225 T53 C1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_2,generation=2,filenames=[_0_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _0.fnm, _0_nrm.cfs, _0_MockRandom_0.skp, _0_MockRandom_0.tip, _0_MockRandom_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.doc, _0_nrm.cfe, _0_MockRandom_0.pos, _0_MockVariableIntBlock_0.frq, segments_2, _0.fdx, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, _0.fdt]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_3,generation=3,filenames=[_0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _1.fdx, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _1_MockRandom_0.frq, _1_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _1_nrm.cfs, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_MockRandom_0.skp, _1_Pulsing41_0.pos, _1_nrm.cfe, _1_MockVariableIntBlock_0.frq, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _0_MockRandom_0.tip, _1_MockRandom_0.pyl, _1.si, _0_nrm.cfe, _0.fdx, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, segments_3, _0.fdt]
[junit4:junit4]   2> 15226 T53 C1 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _1.fdx, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _1_MockRandom_0.frq, _1_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _1_nrm.cfs, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_MockRandom_0.skp, _1_Pulsing41_0.pos, _1_nrm.cfe, _1_MockVariableIntBlock_0.frq, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _0_MockRandom_0.tip, _1_MockRandom_0.pyl, _1.si, _0_nrm.cfe, _0.fdx, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, segments_3, _0.fdt]
[junit4:junit4]   2> 15226 T53 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 15295 T53 C1 oass.SolrIndexSearcher.<init> Opening Searcher@3c9d17e main
[junit4:junit4]   2> 15296 T56 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3c9d17e main{StandardDirectoryReader(segments_3:5 _0(5.0):C1 _1(5.0):C1)}
[junit4:junit4]   2> 15296 T53 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 15297 T56 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index
[junit4:junit4]   2> 15297 T53 C1 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 86
[junit4:junit4]   2> 15301 T40 C0 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 15307 T55 C1 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 15319 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 15326 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 15336 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 15344 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 15352 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 15361 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 15368 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 15375 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 15379 T53 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= START replicas=[127.0.0.1:40580/solr] nUpdates=100
[junit4:junit4]   2> 15383 T40 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=0 
[junit4:junit4]   2> 15384 T53 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Received 10 versions from 127.0.0.1:40580/solr
[junit4:junit4]   2> 15385 T53 C1 oasu.PeerSync.requestUpdates PeerSync: core=collection1 url= Requesting updates from 127.0.0.1:40580/solrn=8 versions=[10, 9, 8, 7, 6, 5, 4, 3]
[junit4:junit4]   2> 15389 T39 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&getUpdates=10,9,8,7,6,5,4,3&qt=/get&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15413 T53 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4:junit4]   2> 15414 T53 C1 REQ [collection1] webapp=/solr path=/get params={qt=/get&wt=javabin&sync=127.0.0.1:40580/solr&version=2&getVersions=100} status=0 QTime=36 
[junit4:junit4]   2> 15418 T41 C0 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 15471 T41 C0 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_3,generation=3,filenames=[_1_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.skp, _1_MockRandom_0.pos, _1.fnm, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _0_MockRandom_0.tib, _1_nrm.cfs, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockVariableIntBlock_0.pos, _1_MockRandom_0.tip, _1_Pulsing41_0.doc, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _0_nrm.cfs, _1_Pulsing41_0.pos, _1_MockVariableIntBlock_0.tib, _1_nrm.cfe, _1_MockVariableIntBlock_0.frq, _1.fdx, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _1_Pulsing41_0.tip, _0_MockRandom_0.tiv, _1.fdt, _1_Pulsing41_0.tim, _0_MockRandom_0.doc, _1.si, _0_nrm.cfe, _0_MockRandom_0.pos, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _0.fdx, segments_3, _0.fdt]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_4,generation=4,filenames=[_2_Pulsing41_0.doc, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _1_MockVariableIntBlock_0.tib, _2_Pulsing41_0.pos, _1.fdx, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.frq, _2_MockVariableIntBlock_0.doc, _2_MockRandom_0.tiv, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_MockRandom_0.tib, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _0_MockRandom_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_Pulsing41_0.pos, _2.fnm, _1_nrm.cfe, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, _2_MockRandom_0.doc, _0.fdt, segments_4]
[junit4:junit4]   2> 15472 T41 C0 oasc.SolrDeletionPolicy.updateCommits newest commit = 4[_2_Pulsing41_0.doc, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _1_MockVariableIntBlock_0.tib, _2_Pulsing41_0.pos, _1.fdx, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.frq, _2_MockVariableIntBlock_0.doc, _2_MockRandom_0.tiv, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_MockRandom_0.tib, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _0_MockRandom_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_Pulsing41_0.pos, _2.fnm, _1_nrm.cfe, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, _2_MockRandom_0.doc, _0.fdt, segments_4]
[junit4:junit4]   2> 15473 T41 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 15480 T41 C0 oass.SolrIndexSearcher.<init> Opening Searcher@48433545 main
[junit4:junit4]   2> 15481 T41 C0 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 15481 T42 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@48433545 main{StandardDirectoryReader(segments_4:7 _0(5.0):C1 _1(5.0):C1 _2(5.0):C8)}
[junit4:junit4]   2> 15482 T42 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index
[junit4:junit4]   2> 15482 T41 C0 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 64
[junit4:junit4]   2> 15486 T55 C1 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 15514 T55 C1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_3,generation=3,filenames=[_0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _1.fdx, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _1_MockRandom_0.frq, _1_MockVariableIntBlock_0.skp, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _1_nrm.cfs, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_MockRandom_0.skp, _1_Pulsing41_0.pos, _1_nrm.cfe, _1_MockVariableIntBlock_0.frq, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _0_MockRandom_0.tip, _1_MockRandom_0.pyl, _1.si, _0_nrm.cfe, _0.fdx, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, segments_3, _0.fdt]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_4,generation=4,filenames=[_2_Pulsing41_0.doc, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _2_Pulsing41_0.pos, _1.fdx, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _1_MockRandom_0.frq, _2.si, _1_MockVariableIntBlock_0.skp, _2_MockVariableIntBlock_0.pyl, _2_MockRandom_0.tip, _0_MockVariableIntBlock_0.doc, _2_MockRandom_0.tim, _2_MockVariableIntBlock_0.frq, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_MockRandom_0.skp, _1_Pulsing41_0.pos, _2.fnm, _1_nrm.cfe, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _0_MockRandom_0.tip, _1_MockRandom_0.pyl, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, _0_MockRandom_0.pyl, _2_MockRandom_0.doc, _0_MockRandom_0.tim, _0.fdt, segments_4]
[junit4:junit4]   2> 15516 T55 C1 oasc.SolrDeletionPolicy.updateCommits newest commit = 4[_2_Pulsing41_0.doc, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _2_Pulsing41_0.pos, _1.fdx, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _1_MockRandom_0.frq, _2.si, _1_MockVariableIntBlock_0.skp, _2_MockVariableIntBlock_0.pyl, _2_MockRandom_0.tip, _0_MockVariableIntBlock_0.doc, _2_MockRandom_0.tim, _2_MockVariableIntBlock_0.frq, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_MockRandom_0.skp, _1_Pulsing41_0.pos, _2.fnm, _1_nrm.cfe, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _0_MockRandom_0.tip, _1_MockRandom_0.pyl, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, _0_MockRandom_0.pyl, _2_MockRandom_0.doc, _0_MockRandom_0.tim, _0.fdt, segments_4]
[junit4:junit4]   2> 15517 T55 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 15525 T55 C1 oass.SolrIndexSearcher.<init> Opening Searcher@58053b2c main
[junit4:junit4]   2> 15526 T56 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@58053b2c main{StandardDirectoryReader(segments_4:7 _0(5.0):C1 _1(5.0):C1 _2(5.0):C8)}
[junit4:junit4]   2> 15526 T55 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 15527 T56 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index
[junit4:junit4]   2> 15528 T55 C1 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 42
[junit4:junit4]   2> 15532 T39 C0 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=10 status=0 QTime=1 
[junit4:junit4]   2> 15539 T53 C1 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=10 status=0 QTime=1 
[junit4:junit4]   2> 15549 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15555 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15561 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15566 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15572 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15577 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15582 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15588 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15593 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15598 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15604 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15609 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15614 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15620 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15625 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15637 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15644 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15649 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15655 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15661 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15667 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15674 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15680 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15686 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15693 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 15699 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15705 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15713 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15719 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15724 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15730 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15736 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15741 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15747 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15753 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15758 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15764 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15769 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15775 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15780 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15785 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15790 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15795 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15800 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15805 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15810 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15815 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15820 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15824 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15829 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15834 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15839 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15843 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15847 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15854 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15859 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15864 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15871 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 15876 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15881 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15886 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15892 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15898 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15904 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15909 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15916 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 15922 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15926 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15932 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15937 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15940 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15946 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15951 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15955 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15962 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 15967 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15971 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15976 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15982 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15986 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 15992 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 15997 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16002 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16008 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16013 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16016 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16023 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 16028 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16033 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16039 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 16045 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16050 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16056 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 16061 T40 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16065 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16068 T53 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= START replicas=[127.0.0.1:40580/solr] nUpdates=100
[junit4:junit4]   2> 16073 T39 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=1 
[junit4:junit4]   2> 16075 T53 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Received 100 versions from 127.0.0.1:40580/solr
[junit4:junit4]   2> 16075 T53 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Our versions are too old. ourHighThreshold=8 otherLowThreshold=25
[junit4:junit4]   2> 16075 T53 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= DONE. sync failed
[junit4:junit4]   2> 16076 T53 C1 REQ [collection1] webapp=/solr path=/get params={qt=/get&wt=javabin&sync=127.0.0.1:40580/solr&version=2&getVersions=100} status=0 QTime=8 
[junit4:junit4]   2> 16084 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 16090 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16095 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16099 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16105 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16109 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16113 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16117 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16122 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16126 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16131 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16134 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16138 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16142 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16147 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16151 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16156 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16161 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16166 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 16171 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16176 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16182 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 16187 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16192 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16197 T54 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16203 T53 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= START replicas=[127.0.0.1:40580/solr] nUpdates=100
[junit4:junit4]   2> 16208 T39 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=1 
[junit4:junit4]   2> 16209 T53 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Received 100 versions from 127.0.0.1:40580/solr
[junit4:junit4]   2> 16209 T53 C1 oasu.PeerSync.requestUpdates PeerSync: core=collection1 url= Requesting updates from 127.0.0.1:40580/solrn=70 versions=[105, 104, 103, 102, 101, 100, 99, 98, 97, 96, 95, 94, 93, 92, 91, 90, 89, 88, 87, 86, 85, 84, 83, 82, 81, 80, 79, 78, 77, 76, 75, 74, 73, 72, 71, 70, 69, 68, 67, 66, 65, 64, 63, 62, 61, 60, 59, 58, 57, 56, 55, 54, 53, 52, 51, 50, 49, 48, 47, 46, 45, 44, 43, 42, 41, 40, 39, 38, 37, 36]
[junit4:junit4]   2> 16219 T41 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&getUpdates=105,104,103,102,101,100,99,98,97,96,95,94,93,92,91,90,89,88,87,86,85,84,83,82,81,80,79,78,77,76,75,74,73,72,71,70,69,68,67,66,65,64,63,62,61,60,59,58,57,56,55,54,53,52,51,50,49,48,47,46,45,44,43,42,41,40,39,38,37,36&qt=/get&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 16287 T53 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4:junit4]   2> 16287 T53 C1 REQ [collection1] webapp=/solr path=/get params={qt=/get&wt=javabin&sync=127.0.0.1:40580/solr&version=2&getVersions=100} status=0 QTime=84 
[junit4:junit4]   2> 16292 T40 C0 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 16334 T40 C0 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_4,generation=4,filenames=[_2_Pulsing41_0.doc, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _1_MockVariableIntBlock_0.tib, _2_Pulsing41_0.pos, _1.fdx, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.frq, _2_MockVariableIntBlock_0.doc, _2_MockRandom_0.tiv, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_MockRandom_0.tib, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _0_MockRandom_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_Pulsing41_0.pos, _2.fnm, _1_nrm.cfe, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, _2_MockRandom_0.doc, _0.fdt, segments_4]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_5,generation=5,filenames=[_3_nrm.cfe, _2_Pulsing41_0.doc, _3_MockVariableIntBlock_0.frq, _3.fdt, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _3_MockVariableIntBlock_0.doc, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _1_MockVariableIntBlock_0.tib, _3_Pulsing41_0.pos, _3_nrm.cfs, _2_Pulsing41_0.pos, _1.fdx, _3_MockRandom_0.tip, _1_Pulsing41_0.tip, _1.fdt, _3_MockRandom_0.tim, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _3_MockVariableIntBlock_0.tib, _3.si, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _3_MockRandom_0.doc, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.frq, _3.fnm, _3_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.doc, _2_MockRandom_0.tiv, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _3_Pulsing41_0.tim, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_MockRandom_0.tib, _3_Pulsing41_0.tip, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _0_MockRandom_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_Pulsing41_0.pos, _3_MockRandom_0.sd, _2.fnm, _1_nrm.cfe, _3.fdx, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.frq, _0.fdx, segments_5, _3_MockVariableIntBlock_0.skp, _3_MockRandom_0.pos, _2_MockRandom_0.doc, _0.fdt, _3_MockVariableIntBlock_0.pos]
[junit4:junit4]   2> 16334 T40 C0 oasc.SolrDeletionPolicy.updateCommits newest commit = 5[_3_nrm.cfe, _2_Pulsing41_0.doc, _3_MockVariableIntBlock_0.frq, _3.fdt, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _3_MockVariableIntBlock_0.doc, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _1_MockVariableIntBlock_0.tib, _3_Pulsing41_0.pos, _3_nrm.cfs, _2_Pulsing41_0.pos, _1.fdx, _3_MockRandom_0.tip, _1_Pulsing41_0.tip, _1.fdt, _3_MockRandom_0.tim, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _3_MockVariableIntBlock_0.tib, _3.si, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _3_MockRandom_0.doc, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.frq, _3.fnm, _3_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.doc, _2_MockRandom_0.tiv, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _3_Pulsing41_0.tim, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_MockRandom_0.tib, _3_Pulsing41_0.tip, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _0_MockRandom_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_Pulsing41_0.pos, _3_MockRandom_0.sd, _2.fnm, _1_nrm.cfe, _3.fdx, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.frq, _0.fdx, segments_5, _3_MockVariableIntBlock_0.skp, _3_MockRandom_0.pos, _2_MockRandom_0.doc, _0.fdt, _3_MockVariableIntBlock_0.pos]
[junit4:junit4]   2> 16335 T40 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 16343 T40 C0 oass.SolrIndexSearcher.<init> Opening Searcher@e9bfee2 main
[junit4:junit4]   2> 16344 T42 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e9bfee2 main{StandardDirectoryReader(segments_5:9 _0(5.0):C1 _1(5.0):C1 _2(5.0):C8 _3(5.0):C95)}
[junit4:junit4]   2> 16344 T42 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index
[junit4:junit4]   2> 16344 T40 C0 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 16345 T40 C0 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 53
[junit4:junit4]   2> 16349 T53 C1 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 16431 T53 C1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_4,generation=4,filenames=[_2_Pulsing41_0.doc, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _2_Pulsing41_0.pos, _1.fdx, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _1_MockRandom_0.frq, _2.si, _1_MockVariableIntBlock_0.skp, _2_MockVariableIntBlock_0.pyl, _2_MockRandom_0.tip, _0_MockVariableIntBlock_0.doc, _2_MockRandom_0.tim, _2_MockVariableIntBlock_0.frq, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_MockRandom_0.skp, _1_Pulsing41_0.pos, _2.fnm, _1_nrm.cfe, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _0_MockRandom_0.tip, _1_MockRandom_0.pyl, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, _0_MockRandom_0.pyl, _2_MockRandom_0.doc, _0_MockRandom_0.tim, _0.fdt, segments_4]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_5,generation=5,filenames=[_3_MockVariableIntBlock_0.frq, _3.fdt, _1_MockRandom_0.pos, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _2.fdx, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _1.fdx, _2_Pulsing41_0.pos, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _3.si, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockRandom_0.tip, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _2_MockRandom_0.tim, _1_MockVariableIntBlock_0.pyl, _3.fnm, _2_MockVariableIntBlock_0.doc, _3_MockVariableIntBlock_0.tii, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _1_MockVariableIntBlock_0.doc, _2_MockRandom_0.pyl, _0_MockVariableIntBlock_0.pos, _3_Pulsing41_0.tim, _2_nrm.cfs, _3_Pulsing41_0.tip, _2_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _1_Pulsing41_0.pos, _2.fnm, _3.fdx, _2_MockRandom_0.sd, _2_MockRandom_0.skp, _1.si, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.doc, _3_MockRandom_0.pos, _3_MockVariableIntBlock_0.pos, _2_Pulsing41_0.doc, _3_nrm.cfe, _0_MockVariableIntBlock_0.skp, _1.fnm, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _3_MockVariableIntBlock_0.doc, _1_Pulsing41_0.doc, _3_MockRandom_0.tib, _3_Pulsing41_0.pos, _3_nrm.cfs, _0_MockRandom_0.doc, _0_MockRandom_0.pos, _3_MockRandom_0.tiv, _3_MockVariableIntBlock_0.tib, _1_MockRandom_0.frq, _3_MockRandom_0.doc, _2_MockVariableIntBlock_0.frq, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _1_nrm.cfs, _1_MockRandom_0.skp, _0_nrm.cfs, _1_nrm.cfe, _3_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.tip, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _1_MockRandom_0.pyl, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, segments_5, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, _3_MockVariableIntBlock_0.skp, _0.fdt]
[junit4:junit4]   2> 16432 T53 C1 oasc.SolrDeletionPolicy.updateCommits newest commit = 5[_3_MockVariableIntBlock_0.frq, _3.fdt, _1_MockRandom_0.pos, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _2.fdx, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _1.fdx, _2_Pulsing41_0.pos, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _3.si, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockRandom_0.tip, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _2_MockRandom_0.tim, _1_MockVariableIntBlock_0.pyl, _3.fnm, _2_MockVariableIntBlock_0.doc, _3_MockVariableIntBlock_0.tii, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _1_MockVariableIntBlock_0.doc, _2_MockRandom_0.pyl, _0_MockVariableIntBlock_0.pos, _3_Pulsing41_0.tim, _2_nrm.cfs, _3_Pulsing41_0.tip, _2_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _1_Pulsing41_0.pos, _2.fnm, _3.fdx, _2_MockRandom_0.sd, _2_MockRandom_0.skp, _1.si, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.doc, _3_MockRandom_0.pos, _3_MockVariableIntBlock_0.pos, _2_Pulsing41_0.doc, _3_nrm.cfe, _0_MockVariableIntBlock_0.skp, _1.fnm, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _3_MockVariableIntBlock_0.doc, _1_Pulsing41_0.doc, _3_MockRandom_0.tib, _3_Pulsing41_0.pos, _3_nrm.cfs, _0_MockRandom_0.doc, _0_MockRandom_0.pos, _3_MockRandom_0.tiv, _3_MockVariableIntBlock_0.tib, _1_MockRandom_0.frq, _3_MockRandom_0.doc, _2_MockVariableIntBlock_0.frq, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _1_nrm.cfs, _1_MockRandom_0.skp, _0_nrm.cfs, _1_nrm.cfe, _3_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.tip, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _1_MockRandom_0.pyl, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, segments_5, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, _3_MockVariableIntBlock_0.skp, _0.fdt]
[junit4:junit4]   2> 16433 T53 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 16439 T53 C1 oass.SolrIndexSearcher.<init> Opening Searcher@6629a046 main
[junit4:junit4]   2> 16440 T56 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6629a046 main{StandardDirectoryReader(segments_5:9 _0(5.0):C1 _1(5.0):C1 _2(5.0):C8 _3(5.0):C95)}
[junit4:junit4]   2> 16441 T56 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index
[junit4:junit4]   2> 16441 T53 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 16441 T53 C1 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 92
[junit4:junit4]   2> 16711 T41 C0 REQ [collection1] webapp=/solr path=/select params={sort=_version_+desc&wt=javabin&q=*:*&version=2} hits=105 status=0 QTime=267 
[junit4:junit4]   2> 16718 T54 C1 REQ [collection1] webapp=/solr path=/select params={sort=_version_+desc&wt=javabin&q=*:*&version=2} hits=105 status=0 QTime=2 
[junit4:junit4]   2> 16726 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 16731 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16774 T40 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 16979 T40 C0 oass.SolrIndexSearcher.<init> Opening Searcher@74b65a68 realtime
[junit4:junit4]   2> 16980 T40 C0 REQ [collection1] webapp=/solr path=/update params={_version_=-1003&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=246 
[junit4:junit4]   2> 16987 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16992 T41 C0 REQ [collection1] webapp=/solr path=/update params={_version_=-1005&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 16995 T53 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= START replicas=[127.0.0.1:40580/solr] nUpdates=100
[junit4:junit4]   2> 17002 T40 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=4 
[junit4:junit4]   2> 17003 T53 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Received 100 versions from 127.0.0.1:40580/solr
[junit4:junit4]   2> 17003 T53 C1 oasu.PeerSync.requestUpdates PeerSync: core=collection1 url= Requesting updates from 127.0.0.1:40580/solrn=5 versions=[-1005, 1004, -1003, 1002, 1001]
[junit4:junit4]   2> 17007 T39 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&getUpdates=-1005,1004,-1003,1002,1001&qt=/get&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 17011 T53 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 17035 T53 C1 oass.SolrIndexSearcher.<init> Opening Searcher@1e79edfe realtime
[junit4:junit4]   2> 17038 T53 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4:junit4]   2> 17038 T53 C1 REQ [collection1] webapp=/solr path=/get params={qt=/get&wt=javabin&sync=127.0.0.1:40580/solr&version=2&getVersions=100} status=0 QTime=43 
[junit4:junit4]   2> 17041 T41 C0 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 17051 T41 C0 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_5,generation=5,filenames=[_3_nrm.cfe, _2_Pulsing41_0.doc, _3_MockVariableIntBlock_0.frq, _3.fdt, _0_MockVariableIntBlock_0.skp, _1.fnm, _1_MockRandom_0.pos, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _3_MockVariableIntBlock_0.doc, _2.fdt, _1_MockRandom_0.tim, _1_MockRandom_0.sd, _1_Pulsing41_0.doc, _2.fdx, _1_MockVariableIntBlock_0.tib, _3_Pulsing41_0.pos, _3_nrm.cfs, _2_Pulsing41_0.pos, _1.fdx, _3_MockRandom_0.tip, _1_Pulsing41_0.tip, _1.fdt, _3_MockRandom_0.tim, _0_MockRandom_0.doc, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _0_MockRandom_0.pos, _3_MockVariableIntBlock_0.tib, _3.si, _1_MockRandom_0.doc, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _3_MockRandom_0.doc, _1_MockVariableIntBlock_0.pyl, _2_MockVariableIntBlock_0.frq, _3.fnm, _3_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.doc, _2_MockRandom_0.tiv, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pyl, _1_MockVariableIntBlock_0.doc, _3_Pulsing41_0.tim, _0_MockVariableIntBlock_0.pos, _2_MockRandom_0.pos, _2_MockRandom_0.tib, _3_Pulsing41_0.tip, _2_nrm.cfs, _0.si, _0_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tii, _1_nrm.cfs, _0_MockRandom_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _0_nrm.cfs, _1_Pulsing41_0.pos, _3_MockRandom_0.sd, _2.fnm, _1_nrm.cfe, _3.fdx, _2_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _0_MockRandom_0.tiv, _2_MockRandom_0.skp, _1.si, _0_nrm.cfe, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.frq, _0.fdx, segments_5, _3_MockVariableIntBlock_0.skp, _3_MockRandom_0.pos, _2_MockRandom_0.doc, _0.fdt, _3_MockVariableIntBlock_0.pos]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_6,generation=6,filenames=[_5_nrm.cfe, _3_MockVariableIntBlock_0.frq, _3.fdt, _1_MockRandom_0.pos, _5_MockVariableIntBlock_0.tii, _5_MockRandom_0.pyl, _5_MockRandom_0.pos, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _2.fdx, _1_MockVariableIntBlock_0.tib, _1.fdx, _2_Pulsing41_0.pos, _1_Pulsing41_0.tip, _5_nrm.cfs, _1.fdt, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _3.si, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _2.si, _1_MockVariableIntBlock_0.skp, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _3.fnm, _2_MockRandom_0.tiv, _2_MockVariableIntBlock_0.doc, _3_MockVariableIntBlock_0.tii, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _1_MockVariableIntBlock_0.doc, _2_MockRandom_0.pyl, _0_MockVariableIntBlock_0.pos, _3_Pulsing41_0.tim, _2_MockRandom_0.tib, _2_nrm.cfs, _3_Pulsing41_0.tip, _5_MockRandom_0.doc, _2_MockVariableIntBlock_0.tii, _5_MockVariableIntBlock_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _5_MockRandom_0.skp, _1_Pulsing41_0.pos, _5_MockVariableIntBlock_0.frq, _2.fnm, _3.fdx, _2_MockRandom_0.sd, _5_Pulsing41_0.tim, _5_Pulsing41_0.pos, _2_MockRandom_0.skp, _1.si, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.doc, _3_MockRandom_0.pos, _5_Pulsing41_0.tip, _3_MockVariableIntBlock_0.pos, _2_Pulsing41_0.doc, _3_nrm.cfe, _5.fdt, _5_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.skp, _1.fnm, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _5_MockRandom_0.sd, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _5_MockVariableIntBlock_0.pos, _0.fnm, _3_MockVariableIntBlock_0.doc, _1_Pulsing41_0.doc, _5.si, _3_Pulsing41_0.pos, _3_nrm.cfs, _3_MockRandom_0.tip, _0_MockRandom_0.doc, _3_MockRandom_0.tim, _0_MockRandom_0.pos, _3_MockVariableIntBlock_0.tib, _5_MockRandom_0.frq, _5_MockVariableIntBlock_0.doc, _3_MockRandom_0.doc, _2_MockVariableIntBlock_0.frq, _5_MockRandom_0.tip, _5_MockRandom_0.tim, _0_MockVariableIntBlock_0.tib, _5_MockVariableIntBlock_0.skp, _2_MockRandom_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _0_MockRandom_0.tib, _1_nrm.cfs, _5.fnm, _0_nrm.cfs, _1_nrm.cfe, _3_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _0_MockRandom_0.tiv, _0_nrm.cfe, _5.fdx, _2_MockRandom_0.frq, _0.fdx, _5_Pulsing41_0.doc, segments_6, _3_MockVariableIntBlock_0.skp, _0.fdt]
[junit4:junit4]   2> 17052 T41 C0 oasc.SolrDeletionPolicy.updateCommits newest commit = 6[_5_nrm.cfe, _3_MockVariableIntBlock_0.frq, _3.fdt, _1_MockRandom_0.pos, _5_MockVariableIntBlock_0.tii, _5_MockRandom_0.pyl, _5_MockRandom_0.pos, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _2.fdx, _1_MockVariableIntBlock_0.tib, _1.fdx, _2_Pulsing41_0.pos, _1_Pulsing41_0.tip, _5_nrm.cfs, _1.fdt, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _3.si, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _2.si, _1_MockVariableIntBlock_0.skp, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _3.fnm, _2_MockRandom_0.tiv, _2_MockVariableIntBlock_0.doc, _3_MockVariableIntBlock_0.tii, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _1_MockVariableIntBlock_0.doc, _2_MockRandom_0.pyl, _0_MockVariableIntBlock_0.pos, _3_Pulsing41_0.tim, _2_MockRandom_0.tib, _2_nrm.cfs, _3_Pulsing41_0.tip, _5_MockRandom_0.doc, _2_MockVariableIntBlock_0.tii, _5_MockVariableIntBlock_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _5_MockRandom_0.skp, _1_Pulsing41_0.pos, _5_MockVariableIntBlock_0.frq, _2.fnm, _3.fdx, _2_MockRandom_0.sd, _5_Pulsing41_0.tim, _5_Pulsing41_0.pos, _2_MockRandom_0.skp, _1.si, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.doc, _3_MockRandom_0.pos, _5_Pulsing41_0.tip, _3_MockVariableIntBlock_0.pos, _2_Pulsing41_0.doc, _3_nrm.cfe, _5.fdt, _5_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.skp, _1.fnm, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _5_MockRandom_0.sd, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _5_MockVariableIntBlock_0.pos, _0.fnm, _3_MockVariableIntBlock_0.doc, _1_Pulsing41_0.doc, _5.si, _3_Pulsing41_0.pos, _3_nrm.cfs, _3_MockRandom_0.tip, _0_MockRandom_0.doc, _3_MockRandom_0.tim, _0_MockRandom_0.pos, _3_MockVariableIntBlock_0.tib, _5_MockRandom_0.frq, _5_MockVariableIntBlock_0.doc, _3_MockRandom_0.doc, _2_MockVariableIntBlock_0.frq, _5_MockRandom_0.tip, _5_MockRandom_0.tim, _0_MockVariableIntBlock_0.tib, _5_MockVariableIntBlock_0.skp, _2_MockRandom_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _0_MockRandom_0.tib, _1_nrm.cfs, _5.fnm, _0_nrm.cfs, _1_nrm.cfe, _3_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_Pulsing41_0.pos, _0_Pulsing41_0.doc, _0_MockRandom_0.sd, _0_MockRandom_0.tiv, _0_nrm.cfe, _5.fdx, _2_MockRandom_0.frq, _0.fdx, _5_Pulsing41_0.doc, segments_6, _3_MockVariableIntBlock_0.skp, _0.fdt]
[junit4:junit4]   2> 17053 T41 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 17056 T41 C0 oass.SolrIndexSearcher.<init> Opening Searcher@4bb8d481 main
[junit4:junit4]   2> 17058 T41 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index
[junit4:junit4]   2> 17058 T42 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4bb8d481 main{StandardDirectoryReader(segments_6:16:nrt _0(5.0):C1 _1(5.0):C1 _2(5.0):C8 _3(5.0):C95 _5(5.0):C1)}
[junit4:junit4]   2> 17058 T41 C0 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 17062 T42 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data/index
[junit4:junit4]   2> 17062 T41 C0 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 21
[junit4:junit4]   2> 17065 T54 C1 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 17074 T54 C1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_5,generation=5,filenames=[_3_MockVariableIntBlock_0.frq, _3.fdt, _1_MockRandom_0.pos, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _2.fdx, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _1.fdx, _2_Pulsing41_0.pos, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _1.fdt, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _3.si, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockRandom_0.tip, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _2_MockRandom_0.tim, _1_MockVariableIntBlock_0.pyl, _3.fnm, _2_MockVariableIntBlock_0.doc, _3_MockVariableIntBlock_0.tii, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _1_MockVariableIntBlock_0.doc, _2_MockRandom_0.pyl, _0_MockVariableIntBlock_0.pos, _3_Pulsing41_0.tim, _2_nrm.cfs, _3_Pulsing41_0.tip, _2_MockVariableIntBlock_0.tii, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _1_Pulsing41_0.pos, _2.fnm, _3.fdx, _2_MockRandom_0.sd, _2_MockRandom_0.skp, _1.si, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.doc, _3_MockRandom_0.pos, _3_MockVariableIntBlock_0.pos, _2_Pulsing41_0.doc, _3_nrm.cfe, _0_MockVariableIntBlock_0.skp, _1.fnm, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _0.fnm, _3_MockVariableIntBlock_0.doc, _1_Pulsing41_0.doc, _3_MockRandom_0.tib, _3_Pulsing41_0.pos, _3_nrm.cfs, _0_MockRandom_0.doc, _0_MockRandom_0.pos, _3_MockRandom_0.tiv, _3_MockVariableIntBlock_0.tib, _1_MockRandom_0.frq, _3_MockRandom_0.doc, _2_MockVariableIntBlock_0.frq, _0_MockVariableIntBlock_0.tib, _2_MockRandom_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _1_nrm.cfs, _1_MockRandom_0.skp, _0_nrm.cfs, _1_nrm.cfe, _3_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.tip, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _1_MockRandom_0.pyl, _0_nrm.cfe, _2_MockRandom_0.frq, _0.fdx, segments_5, _0_MockRandom_0.pyl, _0_MockRandom_0.tim, _3_MockVariableIntBlock_0.skp, _0.fdt]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@14cee41f lockFactory=org.apache.lucene.store.NativeFSLockFactory@1b1a772d),segFN=segments_6,generation=6,filenames=[_5_nrm.cfe, _3_MockVariableIntBlock_0.frq, _3.fdt, _1_MockRandom_0.pos, _5_MockVariableIntBlock_0.tii, _5_MockRandom_0.pyl, _5_MockRandom_0.pos, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _2.fdx, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _1.fdx, _2_Pulsing41_0.pos, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _5_nrm.cfs, _1.fdt, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _3.si, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockRandom_0.tip, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _2_MockRandom_0.tim, _1_MockVariableIntBlock_0.pyl, _3.fnm, _2_MockVariableIntBlock_0.doc, _3_MockVariableIntBlock_0.tii, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _1_MockVariableIntBlock_0.doc, _2_MockRandom_0.pyl, _0_MockVariableIntBlock_0.pos, _3_Pulsing41_0.tim, _2_nrm.cfs, _3_Pulsing41_0.tip, _5_MockRandom_0.doc, _2_MockVariableIntBlock_0.tii, _5_MockVariableIntBlock_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _5_MockRandom_0.skp, _1_Pulsing41_0.pos, _5_MockVariableIntBlock_0.frq, _2.fnm, _3.fdx, _2_MockRandom_0.sd, _5_Pulsing41_0.tim, _5_Pulsing41_0.pos, _2_MockRandom_0.skp, _1.si, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.doc, _3_MockRandom_0.pos, _5_Pulsing41_0.tip, _3_MockVariableIntBlock_0.pos, _2_Pulsing41_0.doc, _3_nrm.cfe, _5.fdt, _5_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.skp, _1.fnm, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _5_MockRandom_0.sd, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _5_MockVariableIntBlock_0.pos, _0.fnm, _3_MockVariableIntBlock_0.doc, _1_Pulsing41_0.doc, _3_MockRandom_0.tib, _5.si, _3_Pulsing41_0.pos, _3_nrm.cfs, _0_MockRandom_0.doc, _0_MockRandom_0.pos, _3_MockRandom_0.tiv, _3_MockVariableIntBlock_0.tib, _1_MockRandom_0.frq, _5_MockVariableIntBlock_0.doc, _5_MockRandom_0.frq, _3_MockRandom_0.doc, _2_MockVariableIntBlock_0.frq, _5_MockRandom_0.tip, _5_MockRandom_0.tim, _0_MockVariableIntBlock_0.tib, _5_MockVariableIntBlock_0.skp, _2_MockRandom_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _1_nrm.cfs, _5.fnm, _1_MockRandom_0.skp, _0_nrm.cfs, _1_nrm.cfe, _3_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.tip, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _1_MockRandom_0.pyl, _0_nrm.cfe, _5.fdx, _2_MockRandom_0.frq, _0.fdx, _5_Pulsing41_0.doc, _0_MockRandom_0.pyl, segments_6, _0_MockRandom_0.tim, _3_MockVariableIntBlock_0.skp, _0.fdt]
[junit4:junit4]   2> 17075 T54 C1 oasc.SolrDeletionPolicy.updateCommits newest commit = 6[_5_nrm.cfe, _3_MockVariableIntBlock_0.frq, _3.fdt, _1_MockRandom_0.pos, _5_MockVariableIntBlock_0.tii, _5_MockRandom_0.pyl, _5_MockRandom_0.pos, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _2.fdx, _0_MockRandom_0.skp, _1_MockVariableIntBlock_0.tib, _1.fdx, _2_Pulsing41_0.pos, _0_MockRandom_0.frq, _1_Pulsing41_0.tip, _5_nrm.cfs, _1.fdt, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _3.si, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _1_MockVariableIntBlock_0.skp, _2.si, _2_MockRandom_0.tip, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _2_MockRandom_0.tim, _1_MockVariableIntBlock_0.pyl, _3.fnm, _2_MockVariableIntBlock_0.doc, _3_MockVariableIntBlock_0.tii, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _1_MockVariableIntBlock_0.doc, _2_MockRandom_0.pyl, _0_MockVariableIntBlock_0.pos, _3_Pulsing41_0.tim, _2_nrm.cfs, _3_Pulsing41_0.tip, _5_MockRandom_0.doc, _2_MockVariableIntBlock_0.tii, _5_MockVariableIntBlock_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _5_MockRandom_0.skp, _1_Pulsing41_0.pos, _5_MockVariableIntBlock_0.frq, _2.fnm, _3.fdx, _2_MockRandom_0.sd, _5_Pulsing41_0.tim, _5_Pulsing41_0.pos, _2_MockRandom_0.skp, _1.si, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.doc, _3_MockRandom_0.pos, _5_Pulsing41_0.tip, _3_MockVariableIntBlock_0.pos, _2_Pulsing41_0.doc, _3_nrm.cfe, _5.fdt, _5_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.skp, _1.fnm, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _5_MockRandom_0.sd, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _5_MockVariableIntBlock_0.pos, _0.fnm, _3_MockVariableIntBlock_0.doc, _1_Pulsing41_0.doc, _3_MockRandom_0.tib, _5.si, _3_Pulsing41_0.pos, _3_nrm.cfs, _0_MockRandom_0.doc, _0_MockRandom_0.pos, _3_MockRandom_0.tiv, _3_MockVariableIntBlock_0.tib, _1_MockRandom_0.frq, _5_MockVariableIntBlock_0.doc, _5_MockRandom_0.frq, _3_MockRandom_0.doc, _2_MockVariableIntBlock_0.frq, _5_MockRandom_0.tip, _5_MockRandom_0.tim, _0_MockVariableIntBlock_0.tib, _5_MockVariableIntBlock_0.skp, _2_MockRandom_0.pos, _0.si, _0_MockVariableIntBlock_0.tii, _1_nrm.cfs, _5.fnm, _1_MockRandom_0.skp, _0_nrm.cfs, _1_nrm.cfe, _3_MockRandom_0.sd, _1_MockVariableIntBlock_0.frq, _0_MockRandom_0.tip, _0_MockRandom_0.sd, _0_Pulsing41_0.doc, _0_Pulsing41_0.pos, _1_MockRandom_0.pyl, _0_nrm.cfe, _5.fdx, _2_MockRandom_0.frq, _0.fdx, _5_Pulsing41_0.doc, _0_MockRandom_0.pyl, segments_6, _0_MockRandom_0.tim, _3_MockVariableIntBlock_0.skp, _0.fdt]
[junit4:junit4]   2> 17076 T54 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 17079 T54 C1 oass.SolrIndexSearcher.<init> Opening Searcher@76f33280 main
[junit4:junit4]   2> 17080 T54 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index
[junit4:junit4]   2> 17081 T56 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@76f33280 main{StandardDirectoryReader(segments_6:16:nrt _0(5.0):C1 _1(5.0):C1 _2(5.0):C8 _3(5.0):C95 _5(5.0):C1)}
[junit4:junit4]   2> 17081 T54 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 17082 T56 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index
[junit4:junit4]   2> 17083 T54 C1 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 18
[junit4:junit4]   2> 17087 T40 C0 REQ [collection1] webapp=/solr path=/select params={sort=_version_+desc&wt=javabin&q=*:*&version=2} hits=106 status=0 QTime=2 
[junit4:junit4]   2> 17094 T55 C1 REQ [collection1] webapp=/solr path=/select params={sort=_version_+desc&wt=javabin&q=*:*&version=2} hits=106 status=0 QTime=3 
[junit4:junit4]   2> 17101 T39 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 17106 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 17110 T40 C0 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard0/data
[junit4:junit4]   2> 17118 T40 C0 oass.SolrIndexSearcher.<init> Opening Searcher@3e55a58f realtime
[junit4:junit4]   2> 17119 T40 C0 REQ [collection1] webapp=/solr path=/update params={_version_=-2003&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=10 
[junit4:junit4]   2> 17124 T41 C0 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 17128 T40 C0 REQ [collection1] webapp=/solr path=/update params={_version_=-2005&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 17132 T55 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 17136 T54 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 17142 T54 C1 oass.SolrIndexSearcher.<init> Opening Searcher@7a14b43d realtime
[junit4:junit4]   2> 17143 T54 C1 REQ [collection1] webapp=/solr path=/update params={_version_=-2003&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 17148 T53 C1 REQ [collection1] webapp=/solr path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 17151 T55 C1 REQ [collection1] webapp=/solr path=/update params={_version_=-2005&update.distrib=FROMLEADER&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 17153 T54 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= START replicas=[127.0.0.1:40580/solr] nUpdates=100
[junit4:junit4]   2> 17158 T39 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&qt=/get&wt=javabin&version=2&getVersions=100} status=0 QTime=1 
[junit4:junit4]   2> 17159 T54 C1 oasu.PeerSync.handleVersions PeerSync: core=collection1 url=  Received 100 versions from 127.0.0.1:40580/solr
[junit4:junit4]   2> 17161 T54 C1 oasu.PeerSync.requestUpdates PeerSync: core=collection1 url= Requesting updates from 127.0.0.1:40580/solrn=1 versions=[2002]
[junit4:junit4]   2> 17165 T40 C0 REQ [collection1] webapp=/solr path=/get params={distrib=false&getUpdates=2002&qt=/get&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 17167 T54 C1 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected.  Update=add{flags=12,_version_=2002,id=2001} DBQs=[DBQ{version=2003,q=id:2001 OR id:2002}]
[junit4:junit4]   2> 17171 T54 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 17187 T54 C1 oass.SolrIndexSearcher.<init> Opening Searcher@15dbac11 realtime
[junit4:junit4]   2> 17188 T54 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data/index
[junit4:junit4]   2> 17190 T54 C1 oasc.CachingDirectoryFactory.close Releasing directory:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/./org.apache.solr.update.PeerSyncTest-1352387584657/shard1/data
[junit4:junit4]   2> 17198 T54 C1 oasu.PeerSync.sync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4:junit4]   2> 17198 T54 C1 REQ [collection1] webapp=/solr path=/get params={qt=/get&wt=javabin&sync=127.0.0.1:40580/solr&version=2&getVersions=100} status=0 QTime=45 
[junit4:junit4]   2> 17203 T41 C0 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 17222 T41 C0 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@1f48e23b lockFactory=org.apache.lucene.store.NativeFSLockFactory@484dd014),segFN=segments_6,generation=6,filenames=[_5_nrm.cfe, _3_MockVariableIntBlock_0.frq, _3.fdt, _1_MockRandom_0.pos, _5_MockVariableIntBlock_0.tii, _5_MockRandom_0.pyl, _5_MockRandom_0.pos, _1_MockVariableIntBlock_0.tii, _1_MockRandom_0.tip, _2.fdt, _1_MockRandom_0.sd, _1_MockRandom_0.tim, _2.fdx, _1_MockVariableIntBlock_0.tib, _1.fdx, _2_Pulsing41_0.pos, _1_Pulsing41_0.tip, _5_nrm.cfs, _1.fdt, _1_Pulsing41_0.tim, _0_MockVariableIntBlock_0.frq, _1_MockRandom_0.doc, _3.si, _2_MockVariableIntBlock_0.skp, _3_Pulsing41_0.doc, _2.si, _1_MockVariableIntBlock_0.skp, _2_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.doc, _1_MockVariableIntBlock_0.pyl, _3.fnm, _2_MockRandom_0.tiv, _2_MockVariableIntBlock_0.doc, _3_MockVariableIntBlock_0.tii, _0_MockVariableIntBlock_0.pyl, _2_nrm.cfe, _1_MockVariableIntBlock_0.doc, _2_MockRandom_0.pyl, _0_MockVariableIntBlock_0.pos, _3_Pulsing41_0.tim, _2_MockRandom_0.tib, _2_nrm.cfs, _3_Pulsing41_0.tip, _5_MockRandom_0.doc, _2_MockVariableIntBlock_0.tii, _5_MockVariableIntBlock_0.tib, _2_MockVariableIntBlock_0.tib, _1_MockVariableIntBlock_0.pos, _5_MockRandom_0.skp, _1_Pulsing41_0.pos, _5_MockVariableIntBlock_0.frq, _2.fnm, _3.fdx, _2_MockRandom_0.sd, _5_Pulsing41_0.tim, _5_Pulsing41_0.pos, _2_MockRandom_0.skp, _1.si, _3_MockVariableIntBlock_0.pyl, _2_MockRandom_0.doc, _3_MockRandom_0.pos, _5_Pulsing41_0.tip, _3_MockVariableIntBlock_0.pos, _2_Pulsing41_0.doc, _3_nrm.cfe, _5.fdt, _5_MockVariableIntBlock_0.pyl, _0_MockVariableIntBlock_0.skp, _1.fnm, _2_Pulsing41_0.tim, _0_Pulsing41_0.tim, _0_Pulsing41_0.tip, _5_MockRandom_0.sd, _2_Pulsing41_0.tip, _2_MockVariableIntBlock_0.pos, _5_MockVariableIntBlock_0.pos, _0.fnm, _3_MockVariableIntBlock_0.doc, _1_Pulsing41_0.doc, _5.si, _3_Pulsing41_0.pos, _3_nrm.cfs, _3_MockRandom_0.tip, _0_MockRandom_0.doc, _3_MockRandom_0.tim, _0_MockRandom_0.pos, _3_MockVa

[...truncated too long message...]

ool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40, sim=DefaultSimilarity, locale=es_CR, timezone=PST8PDT
[junit4:junit4]   2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=5,free=221861584,total=421920768
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestSolrIndexConfig, TestQueryTypes, SuggesterFSTTest, ScriptEngineTest, TestIndexSearcher, PreAnalyzedFieldTest, TestFastLRUCache, TestJmxMonitoredMap, TestFiltering, TestNumberUtils, SpellCheckCollatorTest, TestCollationField, SearchHandlerTest, TestCharFilters, TestRangeQuery, TestLFUCache, FieldAnalysisRequestHandlerTest, TestXIncludeConfig, SortByFunctionTest, TestDefaultSimilarityFactory, IndexBasedSpellCheckerTest, TestSearchPerf, CoreAdminHandlerTest, TestPerFieldSimilarity, TestQuerySenderNoQuery, BadComponentTest, TestGroupingSearch, BinaryUpdateRequestHandlerTest, TestSuggestSpellingConverter, WordBreakSolrSpellCheckerTest, DateMathParserTest, AnalysisAfterCoreReloadTest, SimplePostToolTest, AutoCommitTest, CurrencyFieldTest, NoCacheHeaderTest]
[junit4:junit4]   2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=NoCacheHeaderTest -Dtests.seed=6DF939765EEC1D89 -Dtests.multiplier=3 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/hudson/lucene-data/enwiki.random.lines.txt -Dtests.locale=es_CR -Dtests.timezone=PST8PDT -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR   0.00s J0 | NoCacheHeaderTest (suite) <<<
[junit4:junit4]    > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.solr.servlet.NoCacheHeaderTest: 
[junit4:junit4]    >    1) Thread[id=206, name=qtp1114673702-206 Acceptor2 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]    >    2) Thread[id=205, name=qtp1114673702-205 Acceptor1 SelectChannelConnector@0.0.0.0:24833, state=RUNNABLE, group=TGRP-NoCacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]    >    3) Thread[id=204, name=qtp1114673702-204 Acceptor0 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]    >    4) Thread[id=207, name=qtp1114673702-207 Acceptor3 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([6DF939765EEC1D89]:0)
[junit4:junit4]    > Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4:junit4]    >    1) Thread[id=206, name=qtp1114673702-206 Acceptor2 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]    >    2) Thread[id=205, name=qtp1114673702-205 Acceptor1 SelectChannelConnector@0.0.0.0:24833, state=RUNNABLE, group=TGRP-NoCacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:163)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]    >    3) Thread[id=204, name=qtp1114673702-204 Acceptor0 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]    >    4) Thread[id=207, name=qtp1114673702-207 Acceptor3 SelectChannelConnector@0.0.0.0:24833, state=BLOCKED, group=TGRP-NoCacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:147)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:109)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:938)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:679)
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([6DF939765EEC1D89]:0)
[junit4:junit4] Completed on J0 in 25.94s, 3 tests, 2 errors <<< FAILURES!

[...truncated 68 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:335: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:39: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:178: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/module-build.xml:61: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1163: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:827: There were test failures: 233 suites, 970 tests, 4 suite-level errors, 760 ignored

Total time: 68 minutes 1 second
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message