[JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.7.0) - Build # 1822 - Still Failing!

[Policeman Jenkins Server]

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/1822/
Java: 64bit/jdk1.7.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
REGRESSION:  org.apache.solr.TestDistributedSearch.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([2E3B19871D967C87:AFDD979F6AC91CBB]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:568)
        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.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:596)
        at 
org.apache.solr.TestDistributedSearch.doTest(TestDistributedSearch.java:499)
        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 10745 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/init-core-data-001
   [junit4]   2> 810335 T1800 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl 
(true) and clientAuth (false)
   [junit4]   2> 810335 T1800 oas.BaseDistributedSearchTestCase.initHostContext 
Setting hostContext system property: /
   [junit4]   2> 810341 T1800 oas.SolrTestCaseJ4.setUp ###Starting 
testDistribSearch
   [junit4]   2> 810344 T1800 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 810350 T1800 oejus.SslContextFactory.doStart Enabled Protocols 
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, 
TLSv1.1, TLSv1.2]
   [junit4]   2> 810355 T1800 oejs.AbstractConnector.doStart Started 
SslSelectChannelConnector@127.0.0.1:55266
   [junit4]   2> 810361 T1800 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 810361 T1800 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 810363 T1800 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr
   [junit4]   2> 810364 T1800 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/'
   [junit4]   2> 810413 T1800 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/solr.xml
   [junit4]   2> 810520 T1800 oasc.CoreContainer.<init> New CoreContainer 
1129455102
   [junit4]   2> 810521 T1800 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/]
   [junit4]   2> 810522 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 810522 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: https
   [junit4]   2> 810522 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 810522 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 810523 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 810523 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 810524 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 810524 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 810524 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 810528 T1800 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 810530 T1800 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 810531 T1800 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 810531 T1800 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 810544 T1810 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 810546 T1810 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 810547 T1810 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 810547 T1810 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 810653 T1810 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 810748 T1810 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 810750 T1810 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 810759 T1810 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 811424 T1810 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 811433 T1810 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 811436 T1810 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 811450 T1810 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 811457 T1810 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 811462 T1810 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 811463 T1810 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 811463 T1810 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 811470 T1810 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 811470 T1810 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 811470 T1810 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 811471 T1810 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 811471 T1810 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 811471 T1810 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/,
 
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/control/data/
   [junit4]   2> 811472 T1810 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6931ae4c
   [junit4]   2> 811472 T1810 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/control/data
   [junit4]   2> 811472 T1810 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/control/data/index/
   [junit4]   2> 811473 T1810 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/control/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 811473 T1810 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/control/data/index
   [junit4]   2> 811474 T1810 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.AlcoholicMergePolicy: 
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1005032052, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 811475 T1810 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-4a2ee216))),segFN=segments_1,generation=1}
   [junit4]   2> 811476 T1810 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 811476 T1810 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 811482 T1810 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 811483 T1810 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 811483 T1810 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 811483 T1810 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 811483 T1810 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 811483 T1810 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 811484 T1810 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 811484 T1810 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 811484 T1810 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 811485 T1810 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 811485 T1810 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 811486 T1810 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 811486 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 811487 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 811487 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 811488 T1810 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 811488 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 811489 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 811490 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 811491 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created dismax: solr.SearchHandler
   [junit4]   2> 811492 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 811493 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 811494 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 811496 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 811496 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 811497 T1810 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 811497 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 811497 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 811498 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 811499 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 811499 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 811499 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 811500 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak_Direct: 
org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 811501 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 811501 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 811502 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 811503 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 811503 T1810 oasc.RequestHandlers.initHandlersFromConfig 
created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 811517 T1810 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 811519 T1810 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 811521 T1810 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 811524 T1810 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 811526 T1810 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 811530 T1810 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 811531 T1810 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 811532 T1810 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=33, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 811533 T1810 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-4a2ee216))),segFN=segments_1,generation=1}
   [junit4]   2> 811533 T1810 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 811533 T1810 oass.SolrIndexSearcher.<init> Opening 
Searcher@7bc0f6d3[collection1] main
   [junit4]   2> 811534 T1810 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 811534 T1810 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 811535 T1810 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 811535 T1810 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 811536 T1810 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 811536 T1810 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 811549 T1810 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 811598 T1811 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7bc0f6d3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 811607 T1810 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 811609 T1800 oass.SolrDispatchFilter.init 
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 811609 T1800 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> 811613 T1800 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 811621 T1800 oejus.SslContextFactory.doStart Enabled Protocols 
[SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, 
TLSv1.1, TLSv1.2]
   [junit4]   2> 811624 T1800 oejs.AbstractConnector.doStart Started 
SslSelectChannelConnector@127.0.0.1:55267
   [junit4]   2> 811627 T1800 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init()
   [junit4]   2> 811628 T1800 oasc.SolrResourceLoader.locateSolrHome JNDI not 
configured for solr (NoInitialContextEx)
   [junit4]   2> 811628 T1800 oasc.SolrResourceLoader.locateSolrHome using 
system property solr.solr.home: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr
   [junit4]   2> 811628 T1800 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/'
   [junit4]   2> 811679 T1800 oasc.ConfigSolr.fromFile Loading container 
configuration from 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/solr.xml
   [junit4]   2> 811799 T1800 oasc.CoreContainer.<init> New CoreContainer 
1951863178
   [junit4]   2> 811800 T1800 oasc.CoreContainer.load Loading cores into 
CoreContainer 
[instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/]
   [junit4]   2> 811803 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting socketTimeout to: 90000
   [junit4]   2> 811804 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting urlScheme to: https
   [junit4]   2> 811805 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting connTimeout to: 15000
   [junit4]   2> 811805 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting maxConnectionsPerHost to: 20
   [junit4]   2> 811805 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting corePoolSize to: 0
   [junit4]   2> 811806 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting maximumPoolSize to: 2147483647
   [junit4]   2> 811807 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting maxThreadIdleTime to: 5
   [junit4]   2> 811807 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting sizeOfQueue to: -1
   [junit4]   2> 811808 T1800 oashc.HttpShardHandlerFactory.getParameter 
Setting fairnessPolicy to: false
   [junit4]   2> 811815 T1800 oasu.UpdateShardHandler.<init> Creating 
UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=false
   [junit4]   2> 811818 T1800 oasl.LogWatcher.createWatcher SLF4J impl is 
org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 811819 T1800 oasl.LogWatcher.newRegisteredLogWatcher 
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 811820 T1800 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 811829 T1822 oasc.SolrResourceLoader.<init> new 
SolrResourceLoader for directory: 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 811832 T1822 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 811832 T1822 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 811832 T1822 oasc.SolrResourceLoader.replaceClassLoader Adding 
'file:/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 811940 T1822 oasc.SolrConfig.<init> Using Lucene MatchVersion: 
5.0.0
   [junit4]   2> 812088 T1822 oasc.SolrConfig.<init> Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 812091 T1822 oass.IndexSchema.readSchema Reading Solr Schema 
from schema.xml
   [junit4]   2> 812107 T1822 oass.IndexSchema.readSchema [collection1] Schema 
name=test
   [junit4]   2> 812757 T1822 oass.OpenExchangeRatesOrgProvider.init 
Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 812769 T1822 oass.IndexSchema.readSchema default search field 
in schema is text
   [junit4]   2> 812773 T1822 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 812793 T1822 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 812799 T1822 oass.FileExchangeRateProvider.reload Reloading 
exchange rates from file currency.xml
   [junit4]   2> 812805 T1822 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 812807 T1822 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 812808 T1822 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 812809 T1822 oass.OpenExchangeRatesOrgProvider.reload 
Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 812810 T1822 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key 
IMPORTANT NOTE
   [junit4]   2> 812810 T1822 
oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, 
got STRING
   [junit4]   2> 812810 T1822 oasc.CoreContainer.create Creating SolrCore 
'collection1' using configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 812811 T1822 oasc.SolrCore.initDirectoryFactory 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 812811 T1822 oasc.SolrCore.<init> [collection1] Opening new 
SolrCore at 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/core/src/test-files/solr/collection1/,
 
dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data/
   [junit4]   2> 812812 T1822 oasc.JmxMonitoredMap.<init> JMX monitoring is 
enabled. Adding Solr mbeans to JMX Server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@6931ae4c
   [junit4]   2> 812813 T1822 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data
   [junit4]   2> 812813 T1822 oasc.SolrCore.getNewIndexDir New index directory 
detected: old=null 
new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data/index/
   [junit4]   2> 812813 T1822 oasc.SolrCore.initIndex WARN [collection1] Solr 
index directory 
'/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 812814 T1822 oasc.CachingDirectoryFactory.get return new 
directory for 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data/index
   [junit4]   2> 812816 T1822 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.AlcoholicMergePolicy: 
[AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1005032052, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 812817 T1822 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-35a4401a))),segFN=segments_1,generation=1}
   [junit4]   2> 812818 T1822 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 812819 T1822 oasc.SolrCore.initWriters created xml: 
solr.XMLResponseWriter
   [junit4]   2> 812840 T1822 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 812841 T1822 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 812842 T1822 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 812845 T1822 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"dedupe-allfields"
   [junit4]   2> 812846 T1822 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 812846 T1822 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 812847 T1822 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 812847 T1822 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 812848 T1822 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 812849 T1822 oasup.UpdateRequestProcessorChain.init creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 812850 T1822 oasup.UpdateRequestProcessorChain.init inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 812851 T1822 oasc.SolrCore.loadUpdateProcessorChains no 
updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 812852 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 812853 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 812853 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
   [junit4]   2> 812854 T1822 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 812855 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /replication: solr.ReplicationHandler
   [junit4]   2> 812856 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created standard: solr.StandardRequestHandler
   [junit4]   2> 812857 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /get: solr.RealTimeGetHandler
   [junit4]   2> 812859 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created dismax: solr.SearchHandler
   [junit4]   2> 812860 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 812861 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 812862 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 812863 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 812864 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created defaults: solr.StandardRequestHandler
   [junit4]   2> 812864 T1822 oasc.RequestHandlers.initHandlersFromConfig 
adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 812865 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created lazy: solr.StandardRequestHandler
   [junit4]   2> 812866 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /update: solr.UpdateRequestHandler
   [junit4]   2> 812868 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 812869 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 812869 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 812870 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 812871 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckWithWordbreak_Direct: 
org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 812872 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 812873 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 812874 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 812875 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 812877 T1822 oasc.RequestHandlers.initHandlersFromConfig 
created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 812900 T1822 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 812904 T1822 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 812908 T1822 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 812911 T1822 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 812913 T1822 oasc.SolrCore.initDeprecatedSupport WARN 
solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config 
to use the ShowFileRequestHandler.
   [junit4]   2> 812920 T1822 oasu.CommitTracker.<init> Hard AutoCommit: 
disabled
   [junit4]   2> 812921 T1822 oasu.CommitTracker.<init> Soft AutoCommit: 
disabled
   [junit4]   2> 812922 T1822 oasu.RandomMergePolicy.<init> RandomMergePolicy 
wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=33, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 812922 T1822 oasc.SolrDeletionPolicy.onInit 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-35a4401a))),segFN=segments_1,generation=1}
   [junit4]   2> 812923 T1822 oasc.SolrDeletionPolicy.updateCommits newest 
commit generation = 1
   [junit4]   2> 812923 T1822 oass.SolrIndexSearcher.<init> Opening 
Searcher@53bd961e[collection1] main
   [junit4]   2> 812924 T1822 oasr.RestManager.init Initializing RestManager 
with initArgs: 
{storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 812924 T1822 oasr.ManagedResourceStorage.load Reading 
_rest_managed.json using InMemoryStorage
   [junit4]   2> 812925 T1822 oasr.ManagedResource.reloadFromStorage WARN No 
stored data found for /rest/managed
   [junit4]   2> 812926 T1822 oasr.ManagedResourceStorage$JsonStorage.store 
Saved JSON object to path _rest_managed.json using InMemoryStorage
   [junit4]   2> 812926 T1822 oasr.RestManager.init Initializing 0 registered 
ManagedResources
   [junit4]   2> 812926 T1822 oashc.SpellCheckComponent.inform Initializing 
spell checkers
   [junit4]   2> 812942 T1822 oass.DirectSolrSpellChecker.init init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 813014 T1823 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@53bd961e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 813041 T1822 oasc.CoreContainer.registerCore registering core: 
collection1
   [junit4]   2> 813043 T1800 oass.SolrDispatchFilter.init 
user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 813043 T1800 oass.SolrDispatchFilter.init 
SolrDispatchFilter.init() done
   [junit4]   2> ASYNC  NEW_CORE C1822 name=collection1 
org.apache.solr.core.SolrCore@68d51392
   [junit4]   2> 813105 T1807 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} 
{deleteByQuery=*:* (-1480792948188643328)} 0 6
   [junit4]   2> ASYNC  NEW_CORE C1823 name=collection1 
org.apache.solr.core.SolrCore@28c9019a
   [junit4]   2> 813165 T1821 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} 
{deleteByQuery=*:* (-1480792948250509312)} 0 6
   [junit4]   2> 813180 T1806 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1 
(1480792948267286528)]} 0 6
   [junit4]   2> 813195 T1816 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1 
(1480792948281966592)]} 0 6
   [junit4]   2> 813207 T1809 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2 
(1480792948297695232)]} 0 3
   [junit4]   2> 813217 T1817 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2 
(1480792948309229568)]} 0 3
   [junit4]   2> 813226 T1803 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3 
(1480792948318666752)]} 0 2
   [junit4]   2> 813235 T1818 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3 
(1480792948327055360)]} 0 3
   [junit4]   2> 813241 T1805 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4 
(1480792948335443968)]} 0 2
   [junit4]   2> 813249 T1820 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4 
(1480792948342784000)]} 0 2
   [junit4]   2> 813260 T1807 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5 
(1480792948353269760)]} 0 3
   [junit4]   2> 813268 T1821 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5 
(1480792948362706944)]} 0 2
   [junit4]   2> 813277 T1808 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6 
(1480792948371095552)]} 0 3
   [junit4]   2> 813287 T1816 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6 
(1480792948381581312)]} 0 4
   [junit4]   2> 813301 T1806 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7 
(1480792948396261376)]} 0 3
   [junit4]   2> 813312 T1817 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7 
(1480792948407795712)]} 0 3
   [junit4]   2> 813320 T1809 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8 
(1480792948417232896)]} 0 3
   [junit4]   2> 813329 T1818 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8 
(1480792948425621504)]} 0 3
   [junit4]   2> 813340 T1803 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9 
(1480792948438204416)]} 0 2
   [junit4]   2> 813352 T1819 C1823 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9 
(1480792948449738752)]} 0 3
   [junit4]   2> 813361 T1805 C1822 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 813373 T1805 C1822 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-4a2ee216))),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-4a2ee216))),segFN=segments_2,generation=2}
   [junit4]   2> 813375 T1805 C1822 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 2
   [junit4]   2> 813379 T1805 C1822 oass.SolrIndexSearcher.<init> Opening 
Searcher@66cfa18a[collection1] main
   [junit4]   2> 813379 T1805 C1822 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 813384 T1811 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@66cfa18a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c9)))}
   [junit4]   2> 813386 T1805 C1822 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update 
params={version=2&waitSearcher=true&commit=true&wt=javabin&softCommit=false} 
{commit=} 0 25
   [junit4]   2> 813394 T1820 C1823 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> ASYNC  NEW_CORE C1824 name=collection1 
org.apache.solr.core.SolrCore@28c9019a
   [junit4]   2> 813454 T1820 C1824 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-35a4401a))),segFN=segments_1,generation=1}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-35a4401a))),segFN=segments_2,generation=2}
   [junit4]   2> 813456 T1820 C1824 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 2
   [junit4]   2> 813459 T1820 C1824 oass.SolrIndexSearcher.<init> Opening 
Searcher@7471ee1e[collection1] main
   [junit4]   2> 813460 T1820 C1824 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 813463 T1823 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@7471ee1e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c9)))}
   [junit4]   2> 813464 T1820 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update 
params={version=2&waitSearcher=true&commit=true&wt=javabin&softCommit=false} 
{commit=} 0 70
   [junit4]   2> ASYNC  NEW_CORE C1825 name=collection1 
org.apache.solr.core.SolrCore@68d51392
   [junit4]   2> 813477 T1807 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10 
(1480792948577665024)]} 0 6
   [junit4]   2> 813492 T1821 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10 
(1480792948593393664)]} 0 6
   [junit4]   2> 813513 T1808 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[11 
(1480792948619608064)]} 0 2
   [junit4]   2> 813523 T1816 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[11 
(1480792948630093824)]} 0 2
   [junit4]   2> 813532 T1806 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12 
(1480792948640579584)]} 0 2
   [junit4]   2> 813543 T1818 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12 
(1480792948652113920)]} 0 3
   [junit4]   2> 813561 T1809 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[13 
(1480792948667842560)]} 0 5
   [junit4]   2> 813579 T1820 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[13 
(1480792948690911232)]} 0 0
   [junit4]   2> 813607 T1803 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1001 
(1480792948708737024)]} 0 11
   [junit4]   2> 813614 T1821 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1001 
(1480792948726562816)]} 0 1
   [junit4]   2> 813624 T1807 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14 
(1480792948736000000)]} 0 2
   [junit4]   2> 813632 T1816 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14 
(1480792948745437184)]} 0 2
   [junit4]   2> 813640 T1808 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15 
(1480792948753825792)]} 0 2
   [junit4]   2> 813647 T1817 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15 
(1480792948761165824)]} 0 1
   [junit4]   2> 813656 T1806 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16 
(1480792948770603008)]} 0 1
   [junit4]   2> 813663 T1819 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16 
(1480792948776894464)]} 0 2
   [junit4]   2> 813670 T1809 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17 
(1480792948785283072)]} 0 2
   [junit4]   2> 813679 T1820 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17 
(1480792948792623104)]} 0 3
   [junit4]   2> 813691 T1805 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[100 
(1480792948806254592)]} 0 2
   [junit4]   2> 813697 T1821 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[100 
(1480792948813594624)]} 0 1
   [junit4]   2> 813706 T1803 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[101 
(1480792948821983232)]} 0 1
   [junit4]   2> 813713 T1816 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[101 
(1480792948830371840)]} 0 2
   [junit4]   2> 813721 T1807 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[102 
(1480792948837711872)]} 0 2
   [junit4]   2> 813728 T1817 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[102 
(1480792948847149056)]} 0 1
   [junit4]   2> 813733 T1808 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[103 
(1480792948852391936)]} 0 1
   [junit4]   2> 813737 T1818 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[103 
(1480792948856586240)]} 0 0
   [junit4]   2> 813743 T1806 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[104 
(1480792948862877696)]} 0 0
   [junit4]   2> 813748 T1819 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[104 
(1480792948867072000)]} 0 1
   [junit4]   2> 813753 T1809 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[105 
(1480792948873363456)]} 0 1
   [junit4]   2> 813763 T1820 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[105 
(1480792948880703488)]} 0 3
   [junit4]   2> 813770 T1805 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[106 
(1480792948890140672)]} 0 1
   [junit4]   2> 813775 T1821 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[106 
(1480792948895383552)]} 0 1
   [junit4]   2> 813779 T1803 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[107 
(1480792948900626432)]} 0 0
   [junit4]   2> 813783 T1816 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[107 
(1480792948904820736)]} 0 1
   [junit4]   2> 813789 T1807 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[108 
(1480792948910063616)]} 0 1
   [junit4]   2> 813794 T1817 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[108 
(1480792948916355072)]} 0 1
   [junit4]   2> 813799 T1808 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[109 
(1480792948920549376)]} 0 1
   [junit4]   2> 813803 T1818 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[109 
(1480792948924743680)]} 0 1
   [junit4]   2> 813809 T1806 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[110 
(1480792948931035136)]} 0 1
   [junit4]   2> 813815 T1819 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[110 
(1480792948938375168)]} 0 1
   [junit4]   2> 813823 T1809 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[111 
(1480792948945715200)]} 0 1
   [junit4]   2> 813830 T1820 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[111 
(1480792948953055232)]} 0 1
   [junit4]   2> 813836 T1805 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[112 
(1480792948959346688)]} 0 2
   [junit4]   2> 813842 T1821 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[112 
(1480792948966686720)]} 0 1
   [junit4]   2> 813848 T1803 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[113 
(1480792948971929600)]} 0 1
   [junit4]   2> 813854 T1816 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[113 
(1480792948978221056)]} 0 1
   [junit4]   2> 813866 T1807 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[114 
(1480792948989755392)]} 0 2
   [junit4]   2> 813872 T1817 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[114 
(1480792948997095424)]} 0 1
   [junit4]   2> 813880 T1808 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[115 
(1480792949005484032)]} 0 2
   [junit4]   2> 813889 T1818 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[115 
(1480792949012824064)]} 0 4
   [junit4]   2> 813896 T1806 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[116 
(1480792949022261248)]} 0 1
   [junit4]   2> 813902 T1819 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[116 
(1480792949028552704)]} 0 1
   [junit4]   2> 813910 T1809 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[117 
(1480792949034844160)]} 0 3
   [junit4]   2> 813920 T1820 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[117 
(1480792949046378496)]} 0 2
   [junit4]   2> 813925 T1805 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[118 
(1480792949053718528)]} 0 0
   [junit4]   2> 813932 T1821 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[118 
(1480792949061058560)]} 0 0
   [junit4]   2> 813938 T1803 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[119 
(1480792949066301440)]} 0 1
   [junit4]   2> 813943 T1816 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[119 
(1480792949072592896)]} 0 0
   [junit4]   2> 813949 T1807 C1825 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[120 
(1480792949078884352)]} 0 1
   [junit4]   2> 813955 T1817 C1824 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[120 
(1480792949084127232)]} 0 1
   [junit4]   2> ASYNC  NEW_CORE C1826 name=collection1 
org.apache.solr.core.SolrCore@68d51392
   [junit4]   2> 813962 T1808 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[121 
(1480792949091467264)]} 0 1
   [junit4]   2> ASYNC  NEW_CORE C1827 name=collection1 
org.apache.solr.core.SolrCore@28c9019a
   [junit4]   2> 813991 T1818 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[121 
(1480792949119778816)]} 0 3
   [junit4]   2> 814000 T1806 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[122 
(1480792949132361728)]} 0 1
   [junit4]   2> 814006 T1819 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[122 
(1480792949138653184)]} 0 0
   [junit4]   2> 814014 T1805 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[123 
(1480792949145993216)]} 0 1
   [junit4]   2> 814020 T1820 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[123 
(1480792949152284672)]} 0 2
   [junit4]   2> 814028 T1803 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[124 
(1480792949160673280)]} 0 1
   [junit4]   2> 814035 T1821 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[124 
(1480792949168013312)]} 0 2
   [junit4]   2> 814041 T1807 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[125 
(1480792949174304768)]} 0 1
   [junit4]   2> 814047 T1816 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[125 
(1480792949180596224)]} 0 1
   [junit4]   2> 814054 T1808 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[126 
(1480792949187936256)]} 0 2
   [junit4]   2> 814058 T1817 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[126 
(1480792949193179136)]} 0 0
   [junit4]   2> 814064 T1809 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[127 
(1480792949199470592)]} 0 0
   [junit4]   2> 814070 T1819 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[127 
(1480792949204713472)]} 0 1
   [junit4]   2> 814076 T1806 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[128 
(1480792949211004928)]} 0 1
   [junit4]   2> 814088 T1820 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[128 
(1480792949222539264)]} 0 4
   [junit4]   2> 814103 T1805 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[129 
(1480792949239316480)]} 0 1
   [junit4]   2> 814109 T1821 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[129 
(1480792949245607936)]} 0 1
   [junit4]   2> 814115 T1803 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[130 
(1480792949251899392)]} 0 1
   [junit4]   2> 814122 T1816 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[130 
(1480792949260288000)]} 0 1
   [junit4]   2> 814135 T1807 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[131 
(1480792949271822336)]} 0 2
   [junit4]   2> 814141 T1818 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[131 
(1480792949279162368)]} 0 1
   [junit4]   2> 814148 T1808 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[132 
(1480792949286502400)]} 0 1
   [junit4]   2> 814154 T1817 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[132 
(1480792949292793856)]} 0 1
   [junit4]   2> 814161 T1809 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[133 
(1480792949300133888)]} 0 1
   [junit4]   2> 814168 T1819 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[133 
(1480792949307473920)]} 0 2
   [junit4]   2> 814174 T1806 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[134 
(1480792949313765376)]} 0 1
   [junit4]   2> 814179 T1820 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[134 
(1480792949319008256)]} 0 1
   [junit4]   2> 814185 T1805 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[135 
(1480792949325299712)]} 0 1
   [junit4]   2> 814190 T1821 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[135 
(1480792949331591168)]} 0 1
   [junit4]   2> 814196 T1803 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[136 
(1480792949337882624)]} 0 1
   [junit4]   2> 814201 T1816 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[136 
(1480792949342076928)]} 0 1
   [junit4]   2> 814207 T1807 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[137 
(1480792949348368384)]} 0 1
   [junit4]   2> 814214 T1818 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[137 
(1480792949355708416)]} 0 1
   [junit4]   2> 814220 T1808 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[138 
(1480792949361999872)]} 0 1
   [junit4]   2> 814226 T1817 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[138 
(1480792949367242752)]} 0 1
   [junit4]   2> 814231 T1809 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[139 
(1480792949373534208)]} 0 1
   [junit4]   2> 814236 T1819 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[139 
(1480792949378777088)]} 0 1
   [junit4]   2> 814241 T1806 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[140 
(1480792949385068544)]} 0 1
   [junit4]   2> 814248 T1821 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[140 
(1480792949391360000)]} 0 2
   [junit4]   2> 814253 T1805 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[141 
(1480792949397651456)]} 0 1
   [junit4]   2> 814259 T1816 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[141 
(1480792949402894336)]} 0 2
   [junit4]   2> 814264 T1803 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[142 
(1480792949408137216)]} 0 1
   [junit4]   2> 814272 T1818 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[142 
(1480792949416525824)]} 0 1
   [junit4]   2> 814280 T1807 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[143 
(1480792949424914432)]} 0 1
   [junit4]   2> 814286 T1817 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[143 
(1480792949432254464)]} 0 1
   [junit4]   2> 814292 T1808 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[144 
(1480792949438545920)]} 0 1
   [junit4]   2> 814298 T1819 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[144 
(1480792949443788800)]} 0 1
   [junit4]   2> 814302 T1809 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[145 
(1480792949449031680)]} 0 1
   [junit4]   2> 814307 T1820 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[145 
(1480792949453225984)]} 0 1
   [junit4]   2> 814313 T1806 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[146 
(1480792949458468864)]} 0 2
   [junit4]   2> 814318 T1821 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[146 
(1480792949464760320)]} 0 1
   [junit4]   2> 814323 T1805 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[147 
(1480792949470003200)]} 0 1
   [junit4]   2> 814329 T1816 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[147 
(1480792949476294656)]} 0 1
   [junit4]   2> 814336 T1803 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[148 
(1480792949482586112)]} 0 2
   [junit4]   2> 814343 T1818 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[148 
(1480792949490974720)]} 0 2
   [junit4]   2> 814349 T1807 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[149 
(1480792949497266176)]} 0 1
   [junit4]   2> 814356 T1817 C1827 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update params={version=2&wt=javabin} {add=[149 
(1480792949504606208)]} 0 1
   [junit4]   2> 814363 T1808 C1826 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 814451 T1808 C1826 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-4a2ee216))),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-4a2ee216))),segFN=segments_3,generation=3}
   [junit4]   2> 814452 T1808 C1826 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 3
   [junit4]   2> 814454 T1808 C1826 oass.SolrIndexSearcher.<init> Opening 
Searcher@1b5a6cf3[collection1] main
   [junit4]   2> 814454 T1808 C1826 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 814456 T1811 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@1b5a6cf3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c9)
 Uninverting(_1(5.0.0):c59)))}
   [junit4]   2> 814457 T1808 C1826 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update 
params={version=2&waitSearcher=true&commit=true&wt=javabin&softCommit=false} 
{commit=} 0 95
   [junit4]   2> 814462 T1819 C1827 oasu.DirectUpdateHandler2.commit start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> ASYNC  NEW_CORE C1828 name=collection1 
org.apache.solr.core.SolrCore@28c9019a
   [junit4]   2> 814551 T1819 C1828 oasc.SolrDeletionPolicy.onCommit 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-35a4401a))),segFN=segments_2,generation=2}
   [junit4]   2>                
commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory(id=lucene-35a4401a))),segFN=segments_3,generation=3}
   [junit4]   2> 814553 T1819 C1828 oasc.SolrDeletionPolicy.updateCommits 
newest commit generation = 3
   [junit4]   2> 814561 T1819 C1828 oass.SolrIndexSearcher.<init> Opening 
Searcher@44007a9f[collection1] main
   [junit4]   2> 814567 T1823 oasc.SolrCore.registerSearcher [collection1] 
Registered new searcher Searcher@44007a9f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.0.0):c9)
 Uninverting(_1(5.0.0):c59)))}
   [junit4]   2> 814569 T1819 C1828 oasu.DirectUpdateHandler2.commit 
end_commit_flush
   [junit4]   2> 814570 T1819 C1828 oasup.LogUpdateProcessor.finish 
[collection1] webapp= path=/update 
params={version=2&waitSearcher=true&commit=true&wt=javabin&softCommit=false} 
{commit=} 0 109
   [junit4]   2> ASYNC  NEW_CORE C1829 name=collection1 
org.apache.solr.core.SolrCore@68d51392
   [junit4]   2> 814583 T1806 C1829 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_ti1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=4 
   [junit4]   2> 814635 T1817 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204094&distrib=false&sort=n_ti1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/|[ff01::213]:33332/|[ff01::114]:33332/&start=0}
 hits=68 status=0 QTime=2 
   [junit4]   2> 814662 T1820 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204094&distrib=false&ids=117,109,7,15,138,9,147,119,123,13&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/|[ff01::213]:33332/|[ff01::114]:33332/}
 status=0 QTime=4 
   [junit4]   2> 814679 T1821 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_ti1+desc&shards=https://127.0.0.1:55267/|[ff01::213]:33332/|[ff01::114]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=87 
   [junit4]   2> 814690 T1805 C1829 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_ti1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=0 
   [junit4]   2> 814737 T1818 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204216&distrib=false&sort=n_ti1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 814748 T1817 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204216&distrib=false&ids=10,143,16,5,105,137,130,108,103,135&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/}
 status=0 QTime=2 
   [junit4]   2> 814763 T1819 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_ti1+asc&shards=[ff01::083]:33332/|[ff01::213]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=50 
   [junit4]   2> 814772 T1803 C1829 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_f1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 814785 T1821 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204283&distrib=false&sort=n_f1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::213]:33332/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 814799 T1816 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204283&distrib=false&ids=10,120,102,108,128,136,139,134,3,123&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::213]:33332/}
 status=0 QTime=2 
   [junit4]   2> 814809 T1820 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_f1+desc&shards=[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::213]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=29 
   [junit4]   2> 814840 T1808 C1829 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_f1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 814910 T1819 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204375&distrib=false&sort=n_f1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::114]:33332/|https://127.0.0.1:55267/|[ff01::083]:33332/&start=0}
 hits=68 status=0 QTime=2 
   [junit4]   2> 814942 T1821 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204375&distrib=false&ids=15,133,100,104,111,122,119,142,135,131&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::114]:33332/|https://127.0.0.1:55267/|[ff01::083]:33332/}
 status=0 QTime=2 
   [junit4]   2> 814996 T1818 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_f1+asc&shards=[ff01::114]:33332/|https://127.0.0.1:55267/|[ff01::083]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=124 
   [junit4]   2> 815016 T1809 C1829 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_tf1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=3 
   [junit4]   2> 815040 T1820 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204532&distrib=false&sort=n_tf1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815056 T1817 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204532&distrib=false&ids=120,6,138,4,137,104,119,112,123,144&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/}
 status=0 QTime=1 
   [junit4]   2> 815065 T1816 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_tf1+desc&shards=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=36 
   [junit4]   2> 815085 T1805 C1829 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_tf1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815110 T1821 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204606&distrib=false&sort=n_tf1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=0 
   [junit4]   2> 815122 T1818 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204606&distrib=false&ids=10,141,7,16,2,100,101,121,14,116&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|https://127.0.0.1:55267/}
 status=0 QTime=5 
   [junit4]   2> 815130 T1819 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_tf1+asc&shards=[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/|https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=27 
   [junit4]   2> 815139 T1803 C1829 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_d1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=2 
   [junit4]   2> 815154 T1817 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204651&distrib=false&sort=n_d1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815168 T1816 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204651&distrib=false&ids=17,146,141,120,140,9,11,12,129,116&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/}
 status=0 QTime=2 
   [junit4]   2> 815175 T1820 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_d1+desc&shards=https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=27 
   [junit4]   2> 815184 T1807 C1829 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_d1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=0 
   [junit4]   2> 815200 T1818 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204695&distrib=false&sort=n_d1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::213]:33332/|https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815214 T1819 C1828 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204695&distrib=false&ids=16,8,138,104,119,128,148,131,107,1&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::213]:33332/|https://127.0.0.1:55267/}
 status=0 QTime=3 
   [junit4]   2> ASYNC  NEW_CORE C1830 name=collection1 
org.apache.solr.core.SolrCore@28c9019a
   [junit4]   2> 815247 T1821 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_d1+asc&shards=[ff01::213]:33332/|https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=55 
   [junit4]   2> ASYNC  NEW_CORE C1831 name=collection1 
org.apache.solr.core.SolrCore@68d51392
   [junit4]   2> 815273 T1808 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_td1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815321 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204794&distrib=false&sort=n_td1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815331 T1818 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204794&distrib=false&ids=10,110,6,145,11,122,137,130,123,113&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::083]:33332/|[ff01::213]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/}
 status=0 QTime=3 
   [junit4]   2> 815346 T1817 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_td1+desc&shards=[ff01::083]:33332/|[ff01::213]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=55 
   [junit4]   2> 815356 T1806 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_td1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815375 T1821 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204872&distrib=false&sort=n_td1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815386 T1816 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204872&distrib=false&ids=115,16,140,9,5,136,112,12,3,1&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/}
 status=0 QTime=3 
   [junit4]   2> 815391 T1819 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_td1+asc&shards=https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=22 
   [junit4]   2> 815401 T1809 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_l1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815416 T1818 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204912&distrib=false&sort=n_l1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/&start=0}
 hits=68 status=0 QTime=2 
   [junit4]   2> 815424 T1817 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204912&distrib=false&ids=17,146,115,8,6,140,15,137,126,134&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/}
 status=0 QTime=1 
   [junit4]   2> 815427 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_l1+desc&shards=[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::114]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=18 
   [junit4]   2> 815438 T1805 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_l1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815459 T1816 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204956&distrib=false&sort=n_l1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/|[ff01::083]:33332/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815469 T1819 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204956&distrib=false&ids=132,7,4,100,142,108,136,107,113,14&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/|[ff01::083]:33332/}
 status=0 QTime=2 
   [junit4]   2> 815475 T1821 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_l1+asc&shards=https://127.0.0.1:55267/|[ff01::083]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=22 
   [junit4]   2> 815484 T1807 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_tl1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815500 T1817 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204995&distrib=false&sort=n_tl1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=2 
   [junit4]   2> 815513 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194204995&distrib=false&ids=149,146,143,124,127,121,134,144,107,1&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/}
 status=0 QTime=2 
   [junit4]   2> 815517 T1818 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_tl1+desc&shards=https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=25 
   [junit4]   2> 815523 T1808 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_tl1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=0 
   [junit4]   2> 815535 T1819 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205033&distrib=false&sort=n_tl1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815545 T1821 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205033&distrib=false&ids=132,109,138,133,111,137,119,12,123,13&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/}
 status=0 QTime=2 
   [junit4]   2> 815550 T1816 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_tl1+asc&shards=https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=20 
   [junit4]   2> 815566 T1806 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_dt1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815579 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205076&distrib=false&sort=n_dt1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::213]:33332/&start=0}
 hits=68 status=0 QTime=2 
   [junit4]   2> 815590 T1818 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205076&distrib=false&ids=117,132,138,145,100,147,142,127,106,129&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::213]:33332/}
 status=0 QTime=2 
   [junit4]   2> 815595 T1817 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_dt1+desc&shards=[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/|[ff01::213]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=22 
   [junit4]   2> 815608 T1803 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_dt1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815641 T1816 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205129&distrib=false&sort=n_dt1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815653 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205129&distrib=false&ids=7,5,4,11,128,136,126,101,13,14&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/}
 status=0 QTime=1 
   [junit4]   2> 815660 T1819 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_dt1+asc&shards=https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=34 
   [junit4]   2> 815670 T1805 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_tdt1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815692 T1817 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205183&distrib=false&sort=n_tdt1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=2 
   [junit4]   2> 815702 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205183&distrib=false&ids=10,15,2,137,142,127,139,118,121,144&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/}
 status=0 QTime=2 
   [junit4]   2> 815707 T1818 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_tdt1+desc&shards=https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=27 
   [junit4]   2> 815720 T1807 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=n_tdt1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=3 
   [junit4]   2> 815738 T1817 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205237&distrib=false&sort=n_tdt1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/|[ff01::213]:33332/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815749 T1821 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205237&distrib=false&ids=114,120,5,9,145,147,12,107,131,129&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/|[ff01::213]:33332/}
 status=0 QTime=3 
   [junit4]   2> 815755 T1819 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=n_tdt1+asc&shards=https://127.0.0.1:55267/|[ff01::213]:33332/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=21 
   [junit4]   2> 815769 T1808 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=a_i1+desc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=2 
   [junit4]   2> 815782 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205279&distrib=false&sort=a_i1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815792 T1818 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205279&distrib=false&ids=10,8,7,2,5,9,12,3,13,1&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/}
 status=0 QTime=2 
   [junit4]   2> 815800 T1816 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=a_i1+desc&shards=[ff01::114]:33332/|[ff01::083]:33332/|https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=24 
   [junit4]   2> 815813 T1806 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&distrib=false&sort={!func}testfunc(add(a_i1,5))+desc&q=*:*&wt=javabin}
 hits=68 status=0 QTime=3 
   [junit4]   2> 815838 T1819 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205330&distrib=false&sort={!func}testfunc(add(a_i1,5))+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815857 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205330&distrib=false&ids=10,8,7,2,5,9,12,3,13,1&isShard=true&q=*:*&wt=javabin&shard.url=https://127.0.0.1:55267/}
 status=0 QTime=3 
   [junit4]   2> 815861 T1817 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort={!func}testfunc(add(a_i1,5))+desc&shards=https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=34 
   [junit4]   2> 815886 T1809 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select params={version=2&distrib=false&sort=a_i1+asc&q=*:*&wt=javabin} 
hits=68 status=0 QTime=2 
   [junit4]   2> 815912 T1821 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205406&distrib=false&sort=a_i1+asc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=1 
   [junit4]   2> 815926 T1819 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205406&distrib=false&ids=6,7,2,9,4,11,12,3,1,13&isShard=true&q=*:*&wt=javabin&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|https://127.0.0.1:55267/}
 status=0 QTime=2 
   [junit4]   2> 815932 T1816 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=a_i1+asc&shards=[ff01::213]:33332/|[ff01::083]:33332/|[ff01::114]:33332/|https://127.0.0.1:55267/&q=*:*&wt=javabin}
 hits=68 status=0 QTime=29 
   [junit4]   2> 815958 T1805 C1831 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&distrib=false&sort=a_i1+desc&q=*:*&wt=javabin&fl=*,score} 
hits=68 status=0 QTime=1 
   [junit4]   2> 815984 T1817 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205480&distrib=false&sort=a_i1+desc&rows=10&isShard=true&q=*:*&fsv=true&wt=javabin&fl=id,score&shard.url=https://127.0.0.1:55267/&start=0}
 hits=68 status=0 QTime=0 
   [junit4]   2> 816013 T1818 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&NOW=1412194205480&distrib=false&ids=10,8,7,2,5,9,12,3,13,1&isShard=true&q=*:*&wt=javabin&fl=*,score&shard.url=https://127.0.0.1:55267/}
 status=0 QTime=2 
   [junit4]   2> 816035 T1820 C1830 oasc.SolrCore.execute [collection1] webapp= 
path=/select 
params={version=2&sort=a_i1+desc&shards=https://127.0.0.1:55267/&q=*:*&wt=javabin&fl=*,score}
 hits=68 status=0 QTime=58 
   [junit4]   2> 816056 T1807 C1831 oasc.SolrCore.execute

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

/,null}
   [junit4]   2> 849321 T1800 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=1779644726
   [junit4]   2> 849323 T1800 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@268147b1
   [junit4]   2> 849338 T1800 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=3,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=35,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=9516,transaction_logs_total_number=3}
   [junit4]   2> 849338 T1800 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 849339 T1800 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 849339 T1800 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 849341 T1800 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 849341 T1800 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 849342 T1800 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data;done=false>>]
   [junit4]   2> 849342 T1800 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data
   [junit4]   2> 849343 T1800 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data/index
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data/index;done=false>>]
   [junit4]   2> 849343 T1800 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard0/data/index
   [junit4]   2> 849347 T1800 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/,null}
   [junit4]   2> 854327 T1800 oasc.CoreContainer.shutdown Shutting down 
CoreContainer instance=10184640
   [junit4]   2> 854329 T1800 oasc.SolrCore.close [collection1]  CLOSING 
SolrCore org.apache.solr.core.SolrCore@4ebf97a4
   [junit4]   2> 854379 T1800 oasu.DirectUpdateHandler2.close closing 
DirectUpdateHandler2{commits=3,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=36,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=8903,transaction_logs_total_number=3}
   [junit4]   2> 854380 T1800 oasu.SolrCoreState.decrefSolrCoreState Closing 
SolrCoreState
   [junit4]   2> 854380 T1800 oasu.DefaultSolrCoreState.closeIndexWriter 
SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 854381 T1800 oasu.DefaultSolrCoreState.closeIndexWriter 
closing IndexWriter with IndexWriterCloser
   [junit4]   2> 854384 T1800 oasc.SolrCore.closeSearcher [collection1] Closing 
main searcher on request.
   [junit4]   2> 854438 T1800 oasc.CachingDirectoryFactory.close Closing 
MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 854438 T1800 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard1/data/index
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard1/data/index;done=false>>]
   [junit4]   2> 854439 T1800 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard1/data/index
   [junit4]   2> 854440 T1800 oasc.CachingDirectoryFactory.closeCacheValue 
looking to close 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard1/data
 
[CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard1/data;done=false>>]
   [junit4]   2> 854440 T1800 oasc.CachingDirectoryFactory.close Closing 
directory: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001/tempDir-001/shard1/data
   [junit4]   2> 854441 T1800 oejsh.ContextHandler.doStop stopped 
o.e.j.s.ServletContextHandler{/,null}
   [junit4]   2> 859317 T1800 oas.SolrTestCaseJ4.tearDown ###Ending 
testDistribSearch
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestDistributedSearch -Dtests.method=testDistribSearch 
-Dtests.seed=2E3B19871D967C87 -Dtests.slow=true -Dtests.locale=sl 
-Dtests.timezone=Mexico/General -Dtests.file.encoding=UTF-8
   [junit4] ERROR   49.0s | TestDistributedSearch.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([2E3B19871D967C87:AFDD979F6AC91CBB]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:568)
   [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.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:596)
   [junit4]    >        at 
org.apache.solr.TestDistributedSearch.doTest(TestDistributedSearch.java:499)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:875)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 859353 T1800 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.TestDistributedSearch-2E3B19871D967C87-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=DefaultSimilarity, locale=sl, timezone=Mexico/General
   [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_67 
(64-bit)/cpus=2,threads=1,free=45648416,total=228421632
   [junit4]   2> NOTE: All tests run in this JVM: [SuggesterTest, 
TestElisionMultitermQuery, ResponseLogComponentTest, 
TestSchemaSimilarityResource, DistributedFacetPivotLargeTest, 
TestSolrCoreProperties, TestZkChroot, CoreAdminRequestStatusTest, 
HdfsBasicDistributedZkTest, UpdateRequestProcessorFactoryTest, 
LeaderElectionIntegrationTest, RecoveryZkTest, IndexBasedSpellCheckerTest, 
DirectUpdateHandlerOptimizeTest, TestSchemaVersionResource, 
TestCloudInspectUtil, TestStressReorder, TestIBSimilarityFactory, 
CurrencyFieldOpenExchangeTest, DocumentBuilderTest, 
OverseerCollectionProcessorTest, TestAnalyzeInfixSuggestions, 
TestCloudManagedSchema, TestDistribDocBasedVersion, 
DistributedSuggestComponentTest, EnumFieldTest, TermVectorComponentTest, 
TestPostingsSolrHighlighter, ChangedSchemaMergeTest, TestBM25SimilarityFactory, 
RAMDirectoryFactoryTest, DeleteReplicaTest, MinimalSchemaTest, 
TestSuggestSpellingConverter, StatsComponentTest, BlockDirectoryTest, 
TestBinaryField, CoreAdminHandlerTest, TestOrdValues, 
TestManagedStopFilterFactory, TestNRTOpen, CustomCollectionTest, 
TestDistributedSearch]
   [junit4] Completed in 49.08s, 1 test, 1 error <<< FAILURES!

[...truncated 1238 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:524: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:472: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:189: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:496: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1360: 
The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:962: 
There were test failures: 431 suites, 1778 tests, 1 error, 50 ignored (22 
assumptions)

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



---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org