Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-MacOSX/1875/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseParallelGC

1 tests failed.
REGRESSION:  org.apache.solr.TestDistributedGrouping.testDistribSearch

Error Message:
Request took too long during query expansion. Terminating request.

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Request 
took too long during query expansion. Terminating request.
        at 
__randomizedtesting.SeedInfo.seed([C03DCB58EDB3977E:41DB45409AECF742]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:570)
        at 
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
        at 
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
        at 
org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:91)
        at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:512)
        at 
org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:274)
        at 
org.apache.solr.TestDistributedGrouping.doTest(TestDistributedGrouping.java:262)
        at 
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:875)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10808 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedGrouping
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/init-core-data-001
   [junit4]   2> 99389 T214 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(true) and clientAuth (false)
   [junit4]   2> 99390 T214 oas.BaseDistributedSearchTestCase.initHostContext 
Setting hostContext system property: /e_f/
   [junit4]   2> 99415 T214 oas.SolrTestCaseJ4.setUp ###Starting 
testDistribSearch
   [junit4]   2> 100415 T214 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 101304 T214 oejus.SslContextFactory.doStart Enabled Protocols 
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, 
TLSv1.1, TLSv1.2]
   [junit4]   2> 101373 T214 oejs.AbstractConnector.doStart Started 
[email protected]:49238
   [junit4]   2> 101636 T214 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 101638 T214 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 101638 T214 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr
   [junit4]   2> 101639 T214 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/'
   [junit4]   2> 101715 T214 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/solr.xml
   [junit4]   2> 101851 T214 oasc.CoreContainer.<init> New CoreContainer 
1047850007
   [junit4]   2> 101852 T214 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/]
   [junit4]   2> 101855 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 90000
   [junit4]   2> 101856 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: https
   [junit4]   2> 101857 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 15000
   [junit4]   2> 101857 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 101858 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 101859 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 101860 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 101861 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 101861 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 101865 T214 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 101869 T214 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 101869 T214 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 101869 T214 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 101878 T226 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 101881 T226 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 101882 T226 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 101883 T226 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 101999 T226 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
6.0.0
   [junit4]   2> 102097 T226 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 102099 T226 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 102123 T226 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 102825 T226 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 102837 T226 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 102841 T226 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 102867 T226 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 102873 T226 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 102879 T226 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 102882 T226 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 102882 T226 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 102883 T226 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 102883 T226 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 102884 T226 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 102884 T226 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 102884 T226 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 102885 T226 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/,
 
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data/
   [junit4]   2> 102886 T226 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@477dfc2e
   [junit4]   2> 102888 T226 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data
   [junit4]   2> 102889 T226 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data/index/
   [junit4]   2> 102889 T226 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 102890 T226 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data/index
   [junit4]   2> 102891 T226 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=7.939453125, 
floorSegmentMB=1.8701171875, forceMergeDeletesPctAllowed=18.315739561755453, 
segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.19399700808886877
   [junit4]   2> 102892 T226 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RateLimitedDirectoryWrapper(RAMDirectory(id=lucene-7a363633)))),segFN=segments_1,generation=1}
   [junit4]   2> 102892 T226 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 102893 T226 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 102900 T226 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 102901 T226 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 102901 T226 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 102902 T226 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 102902 T226 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 102902 T226 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 102903 T226 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 102904 T226 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 102904 T226 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 102905 T226 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 102905 T226 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 102906 T226 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 102907 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 102909 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 102910 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 102910 T226 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 102911 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 102911 T226 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 102912 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 102912 T226 oasc.RequestHandlers.initHandlersFromConfig 
created dismax: solr.SearchHandler
   [junit4]   2> 102913 T226 oasc.RequestHandlers.initHandlersFromConfig 
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 102914 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 102915 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 102916 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 102917 T226 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 102917 T226 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 102917 T226 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 102918 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 102919 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 102920 T226 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 102921 T226 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 102922 T226 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 102922 T226 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak_Direct: 
org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 102923 T226 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 102923 T226 oasc.RequestHandlers.initHandlersFromConfig 
created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 102924 T226 oasc.RequestHandlers.initHandlersFromConfig 
created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 102925 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 102926 T226 oasc.RequestHandlers.initHandlersFromConfig 
created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 102942 T226 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 102946 T226 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 102948 T226 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 102950 T226 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 102951 T226 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 102955 T226 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 102956 T226 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 102957 T226 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.42175643771216675]
   [junit4]   2> 102958 T226 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RateLimitedDirectoryWrapper(RAMDirectory(id=lucene-7a363633)))),segFN=segments_1,generation=1}
   [junit4]   2> 102958 T226 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 102959 T226 oass.SolrIndexSearcher.<init> Opening 
Searcher@6efbb783[collection1] main
   [junit4]   2> 102960 T226 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 102960 T226 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 102960 T226 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 102961 T226 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 102961 T226 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 102962 T226 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 102987 T226 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 103070 T227 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@6efbb783[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 103081 T226 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 103087 T214 oass.SolrDispatchFilter.init 
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 103087 T214 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 103136 T214 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 103147 T214 oejus.SslContextFactory.doStart Enabled Protocols 
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, 
TLSv1.1, TLSv1.2]
   [junit4]   2> 103152 T214 oejs.AbstractConnector.doStart Started 
[email protected]:49239
   [junit4]   2> 103156 T214 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 103157 T214 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 103157 T214 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr
   [junit4]   2> 103157 T214 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/'
   [junit4]   2> 103203 T214 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/solr.xml
   [junit4]   2> 103284 T214 oasc.CoreContainer.<init> New CoreContainer 
1942507843
   [junit4]   2> 103284 T214 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/]
   [junit4]   2> 103286 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
socketTimeout to: 90000
   [junit4]   2> 103286 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
urlScheme to: https
   [junit4]   2> 103286 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
connTimeout to: 15000
   [junit4]   2> 103286 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
maxConnectionsPerHost to: 20
   [junit4]   2> 103287 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
corePoolSize to: 0
   [junit4]   2> 103288 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
maximumPoolSize to: 2147483647
   [junit4]   2> 103288 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
maxThreadIdleTime to: 5
   [junit4]   2> 103288 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
sizeOfQueue to: -1
   [junit4]   2> 103289 T214 oashc.HttpShardHandlerFactory.getParameter Setting 
fairnessPolicy to: false
   [junit4]   2> 103292 T214 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 103295 T214 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 103295 T214 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 103296 T214 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 103303 T238 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 103306 T238 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 103306 T238 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 103308 T238 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 103408 T238 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
6.0.0
   [junit4]   2> 103510 T238 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 103513 T238 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 103530 T238 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 104052 T238 oass.OpenExchangeRatesOrgProvider.init Initialized 
with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 104085 T238 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 104093 T238 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 104130 T238 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 104137 T238 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 104143 T238 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 104144 T238 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 104145 T238 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 104146 T238 oass.OpenExchangeRatesOrgProvider.reload Reloading 
exchange rates from open-exchange-rates.json
   [junit4]   2> 104146 T238 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 104147 T238 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 104148 T238 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 104149 T238 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 104149 T238 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/core/src/test-files/solr/collection1/,
 
dataDir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data/
   [junit4]   2> 104150 T238 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@477dfc2e
   [junit4]   2> 104151 T238 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data
   [junit4]   2> 104151 T238 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data/index/
   [junit4]   2> 104152 T238 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 104153 T238 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data/index
   [junit4]   2> 104153 T238 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=37, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=7.939453125, 
floorSegmentMB=1.8701171875, forceMergeDeletesPctAllowed=18.315739561755453, 
segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.19399700808886877
   [junit4]   2> 104156 T238 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RateLimitedDirectoryWrapper(RAMDirectory(id=lucene-30ffcdae)))),segFN=segments_1,generation=1}
   [junit4]   2> 104156 T238 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 104157 T238 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 104170 T238 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 104171 T238 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 104172 T238 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 104172 T238 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 104173 T238 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 104173 T238 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 104174 T238 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 104175 T238 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 104175 T238 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 104175 T238 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 104176 T238 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 104176 T238 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 104178 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 104179 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 104179 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 104180 T238 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 104180 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 104182 T238 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 104182 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 104183 T238 oasc.RequestHandlers.initHandlersFromConfig 
created dismax: solr.SearchHandler
   [junit4]   2> 104184 T238 oasc.RequestHandlers.initHandlersFromConfig 
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 104186 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 104188 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 104189 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 104191 T238 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 104192 T238 oasc.RequestHandlers.initHandlersFromConfig adding 
lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 104192 T238 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 104193 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 104196 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 104197 T238 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 104197 T238 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 104198 T238 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 104199 T238 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak_Direct: 
org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 104200 T238 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 104218 T238 oasc.RequestHandlers.initHandlersFromConfig 
created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 104226 T238 oasc.RequestHandlers.initHandlersFromConfig 
created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 104227 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 104229 T238 oasc.RequestHandlers.initHandlersFromConfig 
created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 104259 T238 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 104262 T238 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 104266 T238 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 104270 T238 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 104275 T238 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 104280 T238 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 104281 T238 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 104282 T238 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: 
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=14, 
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, 
calibrateSizeByDeletes=false, maxMergeDocs=2147483647, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.42175643771216675]
   [junit4]   2> 104283 T238 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RateLimitedDirectoryWrapper(RAMDirectory(id=lucene-30ffcdae)))),segFN=segments_1,generation=1}
   [junit4]   2> 104283 T238 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 104285 T238 oass.SolrIndexSearcher.<init> Opening 
Searcher@691996d4[collection1] main
   [junit4]   2> 104286 T238 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 104286 T238 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 104287 T238 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 104288 T238 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 104288 T238 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 104288 T238 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 104310 T238 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 104405 T239 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@691996d4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 104419 T238 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 104420 T214 oass.SolrDispatchFilter.init 
user.dir=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 104421 T214 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> ASYNC  NEW_CORE C1 name=collection1 
org.apache.solr.core.SolrCore@118b9d53
   [junit4]   2> 106368 T222 C1 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 106371 T222 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 43
   [junit4]   2> ASYNC  NEW_CORE C2 name=collection1 
org.apache.solr.core.SolrCore@22340d4e
   [junit4]   2> 106623 T231 C2 oasu.DirectUpdateHandler2.deleteAll 
[collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 106625 T231 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 3
   [junit4]   2> 106654 T225 C1 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 106659 T225 C1 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RateLimitedDirectoryWrapper(RAMDirectory(id=lucene-7a363633)))),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RateLimitedDirectoryWrapper(RAMDirectory(id=lucene-7a363633)))),segFN=segments_2,generation=2}
   [junit4]   2> 106662 T225 C1 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 106664 T225 C1 oass.SolrIndexSearcher.<init> Opening 
Searcher@6abc3ad4[collection1] main
   [junit4]   2> 106666 T225 C1 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 106676 T227 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@6abc3ad4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 106679 T225 C1 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update 
params={commit=true&wt=javabin&softCommit=false&version=2&waitSearcher=true} 
{commit=} 0 25
   [junit4]   2> 106701 T232 C2 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 106705 T232 C2 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RateLimitedDirectoryWrapper(RAMDirectory(id=lucene-30ffcdae)))),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RateLimitedDirectoryWrapper(RAMDirectory(id=lucene-30ffcdae)))),segFN=segments_2,generation=2}
   [junit4]   2> 106708 T232 C2 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 2
   [junit4]   2> 106710 T232 C2 oass.SolrIndexSearcher.<init> Opening 
Searcher@7bc520e2[collection1] main
   [junit4]   2> 106711 T232 C2 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 106715 T239 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7bc520e2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 106718 T232 C2 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update 
params={commit=true&wt=javabin&softCommit=false&version=2&waitSearcher=true} 
{commit=} 0 17
   [junit4]   2> 106954 T221 C1 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&version=2&q=*:*&distrib=false&sort=a_i1+asc,+id+asc&fl=id,a_i1}
 hits=0 status=0 QTime=203 
   [junit4]   2> 107298 T231 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=https://127.0.0.1:49239/e_f|[ff01::083]:33332/e_f|[ff01::213]:33332/e_f|[ff01::114]:33332/e_f&rows=100&NOW=1412831101412&group.limit=10&group.field=a_i1&sort=a_i1+asc,+id+asc&start=0&group.distributed.first=true&group=true&wt=javabin&isShard=true&version=2&q=*:*&distrib=false&fl=id}
 status=0 QTime=167 
   [junit4]   2> 107384 T233 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shards=https://127.0.0.1:49239/e_f|[ff01::083]:33332/e_f|[ff01::213]:33332/e_f|[ff01::114]:33332/e_f&group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&version=2&q=*:*&sort=a_i1+asc,+id+asc&fl=id,a_i1}
 status=0 QTime=410 
   [junit4]   2> 107524 T223 C1 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={group=true&wt=javabin&hl.fl=a_t&hl=true&rows=100&group.limit=10&group.field=a_i1&version=2&q=*:*&distrib=false&sort=a_i1+asc,+id+asc&fl=id,a_i1}
 hits=0 status=0 QTime=123 
   [junit4]   2> 107553 T235 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=https://127.0.0.1:49239/e_f|[ff01::213]:33332/e_f|[ff01::114]:33332/e_f|[ff01::083]:33332/e_f&rows=100&NOW=1412831101981&group.limit=10&group.field=a_i1&sort=a_i1+asc,+id+asc&start=0&group.distributed.first=true&group=true&wt=javabin&hl.fl=a_t&hl=false&isShard=true&version=2&q=*:*&distrib=false&fl=id}
 status=0 QTime=1 
   [junit4]   2> 107563 T234 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shards=https://127.0.0.1:49239/e_f|[ff01::213]:33332/e_f|[ff01::114]:33332/e_f|[ff01::083]:33332/e_f&group=true&wt=javabin&hl.fl=a_t&hl=true&rows=100&group.limit=10&group.field=a_i1&version=2&q=*:*&sort=a_i1+asc,+id+asc&fl=id,a_i1}
 status=0 QTime=20 
   [junit4]   2> 107717 T222 C1 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={facet=true&group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&version=2&q=*:*&distrib=false&sort=a_i1+asc,+id+asc&facet.field=a_t&fl=id,a_i1}
 hits=0 status=0 QTime=141 
   [junit4]   2> 107743 T231 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=https://127.0.0.1:49239/e_f&rows=100&NOW=1412831102170&group.limit=10&group.field=a_i1&sort=a_i1+asc,+id+asc&start=0&group.distributed.first=true&facet=false&group=true&wt=javabin&isShard=true&version=2&q=*:*&distrib=false&facet.field=a_t&fl=id}
 status=0 QTime=1 
   [junit4]   2> 107852 T233 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=https://127.0.0.1:49239/e_f&rows=100&NOW=1412831102170&f.a_t.facet.mincount=0&group.limit=10&group.field=a_i1&sort=a_i1+asc,+id+asc&start=0&facet=true&group=true&wt=javabin&isShard=true&version=2&q=*:*&distrib=false&f.a_t.facet.limit=160&facet.field=a_t&group.distributed.second=true&fl=id}
 status=0 QTime=65 
   [junit4]   2> 107883 T236 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shards=https://127.0.0.1:49239/e_f&facet=true&group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&version=2&q=*:*&sort=a_i1+asc,+id+asc&facet.field=a_t&fl=id,a_i1}
 status=0 QTime=151 
   [junit4]   2> 107936 T225 C1 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={stats.field=a_i1&group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&version=2&q=*:*&distrib=false&sort=a_i1+asc,+id+asc&stats=true&fl=id,a_i1}
 hits=0 status=0 QTime=44 
   [junit4]   2> 107957 T234 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=https://127.0.0.1:49239/e_f&rows=100&NOW=1412831102384&group.limit=10&group.field=a_i1&sort=a_i1+asc,+id+asc&stats=false&start=0&group.distributed.first=true&stats.field=a_i1&group=true&wt=javabin&isShard=true&version=2&q=*:*&distrib=false&fl=id}
 status=0 QTime=1 
   [junit4]   2> 107971 T231 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=https://127.0.0.1:49239/e_f&rows=100&NOW=1412831102384&group.limit=10&group.field=a_i1&sort=a_i1+asc,+id+asc&stats=true&start=0&stats.field=a_i1&group=true&wt=javabin&isShard=true&version=2&q=*:*&distrib=false&group.distributed.second=true&fl=id}
 status=0 QTime=1 
   [junit4]   2> 107975 T235 C2 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shards=https://127.0.0.1:49239/e_f&stats.field=a_i1&group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&version=2&q=*:*&sort=a_i1+asc,+id+asc&stats=true&fl=id,a_i1}
 status=0 QTime=29 
   [junit4]   2> ASYNC  NEW_CORE C3 name=collection1 
org.apache.solr.core.SolrCore@118b9d53
   [junit4]   2> 108360 T219 C3 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&version=2&q=kings&distrib=false&spellcheck=true&sort=a_i1+asc,+id+asc&qt=spellCheckCompRH&spellcheck.build=true&fl=id,a_i1}
 hits=0 status=0 QTime=362 
   [junit4]   2> ASYNC  NEW_CORE C4 name=collection1 
org.apache.solr.core.SolrCore@22340d4e
   [junit4]   2> 108398 T236 C4 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=[ff01::083]:33332/e_f|https://127.0.0.1:49239/e_f&spellcheck.extendedResults=false&rows=100&NOW=1412831102812&group.limit=10&group.field=a_i1&spellcheck=true&sort=a_i1+asc,+id+asc&start=0&group.distributed.first=true&spellcheck.onlyMorePopular=false&group=true&spellcheck.count=5&wt=javabin&isShard=true&version=2&q=kings&distrib=false&spellcheck.build=true&fl=id}
 status=0 QTime=2 
   [junit4]   2> 108405 T233 C4 oashc.SpellCheckComponent.finishStage 
[ff01::083]:33332/e_f|https://127.0.0.1:49239/e_f null
   [junit4]   2> 108406 T233 C4 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shards=[ff01::083]:33332/e_f|https://127.0.0.1:49239/e_f&group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&version=2&q=kings&spellcheck=true&sort=a_i1+asc,+id+asc&qt=spellCheckCompRH&spellcheck.build=true&fl=id,a_i1}
 status=0 QTime=32 
   [junit4]   2> 108477 T223 C3 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={facet=true&group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&fq=a_s:a&version=2&q=*:*&distrib=false&sort=a_i1+asc,+id+asc&facet.field=a_t&group.truncate=true&fl=id,a_i1}
 hits=0 status=0 QTime=64 
   [junit4]   2> 108493 T231 C4 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=https://127.0.0.1:49239/e_f&rows=100&NOW=1412831102924&group.limit=10&group.field=a_i1&fq=a_s:a&sort=a_i1+asc,+id+asc&start=0&group.distributed.first=true&facet=false&group=true&wt=javabin&isShard=true&version=2&q=*:*&distrib=false&facet.field=a_t&group.truncate=true&fl=id}
 status=0 QTime=1 
   [junit4]   2> 108505 T235 C4 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shard.url=https://127.0.0.1:49239/e_f&rows=100&NOW=1412831102924&f.a_t.facet.mincount=0&group.limit=10&group.field=a_i1&fq=a_s:a&sort=a_i1+asc,+id+asc&start=0&facet=true&group=true&wt=javabin&isShard=true&version=2&q=*:*&distrib=false&f.a_t.facet.limit=160&facet.field=a_t&group.truncate=true&group.distributed.second=true&fl=id}
 status=0 QTime=3 
   [junit4]   2> 108509 T234 C4 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shards=https://127.0.0.1:49239/e_f&facet=true&group=true&wt=javabin&rows=100&group.limit=10&group.field=a_i1&fq=a_s:a&version=2&q=*:*&sort=a_i1+asc,+id+asc&facet.field=a_t&group.truncate=true&fl=id,a_i1}
 status=0 QTime=23 
   [junit4]   2> 108560 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[1]} 0 33
   [junit4]   2> 108581 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[1]} 0 14
   [junit4]   2> 108597 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[2]} 0 7
   [junit4]   2> 108608 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[2]} 0 4
   [junit4]   2> 108619 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[3]} 0 5
   [junit4]   2> 108631 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[3]} 0 3
   [junit4]   2> 108645 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[4]} 0 6
   [junit4]   2> 108659 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[4]} 0 6
   [junit4]   2> 108669 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[5]} 0 4
   [junit4]   2> 108681 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[5]} 0 4
   [junit4]   2> 108693 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[6]} 0 5
   [junit4]   2> 108705 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[6]} 0 6
   [junit4]   2> 108717 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[7]} 0 3
   [junit4]   2> 108728 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[7]} 0 1
   [junit4]   2> 108748 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[8]} 0 6
   [junit4]   2> 108765 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[8]} 0 7
   [junit4]   2> 108787 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[9]} 0 4
   [junit4]   2> 108804 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[9]} 0 4
   [junit4]   2> 108820 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[10]} 0 3
   [junit4]   2> 108842 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[10]} 0 11
   [junit4]   2> 108855 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[11]} 0 4
   [junit4]   2> 108872 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[11]} 0 2
   [junit4]   2> 108895 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[12]} 0 11
   [junit4]   2> 108940 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[12]} 0 14
   [junit4]   2> 108964 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[14]} 0 6
   [junit4]   2> 108975 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[14]} 0 3
   [junit4]   2> 109003 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[15]} 0 15
   [junit4]   2> 109015 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[15]} 0 3
   [junit4]   2> 109029 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[16]} 0 3
   [junit4]   2> 109053 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[16]} 0 4
   [junit4]   2> 109073 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[17]} 0 10
   [junit4]   2> 109094 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[17]} 0 12
   [junit4]   2> 109104 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[18]} 0 2
   [junit4]   2> 109118 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[18]} 0 5
   [junit4]   2> 109132 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[19]} 0 6
   [junit4]   2> 109147 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[19]} 0 3
   [junit4]   2> 109157 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[20]} 0 2
   [junit4]   2> 109167 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[20]} 0 3
   [junit4]   2> 109193 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[21]} 0 14
   [junit4]   2> 109212 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[21]} 0 9
   [junit4]   2> 109223 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[22]} 0 1
   [junit4]   2> 109234 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[22]} 0 5
   [junit4]   2> 109245 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[23]} 0 5
   [junit4]   2> 109260 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[23]} 0 4
   [junit4]   2> 109269 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[100]} 0 1
   [junit4]   2> 109280 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[100]} 0 3
   [junit4]   2> 109309 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[101]} 0 2
   [junit4]   2> 109318 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[101]} 0 2
   [junit4]   2> 109333 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[102]} 0 3
   [junit4]   2> 109345 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[102]} 0 2
   [junit4]   2> 109359 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[103]} 0 2
   [junit4]   2> 109370 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[103]} 0 2
   [junit4]   2> 109388 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[104]} 0 2
   [junit4]   2> 109405 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[104]} 0 9
   [junit4]   2> 109423 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[105]} 0 11
   [junit4]   2> 109442 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[105]} 0 3
   [junit4]   2> 109451 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[106]} 0 2
   [junit4]   2> 109460 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[106]} 0 3
   [junit4]   2> 109467 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[107]} 0 2
   [junit4]   2> 109484 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[107]} 0 2
   [junit4]   2> 109506 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[108]} 0 12
   [junit4]   2> 109526 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[108]} 0 11
   [junit4]   2> 109553 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[109]} 0 2
   [junit4]   2> 109574 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[109]} 0 3
   [junit4]   2> 109599 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[110]} 0 3
   [junit4]   2> 109612 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[110]} 0 2
   [junit4]   2> 109636 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[111]} 0 10
   [junit4]   2> 109650 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[111]} 0 3
   [junit4]   2> 109684 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[112]} 0 3
   [junit4]   2> 109693 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[112]} 0 2
   [junit4]   2> 109701 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[113]} 0 2
   [junit4]   2> 109708 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[113]} 0 1
   [junit4]   2> 109717 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[114]} 0 2
   [junit4]   2> 109726 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[114]} 0 3
   [junit4]   2> 109734 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[115]} 0 2
   [junit4]   2> 109741 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[115]} 0 1
   [junit4]   2> 109748 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[116]} 0 2
   [junit4]   2> 109756 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[116]} 0 1
   [junit4]   2> 109766 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[117]} 0 2
   [junit4]   2> 109776 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[117]} 0 3
   [junit4]   2> 109784 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[118]} 0 0
   [junit4]   2> 109792 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[118]} 0 2
   [junit4]   2> 109801 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[119]} 0 2
   [junit4]   2> 109811 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[119]} 0 3
   [junit4]   2> 109822 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[120]} 0 3
   [junit4]   2> 109829 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[120]} 0 2
   [junit4]   2> 109839 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[121]} 0 3
   [junit4]   2> 109845 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[121]} 0 0
   [junit4]   2> 109857 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[122]} 0 1
   [junit4]   2> 109868 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[122]} 0 2
   [junit4]   2> 109876 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[123]} 0 2
   [junit4]   2> 109885 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[123]} 0 3
   [junit4]   2> 109893 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[124]} 0 2
   [junit4]   2> 109903 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[124]} 0 1
   [junit4]   2> 109910 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[125]} 0 1
   [junit4]   2> 109917 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[125]} 0 2
   [junit4]   2> 109925 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[126]} 0 2
   [junit4]   2> 109931 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[126]} 0 2
   [junit4]   2> 109938 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[127]} 0 0
   [junit4]   2> 109945 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[127]} 0 2
   [junit4]   2> 109952 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[128]} 0 2
   [junit4]   2> 109959 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[128]} 0 2
   [junit4]   2> 109967 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[129]} 0 4
   [junit4]   2> 109975 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[129]} 0 2
   [junit4]   2> 109983 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[130]} 0 2
   [junit4]   2> 109989 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[130]} 0 2
   [junit4]   2> 109996 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[131]} 0 0
   [junit4]   2> 110005 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[131]} 0 3
   [junit4]   2> 110014 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[132]} 0 1
   [junit4]   2> 110020 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[132]} 0 0
   [junit4]   2> 110035 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[133]} 0 0
   [junit4]   2> 110045 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[133]} 0 2
   [junit4]   2> 110056 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[134]} 0 2
   [junit4]   2> 110074 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[134]} 0 4
   [junit4]   2> 110085 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[135]} 0 1
   [junit4]   2> 110091 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[135]} 0 0
   [junit4]   2> 110098 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[136]} 0 0
   [junit4]   2> 110104 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[136]} 0 1
   [junit4]   2> 110112 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[137]} 0 0
   [junit4]   2> 110118 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[137]} 0 1
   [junit4]   2> 110126 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[138]} 0 1
   [junit4]   2> 110136 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[138]} 0 1
   [junit4]   2> 110154 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[139]} 0 2
   [junit4]   2> 110162 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[139]} 0 1
   [junit4]   2> 110170 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[140]} 0 2
   [junit4]   2> 110178 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[140]} 0 1
   [junit4]   2> 110187 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[141]} 0 2
   [junit4]   2> 110195 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[141]} 0 2
   [junit4]   2> 110202 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[142]} 0 2
   [junit4]   2> 110208 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[142]} 0 0
   [junit4]   2> 110215 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[143]} 0 2
   [junit4]   2> 110221 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[143]} 0 2
   [junit4]   2> 110227 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[144]} 0 0
   [junit4]   2> 110234 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[144]} 0 0
   [junit4]   2> 110244 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[145]} 0 1
   [junit4]   2> 110251 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[145]} 0 1
   [junit4]   2> 110260 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[146]} 0 1
   [junit4]   2> 110270 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[146]} 0 3
   [junit4]   2> 110283 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[147]} 0 1
   [junit4]   2> 110295 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[147]} 0 1
   [junit4]   2> 110308 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[148]} 0 2
   [junit4]   2> 110321 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[148]} 0 2
   [junit4]   2> 110328 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[149]} 0 2
   [junit4]   2> 110335 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[149]} 0 1
   [junit4]   2> 110351 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[500]} 0 1
   [junit4]   2> 110358 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[500]} 0 0
   [junit4]   2> 110364 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[501]} 0 0
   [junit4]   2> 110371 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[501]} 0 0
   [junit4]   2> 110377 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[502]} 0 0
   [junit4]   2> 110384 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[502]} 0 1
   [junit4]   2> 110390 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[503]} 0 1
   [junit4]   2> 110398 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[503]} 0 1
   [junit4]   2> 110405 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[504]} 0 0
   [junit4]   2> 110411 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[504]} 0 1
   [junit4]   2> 110423 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[505]} 0 2
   [junit4]   2> 110428 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[505]} 0 1
   [junit4]   2> 110434 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[506]} 0 0
   [junit4]   2> 110441 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[506]} 0 0
   [junit4]   2> 110448 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[507]} 0 0
   [junit4]   2> 110455 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[507]} 0 2
   [junit4]   2> 110460 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[508]} 0 0
   [junit4]   2> 110466 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[508]} 0 0
   [junit4]   2> 110472 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[509]} 0 0
   [junit4]   2> 110476 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[509]} 0 0
   [junit4]   2> 110483 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[510]} 0 1
   [junit4]   2> 110489 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[510]} 0 1
   [junit4]   2> 110496 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[511]} 0 1
   [junit4]   2> 110501 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[511]} 0 0
   [junit4]   2> 110506 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[512]} 0 0
   [junit4]   2> 110512 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[512]} 0 0
   [junit4]   2> 110521 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[513]} 0 0
   [junit4]   2> 110533 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[513]} 0 0
   [junit4]   2> 110541 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[514]} 0 0
   [junit4]   2> 110547 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[514]} 0 1
   [junit4]   2> 110553 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[515]} 0 1
   [junit4]   2> 110558 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[515]} 0 0
   [junit4]   2> 110565 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[516]} 0 1
   [junit4]   2> 110573 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[516]} 0 1
   [junit4]   2> 110579 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[517]} 0 1
   [junit4]   2> 110585 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[517]} 0 0
   [junit4]   2> 110592 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[518]} 0 1
   [junit4]   2> 110604 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[518]} 0 0
   [junit4]   2> 110609 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[519]} 0 1
   [junit4]   2> 110616 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[519]} 0 0
   [junit4]   2> 110622 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[520]} 0 1
   [junit4]   2> 110631 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[520]} 0 1
   [junit4]   2> 110638 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[521]} 0 0
   [junit4]   2> 110644 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[521]} 0 0
   [junit4]   2> 110650 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[522]} 0 0
   [junit4]   2> 110656 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[522]} 0 1
   [junit4]   2> 110661 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[523]} 0 0
   [junit4]   2> 110666 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[523]} 0 1
   [junit4]   2> 110672 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[524]} 0 0
   [junit4]   2> 110679 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[524]} 0 2
   [junit4]   2> 110685 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[525]} 0 0
   [junit4]   2> 110690 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[525]} 0 1
   [junit4]   2> 110697 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[526]} 0 0
   [junit4]   2> 110702 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[526]} 0 1
   [junit4]   2> 110708 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[527]} 0 1
   [junit4]   2> 110714 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[527]} 0 0
   [junit4]   2> 110719 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[528]} 0 0
   [junit4]   2> 110726 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[528]} 0 1
   [junit4]   2> 110731 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[529]} 0 1
   [junit4]   2> 110739 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[529]} 0 0
   [junit4]   2> 110750 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[530]} 0 2
   [junit4]   2> 110757 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[530]} 0 1
   [junit4]   2> 110774 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[531]} 0 0
   [junit4]   2> 110781 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[531]} 0 1
   [junit4]   2> 110787 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[532]} 0 1
   [junit4]   2> 110792 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[532]} 0 0
   [junit4]   2> 110798 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[533]} 0 0
   [junit4]   2> 110803 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[533]} 0 0
   [junit4]   2> 110811 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[534]} 0 1
   [junit4]   2> 110820 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[534]} 0 0
   [junit4]   2> 110825 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[535]} 0 1
   [junit4]   2> 110833 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[535]} 0 1
   [junit4]   2> 110839 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[536]} 0 1
   [junit4]   2> 110852 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[536]} 0 0
   [junit4]   2> 110859 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[537]} 0 1
   [junit4]   2> 110865 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[537]} 0 1
   [junit4]   2> 110871 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[538]} 0 0
   [junit4]   2> 110877 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[538]} 0 1
   [junit4]   2> 110888 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[539]} 0 3
   [junit4]   2> 110893 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[539]} 0 0
   [junit4]   2> 110900 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[540]} 0 1
   [junit4]   2> 110906 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[540]} 0 0
   [junit4]   2> 110913 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[541]} 0 1
   [junit4]   2> 110920 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[541]} 0 2
   [junit4]   2> 110928 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[542]} 0 1
   [junit4]   2> 110932 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[542]} 0 0
   [junit4]   2> 110939 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[543]} 0 1
   [junit4]   2> 110948 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[543]} 0 0
   [junit4]   2> 110953 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[544]} 0 1
   [junit4]   2> 110961 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[544]} 0 1
   [junit4]   2> 110970 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[545]} 0 1
   [junit4]   2> 110980 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[545]} 0 2
   [junit4]   2> 110986 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[546]} 0 0
   [junit4]   2> 110995 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[546]} 0 1
   [junit4]   2> 111013 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[547]} 0 2
   [junit4]   2> 111065 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[547]} 0 2
   [junit4]   2> 111083 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[548]} 0 2
   [junit4]   2> 111102 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[548]} 0 1
   [junit4]   2> 111114 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[549]} 0 2
   [junit4]   2> 111133 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[549]} 0 3
   [junit4]   2> 111148 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[550]} 0 0
   [junit4]   2> 111170 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[550]} 0 0
   [junit4]   2> 111200 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[551]} 0 0
   [junit4]   2> 111215 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[551]} 0 1
   [junit4]   2> 111224 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[552]} 0 0
   [junit4]   2> 111233 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[552]} 0 0
   [junit4]   2> 111251 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[553]} 0 0
   [junit4]   2> 111265 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[553]} 0 0
   [junit4]   2> 111298 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[554]} 0 1
   [junit4]   2> 111318 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[554]} 0 12
   [junit4]   2> 111333 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[555]} 0 0
   [junit4]   2> 111338 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[555]} 0 0
   [junit4]   2> 111346 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[556]} 0 1
   [junit4]   2> 111353 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[556]} 0 1
   [junit4]   2> 111359 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[557]} 0 1
   [junit4]   2> 111367 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[557]} 0 0
   [junit4]   2> 111376 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[558]} 0 0
   [junit4]   2> 111383 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[558]} 0 1
   [junit4]   2> 111388 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[559]} 0 0
   [junit4]   2> 111395 T236 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[559]} 0 0
   [junit4]   2> 111407 T219 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[560]} 0 1
   [junit4]   2> 111417 T233 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[560]} 0 0
   [junit4]   2> 111423 T225 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[561]} 0 1
   [junit4]   2> 111437 T232 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[561]} 0 1
   [junit4]   2> 111445 T222 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[562]} 0 1
   [junit4]   2> 111451 T235 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[562]} 0 1
   [junit4]   2> 111456 T223 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[563]} 0 0
   [junit4]   2> 111461 T231 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[563]} 0 1
   [junit4]   2> 111466 T221 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[564]} 0 1
   [junit4]   2> 111472 T234 C4 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[564]} 0 0
   [junit4]   2> 111478 T224 C3 oasup.LogUpdateProcessor.finish [collection1] 
webapp=/e_f path=/update params={wt=javabin&version=2} {add=[565]} 0 1
   [junit4]   2> 111485 T236 C4 oasup.LogUpdateProcessor.finis

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

                at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
   [junit4]   2>                at 
java.util.concurrent.FutureTask.run(FutureTask.java:262)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   [junit4]   2>                at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   [junit4]   2>                at java.lang.Thread.run(Thread.java:745)
   [junit4]   2>        
   [junit4]   2> 119275 T235 C5 oasc.SolrCore.execute [collection1] webapp=/e_f 
path=/select 
params={shards=https://127.0.0.1:49239/e_f&group=true&wt=javabin&rows=100&group.limit=10&version=2&timeAllowed=1&group.query=a_t:kings+OR+a_t:eggs&q=*:*&sort=a_i1+asc,+id+asc&fl=id,a_i1}
 status=400 QTime=84 
   [junit4]   2> 119295 T214 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1047850007
   [junit4]   2> 119296 T214 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@118b9d53
   [junit4]   2> 119370 T214 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=2,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=172,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 119375 T214 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 119377 T214 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 119378 T214 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 119383 T214 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 119388 T214 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 119389 T214 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data;done=false>>]
   [junit4]   2> 119391 T214 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data
   [junit4]   2> 119391 T214 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data/index
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data/index;done=false>>]
   [junit4]   2> 119392 T214 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/control/data/index
   [junit4]   2> 119401 T214 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/e_f,null}
   [junit4]   2> 124309 T214 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1942507843
   [junit4]   2> 124311 T214 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@22340d4e
   [junit4]   2> 124350 T214 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=2,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=172,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 124351 T214 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 124351 T214 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 124351 T214 oasu.DefaultSolrCoreState.closeIndexWriter closing 
IndexWriter with IndexWriterCloser
   [junit4]   2> 124354 T214 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 124356 T214 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 124358 T214 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data;done=false>>]
   [junit4]   2> 124358 T214 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data
   [junit4]   2> 124359 T214 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data/index
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data/index;done=false>>]
   [junit4]   2> 124360 T214 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001/tempDir-001/shard0/data/index
   [junit4]   2> 124367 T214 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/e_f,null}
   [junit4]   2> 129300 T214 oas.SolrTestCaseJ4.tearDown ###Ending 
testDistribSearch
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedGrouping -Dtests.method=testDistribSearch 
-Dtests.seed=C03DCB58EDB3977E -Dtests.slow=true -Dtests.locale=in 
-Dtests.timezone=America/Bahia_Banderas -Dtests.file.encoding=UTF-8
   [junit4] ERROR   30.0s | TestDistributedGrouping.testDistribSearch <<<
   [junit4]    > Throwable #1: 
org.apache.solr.client.solrj.impl.HttpSolrServer$RemoteSolrException: Request 
took too long during query expansion. Terminating request.
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([C03DCB58EDB3977E:41DB45409AECF742]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:570)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:215)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:211)
   [junit4]    >        at 
org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:91)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:512)
   [junit4]    >        at 
org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:274)
   [junit4]    >        at 
org.apache.solr.TestDistributedGrouping.doTest(TestDistributedGrouping.java:262)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:875)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 129397 T214 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping-C03DCB58EDB3977E-001
   [junit4]   2> NOTE: test params are: 
codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
 chunkSize=309), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST, 
chunkSize=309)), sim=DefaultSimilarity, locale=in, 
timezone=America/Bahia_Banderas
   [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_67 
(64-bit)/cpus=2,threads=2,free=158838024,total=239599616
   [junit4]   2> NOTE: All tests run in this JVM: 
[LeaderElectionIntegrationTest, TestCharFilters, TestDistributedGrouping]
   [junit4] Completed in 30.15s, 1 test, 1 error <<< FAILURES!

[...truncated 1378 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:524: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:472: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/build.xml:61: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/extra-targets.xml:39: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/build.xml:189: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/solr/common-build.xml:496: 
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:1359: 
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-trunk-MacOSX/lucene/common-build.xml:961: 
There were test failures: 437 suites, 1784 tests, 1 error, 48 ignored (20 
assumptions)

Total time: 180 minutes 21 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.7.0 
-XX:-UseCompressedOops -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to