You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/09/24 23:40:43 UTC
[JENKINS] Lucene-Solr-NightlyTests-5.x - Build # 631 - Still
Failing
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/631/
1 tests failed.
REGRESSION: org.apache.solr.handler.component.DistributedSpellCheckComponentTest.testDistribSearch
Error Message:
Captured an uncaught exception in thread: Thread[id=2263, name=Thread-1076, state=RUNNABLE, group=TGRP-DistributedSpellCheckComponentTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=2263, name=Thread-1076, state=RUNNABLE, group=TGRP-DistributedSpellCheckComponentTest]
at __randomizedtesting.SeedInfo.seed([4382992141BC9E4E:C264173936E3FE72]:0)
Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:44787
at __randomizedtesting.SeedInfo.seed([4382992141BC9E4E]:0)
at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:580)
Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:44787
at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:558)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:91)
at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:575)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:152)
at java.net.SocketInputStream.read(SocketInputStream.java:122)
at sun.security.ssl.InputRecord.readFully(InputRecord.java:442)
at sun.security.ssl.InputRecord.read(InputRecord.java:480)
at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:927)
at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:884)
at sun.security.ssl.AppInputStream.read(AppInputStream.java:102)
at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260)
at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123)
at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486)
at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57)
at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:448)
... 5 more
Build Log:
[...truncated 12088 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedSpellCheckComponentTest
[junit4] 2> Creating dataDir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/init-core-data-001
[junit4] 2> 261144 T500 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (true)
[junit4] 2> 261144 T500 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4] 2> 261148 T500 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> 261151 T500 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 261158 T500 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 261163 T500 oejs.AbstractConnector.doStart Started SslSocketConnector@127.0.0.1:43442
[junit4] 2> 261166 T500 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 261167 T500 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 261167 T500 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr
[junit4] 2> 261167 T500 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/'
[junit4] 2> 261183 T500 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/solr.xml
[junit4] 2> 261307 T500 oasc.CoreContainer.<init> New CoreContainer 7563004
[junit4] 2> 261308 T500 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/]
[junit4] 2> 261309 T500 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 261309 T500 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 261309 T500 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 261310 T500 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 261310 T500 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 261310 T500 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 261310 T500 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 261311 T500 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 261311 T500 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 261314 T500 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 261317 T500 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 261317 T500 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 261318 T500 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 261322 T510 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 261324 T510 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 261325 T510 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 261326 T510 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 261456 T510 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 261819 T510 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 261820 T510 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 261833 T510 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 262248 T510 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 262264 T510 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 262267 T510 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 262283 T510 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 262289 T510 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 262294 T510 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 262295 T510 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 262296 T510 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 262296 T510 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 262297 T510 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 262297 T510 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 262298 T510 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/
[junit4] 2> 262298 T510 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 262384 T510 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data/
[junit4] 2> 262384 T510 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@41d42a35
[junit4] 2> 262388 T510 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data
[junit4] 2> 262390 T510 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data/index/
[junit4] 2> 262391 T510 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 262392 T510 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data/index
[junit4] 2> 262392 T510 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=14.1728515625, floorSegmentMB=1.9228515625, forceMergeDeletesPctAllowed=9.43486417838211, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5610078102937456
[junit4] 2> 262416 T510 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@63d07aa2; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> 262416 T510 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 262417 T510 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 262420 T510 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 262421 T510 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 262421 T510 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 262421 T510 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 262421 T510 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 262422 T510 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 262422 T510 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 262422 T510 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 262422 T510 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 262423 T510 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 262423 T510 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 262423 T510 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 262424 T510 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 262424 T510 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 262425 T510 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 262425 T510 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 262425 T510 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 262426 T510 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 262426 T510 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 262427 T510 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 262427 T510 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 262427 T510 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 262428 T510 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 262428 T510 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 262429 T510 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 262429 T510 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 262429 T510 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 262430 T510 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 262430 T510 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 262430 T510 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 262431 T510 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 262431 T510 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 262432 T510 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 262432 T510 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 262432 T510 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 262433 T510 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 262433 T510 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 262434 T510 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 262460 T510 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 262462 T510 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 262464 T510 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 262467 T510 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 262475 T510 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 262477 T510 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 262477 T510 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 262478 T510 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@462215f2
[junit4] 2> 262480 T510 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@63d07aa2; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> 262481 T510 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 262481 T510 oass.SolrIndexSearcher.<init> Opening Searcher@12e39683[collection1] main
[junit4] 2> 262481 T510 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 262482 T510 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 262482 T510 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 262482 T510 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 262482 T510 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 262483 T510 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 262494 T510 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 262555 T511 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@12e39683[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 262559 T510 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 262560 T500 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0
[junit4] 2> 262560 T500 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 262567 T500 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 262575 T500 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4] 2> 262579 T500 oejs.AbstractConnector.doStart Started SslSocketConnector@127.0.0.1:43448
[junit4] 2> 262583 T500 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 262583 T500 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 262584 T500 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr
[junit4] 2> 262584 T500 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/'
[junit4] 2> 262641 T500 oasc.ConfigSolr.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/solr.xml
[junit4] 2> 262738 T500 oasc.CoreContainer.<init> New CoreContainer 1637709079
[junit4] 2> 262739 T500 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/]
[junit4] 2> 262740 T500 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 262740 T500 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 262741 T500 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 262741 T500 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 262741 T500 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 262742 T500 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 262742 T500 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 262742 T500 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 262743 T500 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 262747 T500 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false
[junit4] 2> 262750 T500 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 262751 T500 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 262751 T500 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 262757 T522 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 262759 T522 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 262759 T522 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader
[junit4] 2> 262760 T522 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 262842 T522 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0
[junit4] 2> 262914 T522 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 262915 T522 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 262929 T522 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 263267 T522 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 263278 T522 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 263280 T522 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 263290 T522 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 263293 T522 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 263296 T522 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 263297 T522 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 263297 T522 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 263297 T522 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 263298 T522 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 263298 T522 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 263298 T522 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/
[junit4] 2> 263298 T522 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory
[junit4] 2> 263299 T522 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data/
[junit4] 2> 263299 T522 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@41d42a35
[junit4] 2> 263301 T522 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data
[junit4] 2> 263302 T522 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data/index/
[junit4] 2> 263302 T522 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data/index' doesn't exist. Creating new index...
[junit4] 2> 263303 T522 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data/index
[junit4] 2> 263303 T522 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=14.1728515625, floorSegmentMB=1.9228515625, forceMergeDeletesPctAllowed=9.43486417838211, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5610078102937456
[junit4] 2> 263335 T522 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1fb182ac; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> 263335 T522 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 263336 T522 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 263339 T522 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 263339 T522 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 263339 T522 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 263339 T522 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 263339 T522 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 263339 T522 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 263340 T522 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 263340 T522 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 263340 T522 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 263340 T522 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 263341 T522 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 263341 T522 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 263341 T522 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 263342 T522 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 263342 T522 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 263342 T522 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 263342 T522 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 263343 T522 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 263343 T522 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 263343 T522 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 263344 T522 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 263344 T522 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 263344 T522 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 263345 T522 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 263345 T522 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 263345 T522 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 263345 T522 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 263346 T522 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 263346 T522 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 263346 T522 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 263347 T522 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 263347 T522 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 263347 T522 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 263348 T522 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 263348 T522 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 263348 T522 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 263349 T522 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 263349 T522 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 263364 T522 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 263365 T522 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 263367 T522 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 263368 T522 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 263373 T522 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 263374 T522 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 263374 T522 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 263375 T522 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@567d49b6
[junit4] 2> 263376 T522 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1fb182ac; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> 263376 T522 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 263377 T522 oass.SolrIndexSearcher.<init> Opening Searcher@115bbaa5[collection1] main
[junit4] 2> 263377 T522 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 263377 T522 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 263377 T522 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 263377 T522 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage
[junit4] 2> 263378 T522 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 263378 T522 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 263388 T522 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 263495 T523 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@115bbaa5[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 263500 T522 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 263500 T500 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0
[junit4] 2> 263501 T500 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C164 name=collection1 org.apache.solr.core.SolrCore@767fb281
[junit4] 2> 263654 T503 C164 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 263655 T503 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 2
[junit4] 2> ASYNC NEW_CORE C165 name=collection1 org.apache.solr.core.SolrCore@45382e46
[junit4] 2> 263796 T515 C165 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 263797 T515 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 2
[junit4] 2> 263819 T504 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1]} 0 7
[junit4] 2> 263836 T516 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1]} 0 4
[junit4] 2> 263848 T505 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2]} 0 2
[junit4] 2> 263860 T517 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2]} 0 1
[junit4] 2> 263873 T506 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3]} 0 1
[junit4] 2> 263886 T518 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3]} 0 1
[junit4] 2> 263899 T507 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4]} 0 2
[junit4] 2> 263910 T519 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4]} 0 1
[junit4] 2> 263922 T508 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5]} 0 1
[junit4] 2> 263934 T520 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5]} 0 1
[junit4] 2> 263944 T509 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6]} 0 1
[junit4] 2> 263955 T521 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6]} 0 1
[junit4] 2> 263967 T539 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7]} 0 1
[junit4] 2> 263980 T541 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7]} 0 1
[junit4] 2> 263990 T543 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8]} 0 0
[junit4] 2> 264001 T545 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8]} 0 1
[junit4] 2> 264014 T547 C164 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9]} 0 2
[junit4] 2> 264026 T549 C165 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9]} 0 2
[junit4] 2> ASYNC NEW_CORE C166 name=collection1 org.apache.solr.core.SolrCore@767fb281
[junit4] 2> 264043 T551 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10]} 0 1
[junit4] 2> ASYNC NEW_CORE C167 name=collection1 org.apache.solr.core.SolrCore@45382e46
[junit4] 2> 264055 T553 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10]} 0 1
[junit4] 2> 264067 T555 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12]} 0 1
[junit4] 2> 264077 T557 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12]} 0 1
[junit4] 2> 264088 T559 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[13]} 0 1
[junit4] 2> 264099 T561 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[13]} 0 1
[junit4] 2> 264112 T563 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14]} 0 1
[junit4] 2> 264124 T565 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14]} 0 2
[junit4] 2> 264136 T567 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15]} 0 2
[junit4] 2> 264146 T569 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15]} 0 1
[junit4] 2> 264177 T571 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16]} 0 22
[junit4] 2> 264202 T573 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16]} 0 16
[junit4] 2> 264214 T575 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17]} 0 3
[junit4] 2> 264225 T577 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17]} 0 2
[junit4] 2> 264236 T579 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[18]} 0 1
[junit4] 2> 264245 T581 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[18]} 0 0
[junit4] 2> 264256 T583 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[19]} 0 1
[junit4] 2> 264267 T585 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[19]} 0 1
[junit4] 2> 264279 T587 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[20]} 0 2
[junit4] 2> 264290 T589 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[20]} 0 1
[junit4] 2> 264301 T591 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[21]} 0 2
[junit4] 2> 264312 T593 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[21]} 0 2
[junit4] 2> 264323 T595 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[22]} 0 2
[junit4] 2> 264334 T597 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[22]} 0 1
[junit4] 2> 264345 T599 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[23]} 0 2
[junit4] 2> 264356 T601 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[23]} 0 2
[junit4] 2> 264366 T603 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[24]} 0 2
[junit4] 2> 264376 T605 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[24]} 0 2
[junit4] 2> 264386 T607 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[25]} 0 2
[junit4] 2> 264395 T609 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[25]} 0 2
[junit4] 2> 264403 T611 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[26]} 0 1
[junit4] 2> 264411 T613 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[26]} 0 1
[junit4] 2> 264418 T615 C166 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 264479 T615 C166 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@63d07aa2; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/control/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@63d07aa2; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_2,generation=2}
[junit4] 2> 264480 T615 C166 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 264482 T615 C166 oass.SolrIndexSearcher.<init> Opening Searcher@686fe37a[collection1] main
[junit4] 2> 264483 T615 C166 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 264484 T511 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@686fe37a[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0.0):c15) Uninverting(_1(5.0.0):c10))}
[junit4] 2> 264485 T615 C166 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&softCommit=false&commit=true&version=2&wt=javabin} {commit=} 0 67
[junit4] 2> 264493 T618 C167 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 264537 T618 C167 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1fb182ac; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(NRTCachingDirectory(MMapDirectory@/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard0/data/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1fb182ac; maxCacheMB=48.0 maxMergeSizeMB=4.0)),segFN=segments_2,generation=2}
[junit4] 2> 264538 T618 C167 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 264542 T618 C167 oass.SolrIndexSearcher.<init> Opening Searcher@634d47f3[collection1] main
[junit4] 2> 264543 T618 C167 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 264544 T523 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@634d47f3[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0.0):c15) Uninverting(_1(5.0.0):c10))}
[junit4] 2> 264545 T618 C167 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={waitSearcher=true&softCommit=false&commit=true&version=2&wt=javabin} {commit=} 0 52
[junit4] 2> 264733 T621 C166 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH&qt=spellCheckCompRH&spellcheck=true&spellcheck.build=true&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=179
[junit4] 2> 265057 T626 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&fsv=true&distrib=false&shards.qt=spellCheckCompRH&qt=spellCheckCompRH&shard.url=https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=false&rows=10&version=2&wt=javabin&start=0&NOW=1411591452567&spellcheck=true&spellcheck.build=true&isShard=true} hits=25 status=0 QTime=88
[junit4] 2> 265079 T628 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&shards.qt=spellCheckCompRH&qt=spellCheckCompRH&shard.url=https://127.0.0.1:43448/&spellcheck.count=1&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=false&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591452567&spellcheck=false&spellcheck.build=true&isShard=true} status=0 QTime=1
[junit4] 2> 265093 T623 C167 oashc.SpellCheckComponent.finishStage https://127.0.0.1:43448/ null
[junit4] 2> 265094 T623 C167 oashc.SpellCheckComponent.finishStage https://127.0.0.1:43448/ null
[junit4] 2> 265094 T623 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH&qt=spellCheckCompRH&shards=https://127.0.0.1:43448/&spellcheck=true&spellcheck.build=true&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=352
[junit4] 2> 265433 T630 C166 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=323
[junit4] 2> 265485 T634 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=false&rows=10&version=2&wt=javabin&start=0&NOW=1411591453277&spellcheck=true&isShard=true} hits=25 status=0 QTime=26
[junit4] 2> 265494 T636 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=false&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453277&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265496 T632 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,suggestion=[toyota]}},originalTerms=[toyata]}
[junit4] 2> 265496 T632 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265497 T632 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=45
[junit4] 2> 265499 T500 oas.BaseDistributedSearchTestCase.query starting stress...
[junit4] 2> 265678 T649 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=false&rows=10&version=2&wt=javabin&start=0&NOW=1411591453337&spellcheck=true&isShard=true} hits=25 status=0 QTime=18
[junit4] 2> 265687 T656 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=false&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453337&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265688 T652 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=false&rows=10&version=2&wt=javabin&start=0&NOW=1411591453338&spellcheck=true&isShard=true} hits=25 status=0 QTime=11
[junit4] 2> 265688 T641 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,suggestion=[toyota]}},originalTerms=[toyata]}
[junit4] 2> 265689 T641 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265689 T641 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=177
[junit4] 2> 265693 T653 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=false&rows=10&version=2&wt=javabin&start=0&NOW=1411591453337&spellcheck=true&isShard=true} hits=25 status=0 QTime=15
[junit4] 2> 265697 T659 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=false&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453338&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265698 T643 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,suggestion=[toyota]}},originalTerms=[toyata]}
[junit4] 2> 265699 T643 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265699 T643 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=186
[junit4] 2> 265703 T662 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=false&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453337&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265705 T642 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,suggestion=[toyota]}},originalTerms=[toyata]}
[junit4] 2> 265705 T642 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265705 T642 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=193
[junit4] 2> 265716 T663 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=false&rows=10&version=2&wt=javabin&start=0&NOW=1411591453520&spellcheck=true&isShard=true} hits=25 status=0 QTime=13
[junit4] 2> 265720 T669 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=false&rows=10&version=2&wt=javabin&start=0&NOW=1411591453530&spellcheck=true&isShard=true} hits=25 status=0 QTime=8
[junit4] 2> 265724 T672 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=false&rows=10&version=2&wt=javabin&start=0&NOW=1411591453536&spellcheck=true&isShard=true} hits=25 status=0 QTime=7
[junit4] 2> 265725 T674 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=false&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453520&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265727 T658 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,suggestion=[toyota]}},originalTerms=[toyata]}
[junit4] 2> 265727 T658 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265727 T658 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=32
[junit4] 2> 265729 T676 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=false&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453530&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265730 T665 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,suggestion=[toyota]}},originalTerms=[toyata]}
[junit4] 2> 265731 T665 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265731 T665 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=26
[junit4] 2> 265732 T678 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=false&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453536&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265734 T668 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,suggestion=[toyota]}},originalTerms=[toyata]}
[junit4] 2> 265734 T668 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265735 T668 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&version=2&wt=javabin} hits=25 status=0 QTime=24
[junit4] 2> 265753 T680 C166 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=12
[junit4] 2> 265779 T684 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453586&spellcheck=true&isShard=true} hits=25 status=0 QTime=10
[junit4] 2> 265788 T686 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453586&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265789 T682 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}]}},correctlySpelled=true,originalTerms=[toyata]}
[junit4] 2> 265790 T682 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 265790 T682 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=29
[junit4] 2> 265792 T500 oas.BaseDistributedSearchTestCase.query starting stress...
[junit4] 2> 265815 T699 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453625&spellcheck=true&isShard=true} hits=25 status=0 QTime=8
[junit4] 2> 265817 T697 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453624&spellcheck=true&isShard=true} hits=25 status=0 QTime=12
[junit4] 2> 265818 T698 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453625&spellcheck=true&isShard=true} hits=25 status=0 QTime=12
[junit4] 2> 265825 T628 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453625&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265826 T634 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453624&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265826 T692 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}]}},correctlySpelled=true,originalTerms=[toyata]}
[junit4] 2> 265827 T692 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 265827 T692 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=27
[junit4] 2> 265827 T636 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453625&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265828 T691 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}]}},correctlySpelled=true,originalTerms=[toyata]}
[junit4] 2> 265828 T691 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 265828 T691 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=29
[junit4] 2> 265829 T693 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}]}},correctlySpelled=true,originalTerms=[toyata]}
[junit4] 2> 265829 T693 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 265829 T693 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=29
[junit4] 2> 265855 T656 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453660&spellcheck=true&isShard=true} hits=25 status=0 QTime=10
[junit4] 2> 265855 T652 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453661&spellcheck=true&isShard=true} hits=25 status=0 QTime=9
[junit4] 2> 265855 T649 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=5&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453660&spellcheck=true&isShard=true} hits=25 status=0 QTime=10
[junit4] 2> 265865 T659 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453661&spellcheck=false&isShard=true} status=0 QTime=2
[junit4] 2> 265865 T653 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453660&spellcheck=false&isShard=true} status=0 QTime=2
[junit4] 2> 265865 T662 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck.count=1&spellcheck.q=toyata&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453660&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265866 T708 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}]}},correctlySpelled=true,originalTerms=[toyata]}
[junit4] 2> 265867 T708 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 265867 T708 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=31
[junit4] 2> 265867 T707 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}]}},correctlySpelled=true,originalTerms=[toyata]}
[junit4] 2> 265867 T706 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ {suggestions={toyata={numFound=1,startOffset=0,endOffset=6,origFreq=0,suggestion=[{word=toyota,freq=1}]}},correctlySpelled=true,originalTerms=[toyata]}
[junit4] 2> 265867 T707 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 265868 T706 C167 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/ null
[junit4] 2> 265868 T707 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=33
[junit4] 2> 265868 T706 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::114]:33332/|https://127.0.0.1:43448/|[ff01::213]:33332/|[ff01::083]:33332/&spellcheck=true&spellcheck.q=toyata&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=33
[junit4] 2> 265881 T718 C166 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&spellcheck.count=4&spellcheck=true&spellcheck.q=bluo&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=4
[junit4] 2> 265899 T663 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453713&spellcheck=true&isShard=true} hits=25 status=0 QTime=4
[junit4] 2> 265908 T669 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453713&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265909 T720 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ {suggestions={bluo={numFound=1,startOffset=0,endOffset=4,origFreq=0,suggestion=[{word=blue,freq=1}]}},correctlySpelled=true,originalTerms=[bluo]}
[junit4] 2> 265910 T720 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265910 T720 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck=true&spellcheck.q=bluo&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=22
[junit4] 2> 265912 T500 oas.BaseDistributedSearchTestCase.query starting stress...
[junit4] 2> 265927 T672 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453743&spellcheck=true&isShard=true} hits=25 status=0 QTime=3
[junit4] 2> 265929 T674 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453744&spellcheck=true&isShard=true} hits=25 status=0 QTime=3
[junit4] 2> 265929 T676 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453744&spellcheck=true&isShard=true} hits=25 status=0 QTime=3
[junit4] 2> 265935 T678 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453743&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265936 T727 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ {suggestions={bluo={numFound=1,startOffset=0,endOffset=4,origFreq=0,suggestion=[{word=blue,freq=1}]}},correctlySpelled=true,originalTerms=[bluo]}
[junit4] 2> 265936 T727 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265937 T727 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck=true&spellcheck.q=bluo&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=19
[junit4] 2> 265937 T686 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453744&spellcheck=false&isShard=true} status=0 QTime=0
[junit4] 2> 265937 T684 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453744&spellcheck=false&isShard=true} status=0 QTime=0
[junit4] 2> 265939 T728 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ {suggestions={bluo={numFound=1,startOffset=0,endOffset=4,origFreq=0,suggestion=[{word=blue,freq=1}]}},correctlySpelled=true,originalTerms=[bluo]}
[junit4] 2> 265939 T728 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265939 T729 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ {suggestions={bluo={numFound=1,startOffset=0,endOffset=4,origFreq=0,suggestion=[{word=blue,freq=1}]}},correctlySpelled=true,originalTerms=[bluo]}
[junit4] 2> 265939 T728 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck=true&spellcheck.q=bluo&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=20
[junit4] 2> 265939 T729 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265940 T729 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck=true&spellcheck.q=bluo&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=21
[junit4] 2> 265951 T699 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453769&spellcheck=true&isShard=true} hits=25 status=0 QTime=2
[junit4] 2> 265956 T697 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453771&spellcheck=true&isShard=true} hits=25 status=0 QTime=3
[junit4] 2> 265956 T698 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={fsv=true&q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=5&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,score&spellcheck.extendedResults=true&rows=10&version=2&wt=javabin&start=0&NOW=1411591453773&spellcheck=true&isShard=true} hits=25 status=0 QTime=3
[junit4] 2> 265958 T628 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453769&spellcheck=false&isShard=true} status=0 QTime=0
[junit4] 2> 265960 T739 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ {suggestions={bluo={numFound=1,startOffset=0,endOffset=4,origFreq=0,suggestion=[{word=blue,freq=1}]}},correctlySpelled=true,originalTerms=[bluo]}
[junit4] 2> 265960 T739 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265960 T739 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck=true&spellcheck.q=bluo&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=16
[junit4] 2> 265965 T634 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453771&spellcheck=false&isShard=true} status=0 QTime=1
[junit4] 2> 265965 T636 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&distrib=false&spellcheck.dictionary=direct&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shard.url=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck.q=bluo&spellcheck.onlyMorePopular=false&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin&ids=1,7,10,2,3,5,8,4,6,9&NOW=1411591453773&spellcheck=false&isShard=true} status=0 QTime=0
[junit4] 2> 265967 T740 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ {suggestions={bluo={numFound=1,startOffset=0,endOffset=4,origFreq=0,suggestion=[{word=blue,freq=1}]}},correctlySpelled=true,originalTerms=[bluo]}
[junit4] 2> 265967 T740 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265967 T742 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ {suggestions={bluo={numFound=1,startOffset=0,endOffset=4,origFreq=0,suggestion=[{word=blue,freq=1}]}},correctlySpelled=true,originalTerms=[bluo]}
[junit4] 2> 265967 T740 C167 oasc.SolrCore.execute [collection1] webapp= path=/select params={q=*:*&shards.qt=spellCheckCompRH_Direct&qt=spellCheckCompRH_Direct&shards=[ff01::083]:33332/|https://127.0.0.1:43448/&spellcheck.count=4&spellcheck=true&spellcheck.q=bluo&fl=id,lowerfilt&spellcheck.extendedResults=true&version=2&wt=javabin} hits=25 status=0 QTime=21
[junit4] 2> 265968 T742 C167 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|https://127.0.0.1:43448/ null
[junit4] 2> 265968 T742 C167 oasc.SolrCor
[...truncated too long message...]
992141BC9E4E-001/tempDir-001/shard2/data/index;done=false>>]
[junit4] 2> 425962 T500 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard2/data/index
[junit4] 2> 425962 T500 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard2/data [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard2/data;done=false>>]
[junit4] 2> 425963 T500 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedSpellCheckComponentTest-4382992141BC9E4E-001/tempDir-001/shard2/data
[junit4] 2> 425970 T500 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
[junit4] 2> 430957 T500 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistributedSpellCheckComponentTest -Dtests.method=testDistribSearch -Dtests.seed=4382992141BC9E4E -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/lucene-data/enwiki.random.lines.txt -Dtests.locale=ar_IQ -Dtests.timezone=Indian/Mayotte -Dtests.file.encoding=US-ASCII
[junit4] ERROR 170s J0 | DistributedSpellCheckComponentTest.testDistribSearch <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=2263, name=Thread-1076, state=RUNNABLE, group=TGRP-DistributedSpellCheckComponentTest]
[junit4] > at __randomizedtesting.SeedInfo.seed([4382992141BC9E4E:C264173936E3FE72]:0)
[junit4] > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:44787
[junit4] > at __randomizedtesting.SeedInfo.seed([4382992141BC9E4E]:0)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:580)
[junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:44787
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:558)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206)
[junit4] > at org.apache.solr.client.solrj.request.QueryRequest.process(QueryRequest.java:91)
[junit4] > at org.apache.solr.client.solrj.SolrServer.query(SolrServer.java:301)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$5.run(BaseDistributedSearchTestCase.java:575)
[junit4] > Caused by: java.net.SocketTimeoutException: Read timed out
[junit4] > at java.net.SocketInputStream.socketRead0(Native Method)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:152)
[junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:122)
[junit4] > at sun.security.ssl.InputRecord.readFully(InputRecord.java:442)
[junit4] > at sun.security.ssl.InputRecord.read(InputRecord.java:480)
[junit4] > at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:927)
[junit4] > at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:884)
[junit4] > at sun.security.ssl.AppInputStream.read(AppInputStream.java:102)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
[junit4] > at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
[junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260)
[junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
[junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
[junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:448)
[junit4] > ... 5 more
[junit4] 2> 430970 T500 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {intDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), lowerfilt1and2=PostingsFormat(name=Asserting), end2=PostingsFormat(name=Lucene41VarGapFixedInterval), id=PostingsFormat(name=Lucene41VarGapFixedInterval), gram1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), start3=PostingsFormat(name=Lucene41VarGapFixedInterval), multiDefault=PostingsFormat(name=Asserting), gram4=PostingsFormat(name=Direct), range_facet_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), gram3=PostingsFormat(name=Asserting), start1=PostingsFormat(name=Direct), word=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), start4=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), end3=PostingsFormat(name=Asserting), start2=PostingsFormat(name=Asserting), gram2=PostingsFormat(name=Lucene41VarGapFixedInterval), end1=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), lowerfilt=PostingsFormat(name=Asserting), timestamp=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene41(blocksize=128))), end4=PostingsFormat(name=Direct)}, docValues:{timestamp=DocValuesFormat(name=Lucene410)}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ar_IQ, timezone=Indian/Mayotte
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 (64-bit)/cpus=16,threads=1,free=106621488,total=343932928
[junit4] 2> NOTE: All tests run in this JVM: [TestFieldTypeResource, CoreMergeIndexesAdminHandlerTest, TestAnalyzedSuggestions, SSLMigrationTest, TestNRTOpen, IndexSchemaRuntimeFieldTest, TestRangeQuery, AsyncMigrateRouteKeyTest, TestRandomFaceting, TestCoreContainer, ResourceLoaderTest, DistributedSpellCheckComponentTest]
[junit4] Completed on J0 in 169.90s, 1 test, 1 error <<< FAILURES!
[...truncated 1184 lines...]
BUILD FAILED
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:498: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:471: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:60: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/extra-targets.xml:39: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:189: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:496: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1359: The following error occurred while executing this line:
/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:962: There were test failures: 429 suites, 1775 tests, 1 error, 55 ignored (11 assumptions)
Total time: 174 minutes 49 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #628
Archived 5 artifacts
Archive block size is 32768
Received 0 blocks and 644943698 bytes
Compression is 0.0%
Took 1 min 56 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure