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-Tests-4.x-java7 - Build # 595 - Still Failing
Date Mon, 29 Oct 2012 09:51:43 GMT
Build: https://builds.apache.org/job/Lucene-Solr-Tests-4.x-java7/595/

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

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
	at __randomizedtesting.SeedInfo.seed([7F117478B74F5027]:0)


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

Error Message:
4 threads leaked from SUITE scope at org.apache.solr.servlet.CacheHeaderTest:     1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)         at java.lang.Thread.run(Thread.java:722)    2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)         at java.lang.Thread.run(Thread.java:722)    3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)         at java.lang.Thread.run(Thread.java:722)    4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)         at java.lang.Thread.run(Thread.java:722)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.solr.servlet.CacheHeaderTest: 
   1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
        at java.lang.Thread.run(Thread.java:722)
   2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
        at java.lang.Thread.run(Thread.java:722)
   3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
        at java.lang.Thread.run(Thread.java:722)
   4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
        at java.lang.Thread.run(Thread.java:722)
	at __randomizedtesting.SeedInfo.seed([7F117478B74F5027]:0)


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

Error Message:
There are still zombie threads that couldn't be terminated:    1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)         at java.lang.Thread.run(Thread.java:722)    2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)         at java.lang.Thread.run(Thread.java:722)    3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)         at java.lang.Thread.run(Thread.java:722)    4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)         at java.lang.Thread.run(Thread.java:722)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
   1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
        at java.lang.Thread.run(Thread.java:722)
   2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
        at java.lang.Thread.run(Thread.java:722)
   3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
        at java.lang.Thread.run(Thread.java:722)
   4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
        at java.lang.Thread.run(Thread.java:722)
	at __randomizedtesting.SeedInfo.seed([7F117478B74F5027]:0)


FAILED:  org.apache.solr.TestDistributedSearch.testDistribSearch

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
	at __randomizedtesting.SeedInfo.seed([7F117478B74F5027]:0)




Build Log:
[...truncated 8372 lines...]
[junit4:junit4] Suite: org.apache.solr.servlet.CacheHeaderTest
[junit4:junit4]   2> 0 T160 oas.SolrTestCaseJ4.initCore ####initCore
[junit4:junit4]   2> Creating dataDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/./solrtest-CacheHeaderTest-1351497095869
[junit4:junit4]   2> 2 T160 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4:junit4]   2> 574 T160 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 893 T160 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:16931
[junit4:junit4]   2> 928 T160 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 928 T160 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: solr/
[junit4:junit4]   2> 928 T160 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: 'solr/'
[junit4:junit4]   2> 964 T160 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 964 T160 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 964 T160 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: solr/
[junit4:junit4]   2> 965 T160 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/solr/solr.xml
[junit4:junit4]   2> 965 T160 oasc.CoreContainer.<init> New CoreContainer 941171247
[junit4:junit4]   2> 965 T160 oasc.CoreContainer$Initializer.initialize no solr.xml file found - using default
[junit4:junit4]   2> 966 T160 oasc.CoreContainer.load Loading CoreContainer using Solr Home: 'solr/'
[junit4:junit4]   2> 966 T160 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'solr/'
[junit4:junit4]   2> 1012 T160 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 1057 T160 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: solr/collection1
[junit4:junit4]   2> 1057 T160 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'solr/collection1/'
[junit4:junit4]   2> 1122 T160 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 1172 T160 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1175 T160 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1192 T160 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1646 T160 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1657 T160 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1660 T160 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1689 T160 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1711 T160 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1715 T160 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1719 T160 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1720 T160 oasc.SolrCore.<init> [collection1] Opening new SolrCore at solr/collection1/, dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/solrtest-CacheHeaderTest-1351497095869/
[junit4:junit4]   2> 1721 T160 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@244112c0
[junit4:junit4]   2> 1722 T160 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/solrtest-CacheHeaderTest-1351497095869/index/
[junit4:junit4]   2> 1722 T160 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/solrtest-CacheHeaderTest-1351497095869/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1723 T160 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/solrtest-CacheHeaderTest-1351497095869/index forceNew:false
[junit4:junit4]   2> 1724 T160 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@66b6e0d3 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4efe39c9),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1725 T160 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 1725 T160 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1727 T160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1728 T160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1728 T160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1728 T160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1729 T160 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1730 T160 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1730 T160 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1731 T160 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1731 T160 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1732 T160 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1732 T160 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1733 T160 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1733 T160 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1734 T160 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1734 T160 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1735 T160 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1735 T160 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1736 T160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1736 T160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1737 T160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1737 T160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1738 T160 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1738 T160 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1739 T160 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1739 T160 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1748 T160 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1751 T160 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1753 T160 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: []
[junit4:junit4]   2> 1756 T160 oass.SolrIndexSearcher.<init> Opening Searcher@69f669c0 main
[junit4:junit4]   2> 1756 T160 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 1757 T160 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1757 T160 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1758 T160 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1765 T160 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1824 T160 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 1825 T160 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 1825 T160 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 1825 T160 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 1826 T160 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 1826 T160 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 1826 T160 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 1827 T160 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 1827 T160 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 1828 T160 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 1854 T174 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@69f669c0 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1864 T160 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 1865 T160 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0
[junit4:junit4]   2> 1865 T160 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 1866 T160 oas.SolrJettyTestBase.createJetty Jetty Assigned Port#16931
[junit4:junit4]   2> 1876 T160 oas.SolrTestCaseJ4.setUp ###Starting testCacheControl
[junit4:junit4]   2> 1909 T160 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C4 name=collection1 org.apache.solr.core.SolrCore@5e4680df
[junit4:junit4]   2> 3172 T175 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=68 
[junit4:junit4]   2> 3320 T173 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3333 T172 C4 REQ [collection1] webapp=/solr path=/select params={q=solr&qt=standard} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3335 T160 oas.SolrTestCaseJ4.tearDown ###Ending testCacheControl
[junit4:junit4]   2> 3343 T160 oas.SolrTestCaseJ4.setUp ###Starting testLastModified
[junit4:junit4]   2> 3348 T175 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3390 T175 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3404 T172 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3409 T175 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3418 T175 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3427 T172 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3428 T160 oas.SolrTestCaseJ4.tearDown ###Ending testLastModified
[junit4:junit4]   2> 3436 T160 oas.SolrTestCaseJ4.setUp ###Starting testCacheVetoHandler
[junit4:junit4]   2> 3555 T175 C4 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@66b6e0d3 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4efe39c9),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3555 T175 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 3562 T175 C4 UPDATE [collection1] webapp=/solr path=/update params={stream.contentType=text/csv&stream.file=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J0/cachetest_csv3042430424tmp} {add=[100, 101, 102]} 0 101
[junit4:junit4]   2> 3570 T160 oas.SolrTestCaseJ4.tearDown ###Ending testCacheVetoHandler
[junit4:junit4]   2> 3578 T160 oas.SolrTestCaseJ4.setUp ###Starting testCacheVetoException
[junit4:junit4]   2> 3582 T173 C4 oasc.SolrException.log Ignoring exception matching ignore_exception
[junit4:junit4]   2> 3582 T173 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=xyz_ignore_exception:solr} status=400 QTime=2 
[junit4:junit4]   2> 3583 T160 oas.SolrTestCaseJ4.tearDown ###Ending testCacheVetoException
[junit4:junit4]   2> 3591 T160 oas.SolrTestCaseJ4.setUp ###Starting testEtag
[junit4:junit4]   2> 3593 T175 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3602 T173 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=5 
[junit4:junit4]   2> 3615 T173 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3621 T172 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3625 T175 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3629 T173 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3641 T173 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3645 T172 C4 REQ [collection1] webapp=/solr path=/select params={qt=standard&q=solr} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 3646 T160 oas.SolrTestCaseJ4.tearDown ###Ending testEtag
[junit4:junit4]   2> 3693 T160 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=941171247
[junit4:junit4]   2> 3694 T160 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@5e4680df
[junit4:junit4]   2> 3714 T160 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=3,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4:junit4]   2> 3715 T160 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 3715 T160 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 3715 T160 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 3720 T160 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@66b6e0d3 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4efe39c9),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@66b6e0d3 lockFactory=org.apache.lucene.store.NativeFSLockFactory@4efe39c9),segFN=segments_2,generation=2,filenames=[_0.fnm, _0_Lucene41_0.doc, _0_Lucene41_0.pos, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4]   2> 3720 T160 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 3722 T160 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 3778 T160 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   2> 3880 T160 oejut.QueuedThreadPool.doStop WARNING 4 threads could not be stopped
[junit4:junit4]   2> 3880 T160 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> 3950 T159 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 4 leaked thread(s).
[junit4:junit4]   2> 24185 T159 ccr.ThreadLeakControl.checkThreadLeaks SEVERE 4 threads leaked from SUITE scope at org.apache.solr.servlet.CacheHeaderTest: 
[junit4:junit4]   2> 	   1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	   2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	   3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	   4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 24186 T159 ccr.ThreadLeakControl.tryToInterruptAll Starting to interrupt leaked threads:
[junit4:junit4]   2> 	   1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	   2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	   3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	   4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 27230 T159 ccr.ThreadLeakControl.tryToInterruptAll SEVERE There are still zombie threads that couldn't be terminated:
[junit4:junit4]   2> 	   1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	   2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	   3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	   4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> NOTE: test params are: codec=Compressing(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=285, storedFieldsIndex=DISK_DOC)), sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=mk_MK, timezone=America/Virgin
[junit4:junit4]   2> NOTE: FreeBSD 9.0-RELEASE amd64/Oracle Corporation 1.7.0_06 (64-bit)/cpus=16,threads=5,free=124922488,total=195035136
[junit4:junit4]   2> NOTE: All tests run in this JVM: [PathHierarchyTokenizerFactoryTest, SolrRequestParserTest, HighlighterConfigTest, TestFaceting, TestStressReorder, CacheHeaderTest]
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=CacheHeaderTest -Dtests.seed=7F117478B74F5027 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=mk_MK -Dtests.timezone=America/Virgin -Dtests.file.encoding=ISO-8859-1
[junit4:junit4] ERROR   0.00s J0 | CacheHeaderTest (suite) <<<
[junit4:junit4]    > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 4 threads leaked from SUITE scope at org.apache.solr.servlet.CacheHeaderTest: 
[junit4:junit4]    >    1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    >    2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    >    3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    >    4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([7F117478B74F5027]:0)
[junit4:junit4]    > Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
[junit4:junit4]    >    1) Thread[id=169, name=qtp319385899-169 Acceptor2 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    >    2) Thread[id=170, name=qtp319385899-170 Acceptor3 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    >    3) Thread[id=167, name=qtp319385899-167 Acceptor0 SelectChannelConnector@0.0.0.0:16931, state=RUNNABLE, group=TGRP-CacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    >    4) Thread[id=168, name=qtp319385899-168 Acceptor1 SelectChannelConnector@0.0.0.0:16931, state=BLOCKED, group=TGRP-CacheHeaderTest]
[junit4:junit4]    >         at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]    >         at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]    >         at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]    >         at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]    >         at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([7F117478B74F5027]:0)
[junit4:junit4] Completed on J0 in 27.45s, 5 tests, 2 errors <<< FAILURES!

[...truncated 624 lines...]
[junit4:junit4] Suite: org.apache.solr.TestDistributedSearch
[junit4:junit4]   2> 4 T25 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> 415 T25 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 843 T25 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:47889
[junit4:junit4]   2> 887 T25 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 888 T25 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 889 T25 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 934 T25 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 935 T25 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 935 T25 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 936 T25 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 936 T25 oasc.CoreContainer.<init> New CoreContainer 1433002704
[junit4:junit4]   2> 937 T25 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 937 T25 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 990 T25 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 1053 T25 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 1054 T25 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 1056 T25 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1056 T25 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 1129 T25 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 1195 T25 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1196 T25 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1238 T25 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1944 T25 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1958 T25 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1962 T25 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1976 T25 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1981 T25 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1986 T25 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1988 T25 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1991 T25 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedSearch-1351497068021/control/data/
[junit4:junit4]   2> 1992 T25 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@263c7e3f
[junit4:junit4]   2> 1994 T25 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedSearch-1351497068021/control/data/index/
[junit4:junit4]   2> 1995 T25 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedSearch-1351497068021/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1996 T25 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedSearch-1351497068021/control/data/index forceNew:false
[junit4:junit4]   2> 1999 T25 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@31482ac5 lockFactory=org.apache.lucene.store.NativeFSLockFactory@55ca6626),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2000 T25 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 2001 T25 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2003 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2004 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2004 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2005 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2006 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2006 T25 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2007 T25 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2007 T25 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2008 T25 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2009 T25 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2010 T25 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2011 T25 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2011 T25 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2012 T25 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2012 T25 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2013 T25 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2014 T25 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2015 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2015 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2016 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2017 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2017 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2018 T25 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2019 T25 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2019 T25 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2030 T25 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2038 T25 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2040 T25 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-REQUIRED-FIELDS.XML, SCHEMA-REPLICATION2.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SCHEMA-MINIMAL.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-CACHING.XML, SOLRCONFIG-REPEATER.XML, SOLRCONFIG-MERGEPOLICY.XML, CURRENCY.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-MASTER.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA11.XML, SOLRCONFIG-BASIC.XML, DA_COMPOUNDDICTIONARY.TXT, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-SLAVE.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, ELEVATE.XML, TRIVIAL.UPDATEPROCESSOR0.JS, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SCHEMA-CHARFILTERS.XML, SCHEMA-IB.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, SCHEMA-REPLICATION1.XML, DA_UTF8.XML, CONDITIONAL.UPDATEPROCESSOR.JS, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, HYPHENATION.DTD, SOLRCONFIG-ENABLEPLUGIN.XML, STEMDICT.TXT, SCHEMA-PHRASESUGGEST.XML, HUNSPELL-TEST.AFF, SCHEMA-SNIPPET-TYPE.XML, STOPTYPES-1.TXT, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, SOLRCONFIG-TRANSFORMERS.XML, SOLRCONFIG-PROPINJECT.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-SIMPLELOCK.XML, WDFTYPES.TXT, SCHEMA-REVERSED.XML, STOPTYPES-2.TXT, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-DFR.XML, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, KEEP-1.TXT, SCHEMA-SPATIAL.XML, OPEN-EXCHANGE-RATES.JSON, STOPWITHBOM.TXT, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SCHEMA-XINCLUDE.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-MASTER1.XML, SYNONYMS.TXT, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA_CODEC.XML, SCHEMA.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SOLRCONFIG-FUNCTIONQUERY.XML, STOP-2.TXT, SOLRCONFIG-TERMINDEX.XML, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-ELEVATE.XML, STOPWORDS.TXT, SCHEMA-FOLDING.XML, SCHEMA-STOP-KEEP.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, STOP-1.TXT, SOLRCONFIG-MASTER2.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SOLRCONFIG-LAZYWRITER.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-MP-SOLRCONFIG.XML, FRENCHARTICLES.TXT, SCHEMA15.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMASURROUND.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MASTER3.XML, HUNSPELL-TEST.DIC, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-DELPOLICY1.XML, SOLRCONFIG-SLAVE1.XML, SCHEMA-SIM.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-COLLATE.XML, STOP-SNOWBALL.TXT, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, PROTWORDS.TXT, SCHEMA-TRIE.XML, SOLRCONFIG_CODEC.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, JASUGGEST.TXT, SCHEMA-TFIDF.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-LMJELINEKMERCER.XML, PHRASESUGGEST.TXT, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, OLD_SYNONYMS.TXT, SOLRCONFIG-DELPOLICY2.XML, XSLT, SOLRCONFIG-NATIVELOCK.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-NOCACHE.XML, SCHEMA-BM25.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-ALTDIRECTORY.XML, COMPOUNDDICTIONARY.TXT, SOLRCONFIG-INDEXCONFIG.XML, SOLRCONFIG_PERF.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, KEEP-2.TXT, SCHEMA12.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, MAPPING-ISOLATIN1ACCENT.TXT, BAD_SOLRCONFIG.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML]
[junit4:junit4]   2> 2044 T25 oass.SolrIndexSearcher.<init> Opening Searcher@6db4b903 main
[junit4:junit4]   2> 2045 T25 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 2046 T25 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2046 T25 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2047 T25 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2069 T25 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2122 T25 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 2123 T25 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2123 T25 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 2124 T25 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2124 T25 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2125 T25 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2125 T25 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2126 T25 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2126 T25 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2127 T25 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 2147 T40 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6db4b903 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2154 T25 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 2155 T25 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 2155 T25 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 2213 T25 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 2236 T25 oejs.Server.doStart jetty-8.1.2.v20120308
[junit4:junit4]   2> 2239 T25 oejs.AbstractConnector.doStart Started SelectChannelConnector@0.0.0.0:47891
[junit4:junit4]   2> 2240 T25 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2241 T25 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 2241 T25 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2278 T25 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 2279 T25 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2279 T25 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 2279 T25 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 2280 T25 oasc.CoreContainer.<init> New CoreContainer 151049956
[junit4:junit4]   2> 2281 T25 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2281 T25 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2310 T25 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2330 T25 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 2331 T25 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 2332 T25 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2333 T25 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 2383 T25 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 2454 T25 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2455 T25 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2474 T25 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3051 T25 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 3064 T25 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 3067 T25 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 3081 T25 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3085 T25 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 3090 T25 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3092 T25 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 3094 T25 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedSearch-1351497068021/shard0/data/
[junit4:junit4]   2> 3095 T25 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@263c7e3f
[junit4:junit4]   2> 3096 T25 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedSearch-1351497068021/shard0/data/index/
[junit4:junit4]   2> 3097 T25 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedSearch-1351497068021/shard0/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 3098 T25 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedSearch-1351497068021/shard0/data/index forceNew:false
[junit4:junit4]   2> 3101 T25 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5caed6ca lockFactory=org.apache.lucene.store.NativeFSLockFactory@164ef200),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3102 T25 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 3102 T25 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 3106 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 3106 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 3107 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 3107 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 3108 T25 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 3108 T25 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 3109 T25 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 3110 T25 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 3111 T25 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 3112 T25 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 3112 T25 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 3113 T25 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 3114 T25 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 3114 T25 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 3115 T25 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 3116 T25 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 3117 T25 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3117 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3118 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3119 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3120 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3121 T25 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3121 T25 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 3122 T25 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 3123 T25 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 3133 T25 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 3138 T25 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 3139 T25 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-REQUIRED-FIELDS.XML, SCHEMA-REPLICATION2.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SCHEMA-MINIMAL.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-CACHING.XML, SOLRCONFIG-REPEATER.XML, SOLRCONFIG-MERGEPOLICY.XML, CURRENCY.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-MASTER.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA11.XML, SOLRCONFIG-BASIC.XML, DA_COMPOUNDDICTIONARY.TXT, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-SLAVE.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, ELEVATE.XML, TRIVIAL.UPDATEPROCESSOR0.JS, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SCHEMA-CHARFILTERS.XML, SCHEMA-IB.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, SCHEMA-REPLICATION1.XML, DA_UTF8.XML, CONDITIONAL.UPDATEPROCESSOR.JS, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, HYPHENATION.DTD, SOLRCONFIG-ENABLEPLUGIN.XML, STEMDICT.TXT, SCHEMA-PHRASESUGGEST.XML, HUNSPELL-TEST.AFF, SCHEMA-SNIPPET-TYPE.XML, STOPTYPES-1.TXT, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, SOLRCONFIG-TRANSFORMERS.XML, SOLRCONFIG-PROPINJECT.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-SIMPLELOCK.XML, WDFTYPES.TXT, SCHEMA-REVERSED.XML, STOPTYPES-2.TXT, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-DFR.XML, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, KEEP-1.TXT, SCHEMA-SPATIAL.XML, OPEN-EXCHANGE-RATES.JSON, STOPWITHBOM.TXT, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SCHEMA-XINCLUDE.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SOLRCONFIG-MASTER1.XML, SYNONYMS.TXT, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA_CODEC.XML, SCHEMA.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SOLRCONFIG-FUNCTIONQUERY.XML, STOP-2.TXT, SOLRCONFIG-TERMINDEX.XML, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-ELEVATE.XML, STOPWORDS.TXT, SCHEMA-FOLDING.XML, SCHEMA-STOP-KEEP.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, STOP-1.TXT, SOLRCONFIG-MASTER2.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SOLRCONFIG-LAZYWRITER.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-MP-SOLRCONFIG.XML, FRENCHARTICLES.TXT, SCHEMA15.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMASURROUND.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MASTER3.XML, HUNSPELL-TEST.DIC, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-DELPOLICY1.XML, SOLRCONFIG-SLAVE1.XML, SCHEMA-SIM.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-COLLATE.XML, STOP-SNOWBALL.TXT, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, PROTWORDS.TXT, SCHEMA-TRIE.XML, SOLRCONFIG_CODEC.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, JASUGGEST.TXT, SCHEMA-TFIDF.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-LMJELINEKMERCER.XML, PHRASESUGGEST.TXT, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, OLD_SYNONYMS.TXT, SOLRCONFIG-DELPOLICY2.XML, XSLT, SOLRCONFIG-NATIVELOCK.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-NOCACHE.XML, SCHEMA-BM25.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-ALTDIRECTORY.XML, COMPOUNDDICTIONARY.TXT, SOLRCONFIG-INDEXCONFIG.XML, SOLRCONFIG_PERF.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, KEEP-2.TXT, SCHEMA12.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, MAPPING-ISOLATIN1ACCENT.TXT, BAD_SOLRCONFIG.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML]
[junit4:junit4]   2> 3142 T25 oass.SolrIndexSearcher.<init> Opening Searcher@1c3ceacd main
[junit4:junit4]   2> 3143 T25 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 3143 T25 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 3144 T25 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 3145 T25 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 3180 T25 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 3231 T25 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3232 T25 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3232 T25 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3233 T25 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3233 T25 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3234 T25 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3234 T25 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3234 T25 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3235 T25 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3235 T25 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3252 T54 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c3ceacd main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 3259 T25 oasc.CoreContainer.register registering core: collection1
[junit4:junit4]   2> 3260 T25 oass.SolrDispatchFilter.init user.dir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build/solr-core/test/J1
[junit4:junit4]   2> 3260 T25 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 3261 T25 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C3 name=collection1 org.apache.solr.core.SolrCore@c985e80
[junit4:junit4]   2> 4508 T37 C3 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 4512 T37 C3 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@31482ac5 lockFactory=org.apache.lucene.store.NativeFSLockFactory@55ca6626),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4512 T37 C3 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4513 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 23
[junit4:junit4]   2> ASYNC  NEW_CORE C4 name=collection1 org.apache.solr.core.SolrCore@77d9525e
[junit4:junit4]   2> 4630 T53 C4 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 4672 T53 C4 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5caed6ca lockFactory=org.apache.lucene.store.NativeFSLockFactory@164ef200),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4673 T53 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 1
[junit4:junit4]   2> 4673 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 44
[junit4:junit4]   2> 4792 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 112
[junit4:junit4]   2> 4804 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 7
[junit4:junit4]   2> 4814 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 5
[junit4:junit4]   2> 4827 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 7
[junit4:junit4]   2> 4835 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 4
[junit4:junit4]   2> 4844 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 5
[junit4:junit4]   2> 4854 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 5
[junit4:junit4]   2> 4862 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 5
[junit4:junit4]   2> 4870 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 5
[junit4:junit4]   2> 4878 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 5
[junit4:junit4]   2> 4887 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 4
[junit4:junit4]   2> 4895 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 4
[junit4:junit4]   2> 4903 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 4
[junit4:junit4]   2> 4913 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 4
[junit4:junit4]   2> 4922 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 4
[junit4:junit4]   2> 4930 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 5
[junit4:junit4]   2> 4937 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 3
[junit4:junit4]   2> 4945 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 3
[junit4:junit4]   2> 5027 T38 C3 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5167 T38 C3 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@31482ac5 lockFactory=org.apache.lucene.store.NativeFSLockFactory@55ca6626),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@31482ac5 lockFactory=org.apache.lucene.store.NativeFSLockFactory@55ca6626),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene40_0.prx, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 5168 T38 C3 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 5261 T38 C3 oass.SolrIndexSearcher.<init> Opening Searcher@5a20618a main
[junit4:junit4]   2> 5262 T38 C3 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5263 T38 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5265 T40 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5a20618a main{StandardDirectoryReader(segments_2:4 _0(4.1):C9)}
[junit4:junit4]   2> 5266 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 239
[junit4:junit4]   2> 5270 T53 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5294 T53 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5caed6ca lockFactory=org.apache.lucene.store.NativeFSLockFactory@164ef200),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5caed6ca lockFactory=org.apache.lucene.store.NativeFSLockFactory@164ef200),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene40_0.prx, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 5295 T53 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 2
[junit4:junit4]   2> 5298 T53 C4 oass.SolrIndexSearcher.<init> Opening Searcher@481d2264 main
[junit4:junit4]   2> 5298 T53 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 5299 T53 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5301 T54 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@481d2264 main{StandardDirectoryReader(segments_2:4 _0(4.1):C9)}
[junit4:junit4]   2> 5302 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 32
[junit4:junit4]   2> 5311 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 4
[junit4:junit4]   2> 5345 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 31
[junit4:junit4]   2> 5368 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 18
[junit4:junit4]   2> 5375 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 3
[junit4:junit4]   2> 5384 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 4
[junit4:junit4]   2> 5406 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 18
[junit4:junit4]   2> 5414 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 3
[junit4:junit4]   2> 5441 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 21
[junit4:junit4]   2> 5448 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 3
[junit4:junit4]   2> 5455 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 3
[junit4:junit4]   2> 5500 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 4
[junit4:junit4]   2> 5508 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 3
[junit4:junit4]   2> 5516 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 4
[junit4:junit4]   2> 5525 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 4
[junit4:junit4]   2> 5546 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 15
[junit4:junit4]   2> 5568 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 17
[junit4:junit4]   2> 5577 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[100]} 0 4
[junit4:junit4]   2> 5585 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[100]} 0 3
[junit4:junit4]   2> 5615 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[101]} 0 26
[junit4:junit4]   2> 5644 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[101]} 0 24
[junit4:junit4]   2> 5654 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[102]} 0 5
[junit4:junit4]   2> 5664 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[102]} 0 5
[junit4:junit4]   2> 5674 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[103]} 0 5
[junit4:junit4]   2> 5683 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[103]} 0 4
[junit4:junit4]   2> 5689 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[104]} 0 2
[junit4:junit4]   2> 5698 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[104]} 0 4
[junit4:junit4]   2> 5705 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[105]} 0 2
[junit4:junit4]   2> 5712 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[105]} 0 3
[junit4:junit4]   2> 5719 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[106]} 0 2
[junit4:junit4]   2> 5726 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[106]} 0 2
[junit4:junit4]   2> 5733 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[107]} 0 2
[junit4:junit4]   2> 5739 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[107]} 0 3
[junit4:junit4]   2> 5745 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[108]} 0 3
[junit4:junit4]   2> 5751 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[108]} 0 2
[junit4:junit4]   2> 5759 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[109]} 0 3
[junit4:junit4]   2> 5765 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[109]} 0 3
[junit4:junit4]   2> 5771 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[110]} 0 2
[junit4:junit4]   2> 5777 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[110]} 0 3
[junit4:junit4]   2> 5793 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[111]} 0 10
[junit4:junit4]   2> 5808 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[111]} 0 10
[junit4:junit4]   2> 5816 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[112]} 0 3
[junit4:junit4]   2> 5823 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[112]} 0 4
[junit4:junit4]   2> 5830 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[113]} 0 2
[junit4:junit4]   2> 5836 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[113]} 0 2
[junit4:junit4]   2> 5843 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[114]} 0 2
[junit4:junit4]   2> 5850 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[114]} 0 2
[junit4:junit4]   2> 5857 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[115]} 0 2
[junit4:junit4]   2> 5863 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[115]} 0 3
[junit4:junit4]   2> 5869 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[116]} 0 2
[junit4:junit4]   2> 5875 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[116]} 0 2
[junit4:junit4]   2> 5882 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[117]} 0 2
[junit4:junit4]   2> 5888 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[117]} 0 2
[junit4:junit4]   2> 5894 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[118]} 0 2
[junit4:junit4]   2> 5900 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[118]} 0 3
[junit4:junit4]   2> 5906 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[119]} 0 2
[junit4:junit4]   2> 5911 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[119]} 0 2
[junit4:junit4]   2> 5918 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[120]} 0 2
[junit4:junit4]   2> 5924 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[120]} 0 2
[junit4:junit4]   2> 5937 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[121]} 0 9
[junit4:junit4]   2> 5950 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[121]} 0 9
[junit4:junit4]   2> 5957 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[122]} 0 2
[junit4:junit4]   2> 5964 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[122]} 0 2
[junit4:junit4]   2> 5971 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123]} 0 2
[junit4:junit4]   2> 5977 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123]} 0 2
[junit4:junit4]   2> 5984 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[124]} 0 2
[junit4:junit4]   2> 5989 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[124]} 0 2
[junit4:junit4]   2> 5996 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[125]} 0 2
[junit4:junit4]   2> 6001 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[125]} 0 2
[junit4:junit4]   2> 6007 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[126]} 0 2
[junit4:junit4]   2> 6013 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[126]} 0 2
[junit4:junit4]   2> 6019 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[127]} 0 3
[junit4:junit4]   2> 6025 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[127]} 0 3
[junit4:junit4]   2> 6031 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[128]} 0 2
[junit4:junit4]   2> 6037 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[128]} 0 2
[junit4:junit4]   2> 6046 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[129]} 0 2
[junit4:junit4]   2> 6053 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[129]} 0 2
[junit4:junit4]   2> 6060 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[130]} 0 2
[junit4:junit4]   2> 6067 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[130]} 0 3
[junit4:junit4]   2> 6079 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[131]} 0 8
[junit4:junit4]   2> 6092 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[131]} 0 8
[junit4:junit4]   2> 6098 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[132]} 0 2
[junit4:junit4]   2> 6104 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[132]} 0 3
[junit4:junit4]   2> 6110 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[133]} 0 2
[junit4:junit4]   2> 6116 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[133]} 0 2
[junit4:junit4]   2> 6121 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[134]} 0 2
[junit4:junit4]   2> 6127 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[134]} 0 2
[junit4:junit4]   2> 6133 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[135]} 0 2
[junit4:junit4]   2> 6138 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[135]} 0 2
[junit4:junit4]   2> 6143 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[136]} 0 2
[junit4:junit4]   2> 6149 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[136]} 0 2
[junit4:junit4]   2> 6154 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[137]} 0 2
[junit4:junit4]   2> 6159 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[137]} 0 2
[junit4:junit4]   2> 6166 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[138]} 0 2
[junit4:junit4]   2> 6171 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[138]} 0 2
[junit4:junit4]   2> 6178 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[139]} 0 2
[junit4:junit4]   2> 6183 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[139]} 0 2
[junit4:junit4]   2> 6188 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[140]} 0 2
[junit4:junit4]   2> 6194 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[140]} 0 2
[junit4:junit4]   2> 6205 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[141]} 0 8
[junit4:junit4]   2> 6217 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[141]} 0 7
[junit4:junit4]   2> 6223 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[142]} 0 3
[junit4:junit4]   2> 6228 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[142]} 0 2
[junit4:junit4]   2> 6234 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[143]} 0 2
[junit4:junit4]   2> 6239 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[143]} 0 2
[junit4:junit4]   2> 6244 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[144]} 0 2
[junit4:junit4]   2> 6249 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[144]} 0 2
[junit4:junit4]   2> 6254 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[145]} 0 2
[junit4:junit4]   2> 6259 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[145]} 0 2
[junit4:junit4]   2> 6264 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[146]} 0 2
[junit4:junit4]   2> 6269 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[146]} 0 2
[junit4:junit4]   2> 6274 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[147]} 0 2
[junit4:junit4]   2> 6279 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[147]} 0 2
[junit4:junit4]   2> 6284 T38 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[148]} 0 2
[junit4:junit4]   2> 6289 T52 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[148]} 0 2
[junit4:junit4]   2> 6294 T37 C3 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[149]} 0 2
[junit4:junit4]   2> 6299 T53 C4 UPDATE [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[149]} 0 2
[junit4:junit4]   2> 6303 T39 C3 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 6377 T39 C3 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@31482ac5 lockFactory=org.apache.lucene.store.NativeFSLockFactory@55ca6626),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene40_0.prx, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@31482ac5 lockFactory=org.apache.lucene.store.NativeFSLockFactory@55ca6626),segFN=segments_3,generation=3,filenames=[_5_nrm.cfe, _1_Lucene40_0.tim, _3_nrm.cfe, _5.fdt, _6_Lucene40_0.tim, _6_Lucene40_0.tip, _4.fnm, _4_nrm.cfe, _3.fdt, _0_Lucene40_0.prx, _1.fnm, _1_Lucene40_0.tip, _4.fdx, _2_Lucene40_0.tip, _3_Lucene40_0.frq, _2_Lucene40_0.tim, _5_Lucene40_0.frq, _0_Lucene40_0.tim, _0.fnm, _2.fdt, _2.fdx, _6_Lucene40_0.frq, _1_Lucene40_0.prx, _0_Lucene40_0.tip, _5.si, _1.fdx, _3_nrm.cfs, _5_nrm.cfs, _1.fdt, _2_Lucene40_0.prx, _4_nrm.cfs, _4_Lucene40_0.frq, _6_Lucene40_0.prx, _3.si, _6.fdt, _2.si, _6.fdx, _3.fnm, _2_nrm.cfe, _6_nrm.cfs, _5_Lucene40_0.tim, _5_Lucene40_0.tip, _0_Lucene40_0.frq, _3_Lucene40_0.prx, _4_Lucene40_0.tip, _4_Lucene40_0.tim, _0.si, _2_nrm.cfs, _4_Lucene40_0.prx, _1_nrm.cfs, _3_Lucene40_0.tip, _5.fnm, _3_Lucene40_0.tim, _6_nrm.cfe, _1_Lucene40_0.frq, _4.si, _4.fdt, _0_nrm.cfs, _1_nrm.cfe, _2.fnm, _3.fdx, _2_Lucene40_0.frq, _1.si, _0_nrm.cfe, _5.fdx, _6.si, _6.fnm, _0.fdx, _5_Lucene40_0.prx, segments_3, _0.fdt]
[junit4:junit4]   2> 6377 T39 C3 oasc.SolrDeletionPolicy.updateCommits newest commit = 3
[junit4:junit4]   2> 6386 T39 C3 oass.SolrIndexSearcher.<init> Opening Searcher@396a0391 main
[junit4:junit4]   2> 6386 T39 C3 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 6387 T39 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 6389 T40 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@396a0391 main{StandardDirectoryReader(segments_3:16 _0(4.1):C9 _1(4.1):C10 _2(4.1):C10 _3(4.1):C10 _4(4.1):C10 _5(4.1):C10 _6(4.1):C8)}
[junit4:junit4]   2> 6390 T39 C3 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 87
[junit4:junit4]   2> 6394 T50 C4 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 6461 T50 C4 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5caed6ca lockFactory=org.apache.lucene.store.NativeFSLockFactory@164ef200),segFN=segments_2,generation=2,filenames=[_0_Lucene40_0.tim, _0.fnm, _0_Lucene40_0.frq, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene40_0.prx, _0.fdt, _0_Lucene40_0.tip]
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@5caed6ca lockFactory=org.apache.lucene.store.NativeFSLockFactory@164ef200),segFN=segments_3,generation=3,filenames=[_5_nrm.cfe, _1_Lucene40_0.tim, _3_nrm.cfe, _5.fdt, _6_Lucene40_0.tim, _6_Lucene40_0.tip, _4.fnm, _4_nrm.cfe, _3.fdt, _0_Lucene40_0.prx, _1.fnm, _1_Lucene40_0.tip, _4.fdx, _2_Lucene40_0.tip, _3_Lucene40_0.frq, _2_Lucene40_0.tim, _5_Lucene40_0.frq, _0_Lucene40_0.tim, _0.fnm, _2.fdt, _2.fdx, _6_Lucene40_0.frq, _1_Lucene40_0.prx, _0_Lucene40_0.tip, _5.si, _1.fdx, _3_nrm.cfs, _5_nrm.cfs, _1.fdt, _2_Lucene40_0.prx, _4_nrm.cfs, _4_Lucene40_0.frq, _6_Lucene40_0.prx, _3.si, _6.fdt, _2.si, _6.fdx, _3.fnm, _2_nrm.cfe, _6_nrm.cfs, _5_Lucene40_0.tim, _5_Lucene40_0.tip, _0_Lucene40_0.frq, _3_Lucene40_0.prx, _4_Lucene40_0.tip, _4_Lucene40_0.tim, _0.si, _2_nrm.cfs, _4_Lucene40_0.prx, _1_nrm.cfs, _3_Lucene40_0.tip, _5.fnm, _3_Lucene40_0.tim, _6_nrm.cfe, _1_Lucene40_0.frq, _4.si, _4.fdt, _0_nrm.cfs, _1_nrm.cfe, _2.fnm, _3.fdx, _2_Lucene40_0.frq, _1.si, _0_nrm.cfe, _5.fdx, _6.si, _6.fnm, _0.fdx, _5_Lucene40_0.prx, segments_3, _0.fdt]
[junit4:junit4]   2> 6461 T50 C4 oasc.SolrDeletionPolicy.updateCommits newest commit = 3
[junit4:junit4]   2> 6470 T50 C4 oass.SolrIndexSearcher.<init> Opening Searcher@4238365d main
[junit4:junit4]   2> 6470 T50 C4 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper
[junit4:junit4]   2> 6471 T50 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 6474 T54 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4238365d main{StandardDirectoryReader(segments_3:16 _0(4.1):C9 _1(4.1):C10 _2(4.1):C10 _3(4.1):C10 _4(4.1):C10 _5(4.1):C10 _6(4.1):C8)}
[junit4:junit4]   2> 6474 T50 C4 UPDATE [collection1] webapp=/solr path=/update params={waitSearcher=true&wt=javabin&commit=true&softCommit=false&version=2} {commit=} 0 80
[junit4:junit4]   2> 6559 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_ti1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=51 
[junit4:junit4]   2> 6599 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_ti1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr&NOW=1351497074587&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6651 T53 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr&NOW=1351497074587&q=*:*&ids=134,146,139,149,110,16,103,130,11,119&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=25 
[junit4:junit4]   2> 6655 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_ti1+desc&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=85 
[junit4:junit4]   2> 6665 T39 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_ti1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 6716 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_ti1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497074687&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 6725 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497074687&q=*:*&ids=135,132,145,128,113,137,111,17,140,102&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 6729 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_ti1+asc&shards=127.0.0.1:47891/solr|[ff01::213]:33332/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=59 
[junit4:junit4]   2> 6736 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_f1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6749 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_f1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::083]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr&NOW=1351497074758&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6758 T53 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::083]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr&NOW=1351497074758&q=*:*&ids=125,1,113,139,5,4,106,104,8,129&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 6762 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_f1+desc&shards=[ff01::083]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=21 
[junit4:junit4]   2> 6769 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_f1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 6778 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_f1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497074791&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 6786 T50 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497074791&q=*:*&ids=134,10,128,147,110,111,17,130,12,141&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 6789 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_f1+asc&shards=127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=15 
[junit4:junit4]   2> 6798 T39 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_tf1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6807 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tf1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497074819&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6817 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497074819&q=*:*&ids=125,121,147,139,124,17,105,9,14,119&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 6822 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tf1+desc&shards=127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=20 
[junit4:junit4]   2> 6829 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_tf1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 6839 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tf1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497074851&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 6847 T53 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497074851&q=*:*&ids=2,127,128,112,138,113,4,103,13,130&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 6850 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tf1+asc&shards=127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=16 
[junit4:junit4]   2> 6857 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_d1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6866 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_d1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497074878&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6873 T50 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497074878&q=*:*&ids=115,146,121,7,109,5,110,124,111,103&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 6876 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_d1+desc&shards=127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=15 
[junit4:junit4]   2> 6883 T39 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_d1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 6891 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_d1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497074904&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 6901 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497074904&q=*:*&ids=125,134,10,145,128,17,16,129,11,142&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=5 
[junit4:junit4]   2> 6905 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_d1+asc&shards=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=18 
[junit4:junit4]   2> 6912 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_td1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6922 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_td1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497074933&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6930 T53 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497074933&q=*:*&ids=134,146,121,109,149,107,124,16,101,11&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 6932 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_td1+desc&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=16 
[junit4:junit4]   2> 6937 T39 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_td1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 6948 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_td1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::083]:33332/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497074959&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 6957 T50 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::083]:33332/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497074959&q=*:*&ids=3,135,126,2,144,106,8,13,100,118&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 6959 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_td1+asc&shards=[ff01::083]:33332/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=17 
[junit4:junit4]   2> 6970 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_l1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6979 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_l1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497074991&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 6985 T50 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497074991&q=*:*&ids=114,10,1,121,139,123,5,107,8,14&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 6988 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_l1+desc&shards=127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=14 
[junit4:junit4]   2> 6993 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_l1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7000 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_l1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497075013&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7006 T53 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497075013&q=*:*&ids=143,135,144,2,127,132,146,112,113,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7009 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_l1+asc&shards=127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=13 
[junit4:junit4]   2> 7015 T39 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_tl1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 7024 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::083]:33332/solr&NOW=1351497075036&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 7030 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::083]:33332/solr&NOW=1351497075036&q=*:*&ids=3,1,146,123,110,124,105,14,130,142&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7033 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+desc&shards=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::083]:33332/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=14 
[junit4:junit4]   2> 7039 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_tl1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7048 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075061&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 7058 T50 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075061&q=*:*&ids=143,116,115,147,7,122,139,111,140,13&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7062 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+asc&shards=[ff01::083]:33332/solr|127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=18 
[junit4:junit4]   2> 7070 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_dt1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=3 
[junit4:junit4]   2> 7081 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_dt1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497075092&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 7090 T53 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497075092&q=*:*&ids=116,127,133,115,121,110,9,15,142,141&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7094 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_dt1+desc&shards=127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=19 
[junit4:junit4]   2> 7101 T39 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_dt1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7110 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_dt1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497075123&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 7119 T50 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497075123&q=*:*&ids=134,138,139,108,5,123,137,140,102,101&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7122 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_dt1+asc&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=16 
[junit4:junit4]   2> 7129 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_tdt1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 7142 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tdt1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497075151&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=3 
[junit4:junit4]   2> 7151 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497075151&q=*:*&ids=125,1,114,149,8,140,102,130,14,119&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7154 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tdt1+desc&shards=127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=20 
[junit4:junit4]   2> 7160 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_tdt1+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7169 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tdt1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075182&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 7178 T53 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075182&q=*:*&ids=134,126,128,7,123,124,137,105,131,142&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7181 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tdt1+asc&shards=[ff01::213]:33332/solr|127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=16 
[junit4:junit4]   2> 7188 T39 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=a_si+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7198 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497075209&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 7207 T50 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497075209&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7209 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=17 
[junit4:junit4]   2> 7339 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort={!func}testfunc(add(a_si,5))+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=125 
[junit4:junit4]   2> 7350 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort={!func}testfunc(add(a_si,5))+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::114]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497075361&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7359 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::114]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497075361&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7361 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort={!func}testfunc(add(a_si,5))+desc&shards=[ff01::114]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=17 
[junit4:junit4]   2> 7366 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=a_si+asc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7384 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075398&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 7399 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075398&q=*:*&ids=3,2,1,7,6,4,9,13,11,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7401 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+asc&shards=[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=20 
[junit4:junit4]   2> 7407 T38 C3 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&fl=*,score&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7415 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr&NOW=1351497075428&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 7424 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr&NOW=1351497075428&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7426 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&fl=*,score&shards=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=15 
[junit4:junit4]   2> 7432 T39 C3 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+asc&fl=*,score&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7440 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+asc&distrib=false&wt=javabin&rows=10&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr&NOW=1351497075453&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 7451 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr&NOW=1351497075453&q=*:*&ids=143,116,115,147,7,122,139,111,140,13&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7453 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+asc&fl=*,score&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=17 
[junit4:junit4]   2> 7459 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&sort=n_tl1+desc&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7467 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497075480&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 7475 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497075480&q=*:*&ids=3,1,146,123,110,124,105,14,130,142&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 7477 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=n_tl1+desc&shards=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&wt=javabin&q=*:*&version=2} hits=67 status=0 QTime=14 
[junit4:junit4]   2> 7490 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&wt=javabin&q={!func}a_si&version=2} hits=67 status=0 QTime=9 
[junit4:junit4]   2> 7498 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497075511&start=0&q={!func}a_si&distrib=false&isShard=true&wt=javabin&fsv=true&rows=10&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7511 T50 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=127.0.0.1:47891/solr&NOW=1351497075511&q={!func}a_si&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7513 T53 C4 REQ [collection1] webapp=/solr path=/select params={shards=127.0.0.1:47891/solr&wt=javabin&q={!func}a_si&version=2} hits=67 status=0 QTime=19 
[junit4:junit4]   2> 7518 T39 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&fl=*,score&wt=javabin&q={!func}a_si&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7526 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497075539&start=0&q={!func}a_si&distrib=false&isShard=true&wt=javabin&fsv=true&rows=10&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 7533 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497075539&q={!func}a_si&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 7535 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr&wt=javabin&q={!func}a_si&version=2} hits=67 status=0 QTime=13 
[junit4:junit4]   2> 7541 T37 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&wt=javabin&q=quick&version=2} hits=2 status=0 QTime=2 
[junit4:junit4]   2> 7550 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=[ff01::114]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497075562&start=0&q=quick&distrib=false&isShard=true&wt=javabin&fsv=true&rows=10&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7556 T52 C4 REQ [collection1] webapp=/solr path=/select params={shard.url=[ff01::114]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497075562&q=quick&ids=5,4&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 7557 T50 C4 REQ [collection1] webapp=/solr path=/select params={shards=[ff01::114]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&wt=javabin&q=quick&version=2} hits=2 status=0 QTime=12 
[junit4:junit4]   2> 7561 T38 C3 REQ [collection1] webapp=/solr path=/select params={fl=id&start=0&q=all&distrib=false&wt=javabin&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7569 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497075582&start=0&q=all&distrib=false&isShard=true&wt=javabin&fsv=true&rows=10&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7581 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497075582&start=0&q=all&ids=1,8&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 7582 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=id&shards=127.0.0.1:47891/solr&start=0&q=all&wt=javabin&version=2} hits=2 status=0 QTime=17 
[junit4:junit4]   2> 7587 T39 C3 REQ [collection1] webapp=/solr path=/select params={fl=foofoofoo&start=0&q=all&distrib=false&wt=javabin&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7594 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=[ff01::213]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497075607&start=0&q=all&distrib=false&isShard=true&wt=javabin&fsv=true&rows=10&version=2} hits=2 status=0 QTime=0 
[junit4:junit4]   2> 7598 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=foofoofoo&fl=id&shard.url=[ff01::213]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497075607&start=0&q=all&ids=1,8&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7600 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=foofoofoo&shards=[ff01::213]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&start=0&q=all&wt=javabin&version=2} hits=2 status=0 QTime=10 
[junit4:junit4]   2> 7604 T37 C3 REQ [collection1] webapp=/solr path=/select params={fl=id&start=100&q=all&distrib=false&wt=javabin&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7611 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=[ff01::083]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075624&start=0&q=all&distrib=false&isShard=true&wt=javabin&fsv=true&rows=110&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7612 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id&shards=[ff01::083]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr&start=100&q=all&wt=javabin&version=2} hits=2 status=0 QTime=5 
[junit4:junit4]   2> 7616 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&fl=*,score&wt=javabin&q=quick&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7624 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr&NOW=1351497075637&start=0&q=quick&distrib=false&isShard=true&wt=javabin&fsv=true&rows=10&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7628 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr&NOW=1351497075637&q=quick&ids=5,4&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7630 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr&wt=javabin&q=quick&version=2} hits=2 status=0 QTime=10 
[junit4:junit4]   2> 7634 T39 C3 REQ [collection1] webapp=/solr path=/select params={fl=*,score&start=1&q=all&distrib=false&wt=javabin&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7641 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=[ff01::213]:33332/solr|[ff01::114]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075654&start=0&q=all&distrib=false&isShard=true&wt=javabin&fsv=true&rows=11&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7645 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shard.url=[ff01::213]:33332/solr|[ff01::114]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497075654&start=1&q=all&ids=1&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=1 
[junit4:junit4]   2> 7646 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shards=[ff01::213]:33332/solr|[ff01::114]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr&start=1&q=all&wt=javabin&version=2} hits=2 status=0 QTime=9 
[junit4:junit4]   2> 7650 T37 C3 REQ [collection1] webapp=/solr path=/select params={fl=*,score&start=100&q=all&distrib=false&wt=javabin&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7657 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr|[ff01::083]:33332/solr&NOW=1351497075670&start=0&q=all&distrib=false&isShard=true&wt=javabin&fsv=true&rows=110&version=2} hits=2 status=0 QTime=1 
[junit4:junit4]   2> 7658 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shards=127.0.0.1:47891/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr|[ff01::083]:33332/solr&start=100&q=all&wt=javabin&version=2} hits=2 status=0 QTime=5 
[junit4:junit4]   2> 7961 T38 C3 REQ [collection1] webapp=/solr path=/select params={fl=*,score&q=now+their+fox+sat+had+put&distrib=false&hl.fl=a_t&wt=javabin&hl=true&version=2} hits=7 status=0 QTime=300 
[junit4:junit4]   2> 7978 T52 C4 REQ [collection1] webapp=/solr path=/select params={distrib=false&hl.fl=a_t&wt=javabin&hl=false&rows=10&version=2&NOW=1351497075988&shard.url=127.0.0.1:47891/solr&fl=id,score&start=0&q=now+their+fox+sat+had+put&isShard=true&fsv=true} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 7990 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shard.url=127.0.0.1:47891/solr&NOW=1351497075988&q=now+their+fox+sat+had+put&ids=3,1,7,6,5,4,9&distrib=false&hl.fl=a_t&isShard=true&wt=javabin&hl=true&version=2} status=0 QTime=8 
[junit4:junit4]   2> 7992 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shards=127.0.0.1:47891/solr&q=now+their+fox+sat+had+put&hl.fl=a_t&wt=javabin&hl=true&version=2} hits=7 status=0 QTime=21 
[junit4:junit4]   2> 8000 T39 C3 REQ [collection1] webapp=/solr path=/select params={fl=foofoofoo&q=now+their+fox+sat+had+put&distrib=false&hl.fl=a_t&wt=javabin&hl=true&version=2} hits=7 status=0 QTime=4 
[junit4:junit4]   2> 8009 T53 C4 REQ [collection1] webapp=/solr path=/select params={distrib=false&hl.fl=a_t&wt=javabin&hl=false&rows=10&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076020&start=0&q=now+their+fox+sat+had+put&isShard=true&fsv=true} hits=7 status=0 QTime=1 
[junit4:junit4]   2> 8018 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=foofoofoo&fl=id&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076020&q=now+their+fox+sat+had+put&ids=3,1,7,6,5,4,9&distrib=false&hl.fl=a_t&isShard=true&wt=javabin&hl=true&version=2} status=0 QTime=5 
[junit4:junit4]   2> 8019 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=foofoofoo&shards=127.0.0.1:47891/solr|[ff01::114]:33332/solr&q=now+their+fox+sat+had+put&hl.fl=a_t&wt=javabin&hl=true&version=2} hits=7 status=0 QTime=16 
[junit4:junit4]   2> 8023 T38 C3 REQ [collection1] webapp=/solr path=/select params={distrib=false&fl=*,score&wt=javabin&q=matchesnothing&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 8030 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076043&start=0&q=matchesnothing&distrib=false&isShard=true&wt=javabin&fsv=true&rows=10&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 8030 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=*,score&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr&wt=javabin&q=matchesnothing&version=2} hits=0 status=0 QTime=4 
[junit4:junit4]   2> 8035 T37 C3 REQ [collection1] webapp=/solr path=/select params={sort=score+desc,a_si+desc&fl=id&q={!func}ms(NOW)&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8042 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=score+desc,a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076055&start=0&q={!func}ms(NOW)&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8050 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=id&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076055&q={!func}ms(NOW)&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=4 
[junit4:junit4]   2> 8051 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=score+desc,a_si+desc&fl=id&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&q={!func}ms(NOW)&wt=javabin&version=2} hits=67 status=0 QTime=13 
[junit4:junit4]   2> 8123 T39 C3 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=4649,tindexSize=45,time=1,phase1=1,nTerms=49,bigTerms=0,termInstances=63,uses=0}
[junit4:junit4]   2> 8133 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&q=*:*&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=79 
[junit4:junit4]   2> 8178 T53 C4 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=4649,tindexSize=45,time=2,phase1=2,nTerms=49,bigTerms=0,termInstances=63,uses=0}
[junit4:junit4]   2> 8179 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=160&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497076167&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=3 
[junit4:junit4]   2> 8191 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&q=*:*&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=41 
[junit4:junit4]   2> 8195 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&q=*:*&facet.limit=1&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8202 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=11&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::213]:33332/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr&NOW=1351497076215&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8203 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr|[ff01::213]:33332/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr&q=*:*&facet.limit=1&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8207 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.query=quick&facet.query=all&facet.query=*:*&q=*:*&distrib=false&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8220 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::083]:33332/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076227&facet.query=quick&facet.query=all&facet.query=*:*&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 8221 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::083]:33332/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr&facet.query=quick&facet.query=all&facet.query=*:*&q=*:*&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=11 
[junit4:junit4]   2> 8225 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=2&q=*:*&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8232 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=160&version=2&fl=id,score&shard.url=[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497076245&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8234 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&facet.mincount=2&q=*:*&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=6 
[junit4:junit4]   2> 8247 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.query={!term+f%3Dfoo_s}international????&q=*:*&distrib=false&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=10 
[junit4:junit4]   2> 8254 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076267&facet.query={!term+f%3Dfoo_s}international????&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8255 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr&facet.query={!term+f%3Dfoo_s}international????&q=*:*&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8306 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet.date.start=2010-05-01T11:00:00Z&facet=true&q=*:*&facet.date=a_n_tdt&distrib=false&facet.date.other=all&facet.date.gap=%2B1DAY&wt=javabin&facet.date.end=2010-05-20T11:00:00Z&rows=100&version=2} hits=67 status=0 QTime=48 
[junit4:junit4]   2> 8335 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet.date.start=2010-05-01T11:00:00Z&facet=true&facet.date=a_n_tdt&distrib=false&facet.date.other=all&wt=javabin&rows=100&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497076338&start=0&q=*:*&facet.date.gap=%2B1DAY&isShard=true&facet.date.end=2010-05-20T11:00:00Z&fsv=true} hits=67 status=0 QTime=10 
[junit4:junit4]   2> 8354 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet.date.start=2010-05-01T11:00:00Z&facet=false&ids=116,117,114,115,112,113,110,111,118,119,125,126,127,128,121,122,123,124,129,3,2,1,7,6,5,4,9,120,8,134,135,132,133,138,139,136,137,17,15,16,13,14,11,12,109,108,107,106,105,104,103,131,102,101,130,100,143,144,145,146,147,148,149,10,140,142,141&facet.date=a_n_tdt&distrib=false&facet.date.other=all&wt=javabin&rows=100&version=2&shard.url=127.0.0.1:47891/solr&NOW=1351497076338&q=*:*&facet.date.gap=%2B1DAY&isShard=true&facet.date.end=2010-05-20T11:00:00Z} status=0 QTime=13 
[junit4:junit4]   2> 8360 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet.date.start=2010-05-01T11:00:00Z&facet=true&shards=127.0.0.1:47891/solr&q=*:*&facet.date=a_n_tdt&facet.date.other=all&facet.date.gap=%2B1DAY&wt=javabin&facet.date.end=2010-05-20T11:00:00Z&rows=100&version=2} hits=67 status=0 QTime=39 
[junit4:junit4]   2> 8378 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet.date.start=2010-05-01T11:00:00Z&facet=true&facet.date=a_n_tdt&facet.date=b_n_tdt&distrib=false&facet.date.other=all&wt=javabin&rows=100&version=2&q=*:*&f.b_n_tdt.facet.date.start=2009-05-01T11:00:00Z&facet.date.gap=%2B1DAY&f.b_n_tdt.facet.date.gap=%2B3MONTHS&facet.date.end=2010-05-20T11:00:00Z} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8396 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet.date.start=2010-05-01T11:00:00Z&facet=true&facet.date=a_n_tdt&facet.date=b_n_tdt&distrib=false&facet.date.other=all&wt=javabin&rows=100&version=2&fl=id,score&shard.url=[ff01::213]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076404&start=0&q=*:*&f.b_n_tdt.facet.date.start=2009-05-01T11:00:00Z&facet.date.gap=%2B1DAY&f.b_n_tdt.facet.date.gap=%2B3MONTHS&isShard=true&facet.date.end=2010-05-20T11:00:00Z&fsv=true} hits=67 status=0 QTime=6 
[junit4:junit4]   2> 8422 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet.date.start=2010-05-01T11:00:00Z&facet=false&ids=116,117,114,115,112,113,110,111,118,119,125,126,127,128,121,122,123,124,129,3,2,1,7,6,5,4,9,120,8,134,135,132,133,138,139,136,137,17,15,16,13,14,11,12,109,108,107,106,105,104,103,131,102,101,130,100,143,144,145,146,147,148,149,10,140,142,141&facet.date=a_n_tdt&facet.date=b_n_tdt&distrib=false&facet.date.other=all&wt=javabin&rows=100&version=2&shard.url=[ff01::213]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076404&q=*:*&f.b_n_tdt.facet.date.start=2009-05-01T11:00:00Z&facet.date.gap=%2B1DAY&f.b_n_tdt.facet.date.gap=%2B3MONTHS&isShard=true&facet.date.end=2010-05-20T11:00:00Z} status=0 QTime=19 
[junit4:junit4]   2> 8428 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet.date.start=2010-05-01T11:00:00Z&facet=true&facet.date=a_n_tdt&facet.date=b_n_tdt&facet.date.other=all&wt=javabin&rows=100&version=2&shards=[ff01::213]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&q=*:*&f.b_n_tdt.facet.date.start=2009-05-01T11:00:00Z&facet.date.gap=%2B1DAY&f.b_n_tdt.facet.date.gap=%2B3MONTHS&facet.date.end=2010-05-20T11:00:00Z} hits=67 status=0 QTime=41 
[junit4:junit4]   2> 8442 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&q=*:*&facet.range.start=200&facet.range=other_tl1&distrib=false&facet.range.gap=100&facet.range.end=900&wt=javabin&rows=100&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8460 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.range=other_tl1&distrib=false&facet.range.gap=100&facet.range.end=900&wt=javabin&rows=100&version=2&fl=id,score&shard.url=[ff01::083]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076471&start=0&q=*:*&facet.range.start=200&isShard=true&fsv=true} hits=67 status=0 QTime=3 
[junit4:junit4]   2> 8497 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=false&ids=116,117,114,115,112,113,110,111,118,119,125,126,127,128,121,122,123,124,129,3,2,1,7,6,5,4,9,120,8,134,135,132,133,138,139,136,137,17,15,16,13,14,11,12,109,108,107,106,105,104,103,131,102,101,130,100,143,144,145,146,147,148,149,10,140,142,141&facet.range=other_tl1&distrib=false&facet.range.gap=100&facet.range.end=900&wt=javabin&rows=100&version=2&shard.url=[ff01::083]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076471&q=*:*&facet.range.start=200&isShard=true} status=0 QTime=31 
[junit4:junit4]   2> 8506 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::083]:33332/solr|[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&q=*:*&facet.range.start=200&facet.range=other_tl1&facet.range.gap=100&facet.range.end=900&wt=javabin&rows=100&version=2} hits=67 status=0 QTime=52 
[junit4:junit4]   2> 8521 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&f.other_tl1.facet.range.end=900&f.a_si.facet.range.gap=87&f.a_si.facet.range.start=300&facet.range=other_tl1&facet.range=a_si&distrib=false&facet.range.end=900&facet.range.gap=100&wt=javabin&rows=100&version=2&q=*:*&facet.range.start=200} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 8535 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.other_tl1.facet.range.end=900&f.a_si.facet.range.gap=87&f.a_si.facet.range.start=300&facet.range=other_tl1&facet.range=a_si&distrib=false&facet.range.end=900&facet.range.gap=100&wt=javabin&rows=100&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076546&start=0&q=*:*&facet.range.start=200&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 8561 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=false&f.other_tl1.facet.range.end=900&f.a_si.facet.range.gap=87&ids=116,117,114,115,112,113,110,111,118,119,125,126,127,128,121,122,123,124,129,3,2,1,7,6,5,4,9,120,8,134,135,132,133,138,139,136,137,17,15,16,13,14,11,12,109,108,107,106,105,104,103,131,102,101,130,100,143,144,145,146,147,148,149,10,140,142,141&f.a_si.facet.range.start=300&facet.range=other_tl1&facet.range=a_si&distrib=false&facet.range.end=900&facet.range.gap=100&wt=javabin&rows=100&version=2&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076546&q=*:*&facet.range.start=200&isShard=true} status=0 QTime=20 
[junit4:junit4]   2> 8567 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.other_tl1.facet.range.end=900&f.a_si.facet.range.gap=87&f.a_si.facet.range.start=300&facet.range=other_tl1&facet.range=a_si&facet.range.end=900&facet.range.gap=100&wt=javabin&rows=100&version=2&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr&q=*:*&facet.range.start=200} hits=67 status=0 QTime=38 
[junit4:junit4]   2> 8579 T37 C3 REQ [collection1] webapp=/solr path=/select params={fl=score&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8586 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076599&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 8593 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=score&fl=id&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076599&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8594 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=score&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=12 
[junit4:junit4]   2> 8598 T38 C3 REQ [collection1] webapp=/solr path=/select params={fl=a_si,score&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8605 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id,score&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076618&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8611 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=a_si,score&fl=id&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076618&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8612 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=a_si,score&shards=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=11 
[junit4:junit4]   2> 8617 T39 C3 REQ [collection1] webapp=/solr path=/select params={fl=a_si&fl=score&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8624 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id,score&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076637&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8631 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=a_si&fl=score&fl=id&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076637&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8633 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=a_si&fl=score&shards=[ff01::083]:33332/solr|127.0.0.1:47891/solr&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=13 
[junit4:junit4]   2> 8637 T37 C3 REQ [collection1] webapp=/solr path=/select params={fl=id,a_si&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8644 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497076657&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8650 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,a_si&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497076657&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8651 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=id,a_si&shards=[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=11 
[junit4:junit4]   2> 8655 T38 C3 REQ [collection1] webapp=/solr path=/select params={fl=id&fl=a_si&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8662 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::213]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076675&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8668 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id&fl=a_si&shard.url=[ff01::213]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076675&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=2 
[junit4:junit4]   2> 8669 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=id&fl=a_si&shards=[ff01::213]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=11 
[junit4:junit4]   2> 8674 T39 C3 REQ [collection1] webapp=/solr path=/select params={fl=a_si&fl=id&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8681 T50 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076694&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8687 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=a_si&fl=id&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076694&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8688 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=a_si&fl=id&shards=[ff01::213]:33332/solr|127.0.0.1:47891/solr&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=11 
[junit4:junit4]   2> 8692 T37 C3 REQ [collection1] webapp=/solr path=/select params={fl=id&fl=n_i&fl=n_ti&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8699 T53 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=127.0.0.1:47891/solr&NOW=1351497076712&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8705 T52 C4 REQ [collection1] webapp=/solr path=/select params={fl=id&fl=n_i&fl=n_ti&shard.url=127.0.0.1:47891/solr&NOW=1351497076712&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8706 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=id&fl=n_i&fl=n_ti&shards=127.0.0.1:47891/solr&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=11 
[junit4:junit4]   2> 8710 T38 C3 REQ [collection1] webapp=/solr path=/select params={fl=n_i&fl=id&fl=n_ti&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8717 T52 C4 REQ [collection1] webapp=/solr path=/select params={sort=a_si+desc&distrib=false&wt=javabin&rows=10&version=2&fl=id&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076730&start=0&q=*:*&isShard=true&fsv=true} hits=67 status=0 QTime=0 
[junit4:junit4]   2> 8724 T50 C4 REQ [collection1] webapp=/solr path=/select params={fl=n_i&fl=id&fl=n_ti&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076730&q=*:*&ids=3,2,10,1,7,5,9,8,13,12&distrib=false&isShard=true&wt=javabin&version=2} status=0 QTime=3 
[junit4:junit4]   2> 8725 T53 C4 REQ [collection1] webapp=/solr path=/select params={fl=n_i&fl=id&fl=n_ti&shards=[ff01::083]:33332/solr|127.0.0.1:47891/solr&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=67 status=0 QTime=12 
[junit4:junit4]   2> 8731 T39 C3 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=n_ti1,memSize=4602,tindexSize=46,time=2,phase1=2,nTerms=67,bigTerms=0,termInstances=67,uses=0}
[junit4:junit4]   2> 8733 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=2&facet.sort=count&q=*:*&facet.limit=10000&distrib=false&facet.field=n_ti1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8743 T50 C4 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=n_ti1,memSize=4602,tindexSize=46,time=2,phase1=2,nTerms=67,bigTerms=0,termInstances=67,uses=0}
[junit4:junit4]   2> 8745 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr&NOW=1351497076754&facet.sort=count&start=0&q=*:*&facet.field=n_ti1&f.n_ti1.facet.limit=15013&isShard=true&fsv=true} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8747 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr&facet.mincount=0&facet.offset=2&facet.sort=count&q=*:*&facet.limit=10000&facet.field=n_ti1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=10 
[junit4:junit4]   2> 8752 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=2&facet.offset=0&facet.sort=index&q=*:*&facet.limit=10000&distrib=false&facet.field=n_ti1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8760 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076773&facet.sort=index&start=0&q=*:*&facet.field=n_ti1&f.n_ti1.facet.limit=10000&isShard=true&fsv=true&f.n_ti1.facet.mincount=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8767 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&facet.mincount=2&facet.offset=0&facet.sort=index&q=*:*&facet.limit=10000&facet.field=n_ti1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=11 
[junit4:junit4]   2> 8772 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=6&facet.sort=index&q=*:*&facet.limit=9&distrib=false&facet.field=n_ti1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8780 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497076793&facet.sort=index&start=0&q=*:*&facet.field=n_ti1&f.n_ti1.facet.limit=15&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 8782 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&facet.mincount=0&facet.offset=6&facet.sort=index&q=*:*&facet.limit=9&facet.field=n_ti1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=6 
[junit4:junit4]   2> 8797 T37 C3 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=n_td1,memSize=4607,tindexSize=51,time=2,phase1=2,nTerms=67,bigTerms=0,termInstances=67,uses=0}
[junit4:junit4]   2> 8798 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=4&facet.offset=0&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.limit=10000&distrib=false&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=13 
[junit4:junit4]   2> 8813 T52 C4 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=n_td1,memSize=4607,tindexSize=51,time=2,phase1=2,nTerms=67,bigTerms=0,termInstances=67,uses=0}
[junit4:junit4]   2> 8816 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_td1.facet.limit=15010&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|[ff01::213]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497076819&facet.sort=count&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.field=n_td1&isShard=true&fsv=true} hits=7 status=0 QTime=9 
[junit4:junit4]   2> 8819 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::114]:33332/solr|[ff01::213]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr&facet.mincount=4&facet.offset=0&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.limit=10000&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=17 
[junit4:junit4]   2> 8825 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=2&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.limit=10000&distrib=false&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=3 
[junit4:junit4]   2> 8836 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_td1.facet.limit=10002&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497076846&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.field=n_td1&isShard=true&fsv=true} hits=7 status=0 QTime=3 
[junit4:junit4]   2> 8839 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=0&facet.offset=2&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.limit=10000&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=10 
[junit4:junit4]   2> 8845 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=1&facet.offset=0&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.limit=2&distrib=false&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 8857 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_td1.facet.limit=2&f.n_td1.facet.mincount=1&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497076870&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.field=n_td1&isShard=true&fsv=true} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 8859 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=1&facet.offset=0&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+7]&facet.limit=2&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=6 
[junit4:junit4]   2> 8866 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=4&facet.offset=2&facet.sort=count&q=*:*&facet.limit=-1&distrib=false&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=4 
[junit4:junit4]   2> 8880 T52 C4 REQ [collection1] webapp=/solr path=/select params={f.n_dt1.facet.mincount=1&facet=true&distrib=false&f.n_dt1.facet.limit=-1&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076886&facet.sort=count&start=0&q=*:*&facet.field=n_dt1&isShard=true&fsv=true} hits=67 status=0 QTime=8 
[junit4:junit4]   2> 8892 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&facet.mincount=4&facet.offset=2&facet.sort=count&q=*:*&facet.limit=-1&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=23 
[junit4:junit4]   2> 8900 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=9&facet.sort=index&q=*:*&facet.limit=-1&distrib=false&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8913 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_dt1.facet.limit=-1&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497076920&facet.sort=index&start=0&q=*:*&facet.field=n_dt1&isShard=true&fsv=true} hits=67 status=0 QTime=6 
[junit4:junit4]   2> 8925 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&facet.mincount=0&facet.offset=9&facet.sort=index&q=*:*&facet.limit=-1&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=22 
[junit4:junit4]   2> 8933 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=1&facet.offset=9&facet.sort=index&q=*:*&facet.limit=-1&distrib=false&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8946 T52 C4 REQ [collection1] webapp=/solr path=/select params={f.n_dt1.facet.mincount=1&facet=true&distrib=false&f.n_dt1.facet.limit=-1&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497076954&facet.sort=index&start=0&q=*:*&facet.field=n_dt1&isShard=true&fsv=true} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 8958 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::213]:33332/solr|127.0.0.1:47891/solr|[ff01::114]:33332/solr&facet.mincount=1&facet.offset=9&facet.sort=index&q=*:*&facet.limit=-1&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=21 
[junit4:junit4]   2> 8967 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=1&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.limit=10000&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=4 
[junit4:junit4]   2> 8978 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=15011&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497076987&facet.sort=count&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.field=a_t&isShard=true&fsv=true} hits=7 status=0 QTime=4 
[junit4:junit4]   2> 8980 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::114]:33332/solr|[ff01::083]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&facet.mincount=0&facet.offset=1&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.limit=10000&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=10 
[junit4:junit4]   2> 8985 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=3&facet.offset=7&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.limit=10000&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 8994 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.a_t.facet.mincount=3&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=10007&version=2&fl=id,score&shard.url=[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497077005&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.field=a_t&isShard=true&fsv=true} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 8995 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&facet.mincount=3&facet.offset=7&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.limit=10000&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=7 
[junit4:junit4]   2> 9001 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=5&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.limit=9&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 9010 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=14&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077021&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.field=a_t&isShard=true&fsv=true} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 9011 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=0&facet.offset=5&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+44]&facet.limit=9&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=7 
[junit4:junit4]   2> 9018 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=1&facet.offset=0&facet.sort=count&q=*:*&facet.limit=10000&distrib=false&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=4 
[junit4:junit4]   2> 9028 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.n_f1.facet.limit=15010&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497077039&facet.sort=count&start=0&q=*:*&facet.field=n_f1&isShard=true&fsv=true} hits=67 status=0 QTime=4 
[junit4:junit4]   2> 9030 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr|[ff01::114]:33332/solr&facet.mincount=1&facet.offset=0&facet.sort=count&q=*:*&facet.limit=10000&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=8 
[junit4:junit4]   2> 9034 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=4&facet.offset=7&facet.sort=index&q=*:*&facet.limit=10000&distrib=false&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9090 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.n_f1.facet.limit=10007&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr&NOW=1351497077054&facet.sort=index&start=0&q=*:*&f.n_f1.facet.mincount=4&facet.field=n_f1&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9091 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr|[ff01::114]:33332/solr&facet.mincount=4&facet.offset=7&facet.sort=index&q=*:*&facet.limit=10000&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=54 
[junit4:junit4]   2> 9096 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=1&facet.offset=1&facet.sort=index&q=*:*&facet.limit=1&distrib=false&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9103 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.n_f1.facet.limit=2&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497077116&facet.sort=index&start=0&q=*:*&f.n_f1.facet.mincount=1&facet.field=n_f1&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9104 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr&facet.mincount=1&facet.offset=1&facet.sort=index&q=*:*&facet.limit=1&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 9111 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=3&facet.offset=2&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.limit=10000&distrib=false&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=3 
[junit4:junit4]   2> 9127 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_dt1.facet.limit=15013&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077132&facet.sort=count&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.field=n_dt1&isShard=true&fsv=true} hits=7 status=0 QTime=8 
[junit4:junit4]   2> 9136 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=3&facet.offset=2&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.limit=10000&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=21 
[junit4:junit4]   2> 9146 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=2&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.limit=10000&distrib=false&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=6 
[junit4:junit4]   2> 9158 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_dt1.facet.limit=10002&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077166&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.field=n_dt1&isShard=true&fsv=true} hits=7 status=0 QTime=4 
[junit4:junit4]   2> 9167 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=0&facet.offset=2&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.limit=10000&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=18 
[junit4:junit4]   2> 9173 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=1&facet.offset=0&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.limit=-1&distrib=false&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 9182 T52 C4 REQ [collection1] webapp=/solr path=/select params={f.n_dt1.facet.mincount=1&facet=true&distrib=false&f.n_dt1.facet.limit=-1&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::083]:33332/solr|127.0.0.1:47891/solr&NOW=1351497077193&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.field=n_dt1&isShard=true&fsv=true} hits=7 status=0 QTime=1 
[junit4:junit4]   2> 9185 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::083]:33332/solr|127.0.0.1:47891/solr&facet.mincount=1&facet.offset=0&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+23]&facet.limit=-1&facet.field=n_dt1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=9 
[junit4:junit4]   2> 9192 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=2&facet.offset=0&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.limit=10000&distrib=false&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=4 
[junit4:junit4]   2> 9204 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_td1.facet.limit=15010&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::213]:33332/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&NOW=1351497077212&facet.sort=count&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.field=n_td1&isShard=true&fsv=true} hits=7 status=0 QTime=4 
[junit4:junit4]   2> 9207 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::213]:33332/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr&facet.mincount=2&facet.offset=0&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.limit=10000&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=12 
[junit4:junit4]   2> 9212 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=3&facet.offset=6&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.limit=10000&distrib=false&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 9221 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_td1.facet.limit=10006&f.n_td1.facet.mincount=3&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077233&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.field=n_td1&isShard=true&fsv=true} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 9222 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=3&facet.offset=6&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.limit=10000&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=6 
[junit4:junit4]   2> 9227 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=3&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.limit=0&distrib=false&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 9236 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&f.n_td1.facet.limit=0&wt=javabin&rows=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr&NOW=1351497077248&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.field=n_td1&isShard=true&fsv=true} hits=7 status=0 QTime=1 
[junit4:junit4]   2> 9238 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr|[ff01::114]:33332/solr&facet.mincount=0&facet.offset=3&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+3]&facet.limit=0&facet.field=n_td1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=6 
[junit4:junit4]   2> 9242 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=3&facet.offset=9&facet.sort=count&q=*:*&facet.limit=-1&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9250 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.a_t.facet.mincount=1&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=-1&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077262&facet.sort=count&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 9251 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=3&facet.offset=9&facet.sort=count&q=*:*&facet.limit=-1&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=6 
[junit4:junit4]   2> 9255 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=2&facet.offset=4&facet.sort=index&q=*:*&facet.limit=-1&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9262 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.a_t.facet.mincount=2&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=-1&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::213]:33332/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr&NOW=1351497077275&facet.sort=index&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9264 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr|[ff01::213]:33332/solr|[ff01::083]:33332/solr|[ff01::114]:33332/solr&facet.mincount=2&facet.offset=4&facet.sort=index&q=*:*&facet.limit=-1&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=6 
[junit4:junit4]   2> 9268 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=9&facet.sort=index&q=*:*&facet.limit=0&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9275 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=0&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr&NOW=1351497077288&facet.sort=index&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9276 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr|[ff01::114]:33332/solr|[ff01::213]:33332/solr&facet.mincount=0&facet.offset=9&facet.sort=index&q=*:*&facet.limit=0&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 9280 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=3&facet.offset=0&facet.sort=count&q=*:*&facet.limit=-1&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9288 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.a_t.facet.mincount=1&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=-1&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077300&facet.sort=count&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=2 
[junit4:junit4]   2> 9289 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=3&facet.offset=0&facet.sort=count&q=*:*&facet.limit=-1&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=6 
[junit4:junit4]   2> 9293 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=3&facet.offset=3&facet.sort=index&q=*:*&facet.limit=-1&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9300 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.a_t.facet.mincount=3&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=-1&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077313&facet.sort=index&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9301 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=3&facet.offset=3&facet.sort=index&q=*:*&facet.limit=-1&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 9305 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=7&facet.sort=index&q=*:*&facet.limit=7&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9312 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=14&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077325&facet.sort=index&start=0&q=*:*&facet.field=a_t&isShard=true&fsv=true} hits=67 status=0 QTime=1 
[junit4:junit4]   2> 9313 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=0&facet.offset=7&facet.sort=index&q=*:*&facet.limit=7&facet.field=a_t&wt=javabin&rows=0&version=2} hits=67 status=0 QTime=5 
[junit4:junit4]   2> 9319 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=4&facet.offset=7&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&facet.limit=-1&distrib=false&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=3 
[junit4:junit4]   2> 9330 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.n_f1.facet.limit=-1&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::213]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&NOW=1351497077340&facet.sort=count&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&f.n_f1.facet.mincount=1&facet.field=n_f1&isShard=true&fsv=true} hits=7 status=0 QTime=3 
[junit4:junit4]   2> 9331 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::213]:33332/solr|[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr&facet.mincount=4&facet.offset=7&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&facet.limit=-1&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=8 
[junit4:junit4]   2> 9336 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=1&facet.offset=9&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&facet.limit=-1&distrib=false&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=1 
[junit4:junit4]   2> 9345 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.n_f1.facet.limit=-1&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr&NOW=1351497077357&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&f.n_f1.facet.mincount=1&facet.field=n_f1&isShard=true&fsv=true} hits=7 status=0 QTime=1 
[junit4:junit4]   2> 9347 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::083]:33332/solr|[ff01::213]:33332/solr&facet.mincount=1&facet.offset=9&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&facet.limit=-1&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=7 
[junit4:junit4]   2> 9351 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=3&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&facet.limit=4&distrib=false&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=1 
[junit4:junit4]   2> 9360 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.n_f1.facet.limit=7&distrib=false&wt=javabin&rows=0&version=2&fl=id,score&shard.url=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&NOW=1351497077372&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&facet.field=n_f1&isShard=true&fsv=true} hits=7 status=0 QTime=1 
[junit4:junit4]   2> 9362 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=[ff01::114]:33332/solr|127.0.0.1:47891/solr|[ff01::213]:33332/solr&facet.mincount=0&facet.offset=3&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+15]&facet.limit=4&facet.field=n_f1&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=6 
[junit4:junit4]   2> 9368 T38 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=3&facet.offset=1&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+13]&facet.limit=-1&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=3 
[junit4:junit4]   2> 9380 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&f.a_t.facet.mincount=1&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=-1&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077389&facet.sort=count&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+13]&facet.field=a_t&isShard=true&fsv=true} hits=7 status=0 QTime=4 
[junit4:junit4]   2> 9381 T53 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=3&facet.offset=1&facet.sort=count&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+13]&facet.limit=-1&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=9 
[junit4:junit4]   2> 9386 T37 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&facet.offset=9&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+13]&facet.limit=-1&distrib=false&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 9395 T50 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&distrib=false&wt=javabin&rows=0&f.a_t.facet.limit=-1&version=2&fl=id,score&shard.url=127.0.0.1:47891/solr&NOW=1351497077406&facet.sort=index&start=0&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+13]&facet.field=a_t&isShard=true&fsv=true} hits=7 status=0 QTime=2 
[junit4:junit4]   2> 9396 T52 C4 REQ [collection1] webapp=/solr path=/select params={facet=true&shards=127.0.0.1:47891/solr&facet.mincount=0&facet.offset=9&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+TO+13]&facet.limit=-1&facet.field=a_t&wt=javabin&rows=0&version=2} hits=7 status=0 QTime=7 
[junit4:junit4]   2> 9402 T39 C3 REQ [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=1&facet.offset=6&facet.sort=index&q=id:(1+3+5+7+9+11+13)+OR+id:[100+T

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

ipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  24) Thread[id=90, name=qtp688215095-90 Acceptor1 SelectChannelConnector@0.0.0.0:31019, state=RUNNABLE, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  25) Thread[id=140, name=qtp152752874-140 Acceptor1 SelectChannelConnector@0.0.0.0:16949, state=BLOCKED, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  26) Thread[id=49, name=qtp1542351202-49 Acceptor3 SelectChannelConnector@0.0.0.0:47891, state=BLOCKED, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  27) Thread[id=112, name=qtp810132033-112 Acceptor1 SelectChannelConnector@0.0.0.0:16935, state=BLOCKED, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  28) Thread[id=128, name=qtp1807059414-128 Acceptor3 SelectChannelConnector@0.0.0.0:16939, state=BLOCKED, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  29) Thread[id=46, name=qtp1542351202-46 Acceptor0 SelectChannelConnector@0.0.0.0:47891, state=BLOCKED, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  30) Thread[id=65, name=qtp1279874784-65 Acceptor3 SelectChannelConnector@0.0.0.0:51610, state=RUNNABLE, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  31) Thread[id=142, name=qtp152752874-142 Acceptor3 SelectChannelConnector@0.0.0.0:16949, state=RUNNABLE, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:226)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 	  32) Thread[id=111, name=qtp810132033-111 Acceptor0 SelectChannelConnector@0.0.0.0:16935, state=BLOCKED, group=TGRP-TestDistributedSearch]
[junit4:junit4]   2> 	        at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:210)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.nio.SelectChannelConnector.accept(SelectChannelConnector.java:104)
[junit4:junit4]   2> 	        at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:933)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:599)
[junit4:junit4]   2> 	        at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:534)
[junit4:junit4]   2> 	        at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=da, timezone=SystemV/MST7
[junit4:junit4]   2> NOTE: FreeBSD 9.0-RELEASE amd64/Oracle Corporation 1.7.0_06 (64-bit)/cpus=16,threads=33,free=78170024,total=362807296
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestLRUCache, TestSort, TestCSVLoader, XmlUpdateRequestHandlerTest, ReturnFieldsTest, TestDistributedSearch]
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedSearch -Dtests.seed=7F117478B74F5027 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=da -Dtests.timezone=SystemV/MST7 -Dtests.file.encoding=ISO-8859-1
[junit4:junit4] ERROR   0.00s J1 | TestDistributedSearch (suite) <<<
[junit4:junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([7F117478B74F5027]:0)
[junit4:junit4] Completed on J1 in 7223.83s, 1 test, 2 errors <<< FAILURES!

[...truncated 171 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/build.xml:335: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/build.xml:39: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/solr/build.xml:178: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/lucene/module-build.xml:61: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/lucene/common-build.xml:1159: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-java7/lucene/common-build.xml:827: There were test failures: 233 suites, 965 tests, 3 suite-level errors, 1 error, 839 ignored

Total time: 139 minutes 41 seconds
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