You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/06/17 16:33:40 UTC
[JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.8.0_20-ea-b15) -
Build # 4123 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4123/
Java: 32bit/jdk1.8.0_20-ea-b15 -server -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.handler.component.DistributedDebugComponentTest.testTolerantSearch
Error Message:
Unexpected exception message
Stack Trace:
java.lang.AssertionError: Unexpected exception message
at __randomizedtesting.SeedInfo.seed([C36E36D54DB584BE:597FD0B8E7759EB]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.handler.component.DistributedDebugComponentTest.testTolerantSearch(DistributedDebugComponentTest.java:399)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:483)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:793)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:453)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:360)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11949 lines...]
[junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\init-core-data-001
[junit4] 2> 4146991 T14405 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (true)
[junit4] 2> 4147071 T14405 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 4147071 T14405 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 4147074 T14405 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 4147086 T14405 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:64171
[junit4] 2> 4147086 T14405 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 4147086 T14405 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 4147086 T14405 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001
[junit4] 2> 4147089 T14405 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\'
[junit4] 2> 4147139 T14405 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\solr.xml
[junit4] 2> 4147155 T14405 oasc.CoreContainer.<init> New CoreContainer 29239541
[junit4] 2> 4147155 T14405 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\]
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to:
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 4147158 T14405 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 4147162 T14405 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 4147162 T14405 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 4147162 T14405 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 4147169 T14415 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection1\'
[junit4] 2> 4147234 T14415 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 4147267 T14415 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 4147268 T14415 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 4147277 T14415 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 4147437 T14415 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 4147445 T14415 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 4147448 T14415 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 4147456 T14415 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 4147460 T14415 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 4147464 T14415 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 4147464 T14415 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 4147464 T14415 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 4147464 T14415 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 4147464 T14415 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 4147464 T14415 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 4147464 T14415 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection1\
[junit4] 2> 4147464 T14415 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 4147468 T14415 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-002\
[junit4] 2> 4147468 T14415 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@139563b
[junit4] 2> 4147470 T14415 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-002\
[junit4] 2> 4147470 T14415 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-002\index/
[junit4] 2> 4147470 T14415 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-002\index' doesn't exist. Creating new index...
[junit4] 2> 4147471 T14415 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-002\index
[junit4] 2> 4147471 T14415 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=50, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=51.12890625, floorSegmentMB=1.966796875, forceMergeDeletesPctAllowed=6.668860537547026, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 4147473 T14415 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f31b0c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@300586)),segFN=segments_1,generation=1}
[junit4] 2> 4147473 T14415 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 4147474 T14415 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 4147478 T14415 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 4147479 T14415 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 4147479 T14415 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 4147479 T14415 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 4147479 T14415 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 4147481 T14415 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 4147481 T14415 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 4147481 T14415 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 4147481 T14415 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 4147484 T14415 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 4147484 T14415 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 4147484 T14415 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 4147484 T14415 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 4147484 T14415 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 4147485 T14415 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 4147485 T14415 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 4147486 T14415 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 4147486 T14415 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 4147486 T14415 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 4147489 T14415 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 4147489 T14415 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 4147489 T14415 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 4147489 T14415 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 4147489 T14415 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 4147490 T14415 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 4147492 T14415 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147492 T14415 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147493 T14415 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147493 T14415 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147493 T14415 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147495 T14415 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147495 T14415 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147495 T14415 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147496 T14415 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 4147496 T14415 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 4147502 T14415 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 4147506 T14415 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 4147508 T14415 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 4147508 T14415 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 4147510 T14415 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=83.2041015625, floorSegmentMB=1.412109375, forceMergeDeletesPctAllowed=23.195146029862077, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 4147511 T14415 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f31b0c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@300586)),segFN=segments_1,generation=1}
[junit4] 2> 4147511 T14415 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 4147511 T14415 oass.SolrIndexSearcher.<init> Opening Searcher@1e303e1[collection1] main
[junit4] 2> 4147513 T14415 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 4147513 T14415 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 4147513 T14415 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 4147513 T14415 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 4147513 T14415 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 4147514 T14415 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 4147528 T14415 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 4147600 T14416 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e303e1[collection1] main{UninvertingDirectoryReader()}
[junit4] 2> 4147604 T14415 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 4147606 T14405 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0
[junit4] 2> 4147606 T14405 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 4147606 T14405 oas.SolrJettyTestBase.createJetty Jetty Assigned Port#64171
[junit4] 2> 4147616 T14409 oasha.CoreAdminHandler.handleCreateAction core create command name=collection2&action=CREATE&wt=javabin&version=2
[junit4] 2> 4147617 T14409 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection2\'
[junit4] 2> 4147666 T14409 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0
[junit4] 2> 4147700 T14409 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 4147702 T14409 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 4147710 T14409 oass.IndexSchema.readSchema [collection2] Schema name=test
[junit4] 2> 4147855 T14409 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 4147860 T14409 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 4147860 T14409 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 4147871 T14409 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 4147876 T14409 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 4147878 T14409 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 4147878 T14409 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 4147878 T14409 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 4147878 T14409 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 4147881 T14409 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 4147881 T14409 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 4147881 T14409 oasc.CoreContainer.create Creating SolrCore 'collection2' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection2\
[junit4] 2> 4147881 T14409 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 4147885 T14409 oasc.SolrCore.<init> [collection2] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection2\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection2\data\
[junit4] 2> 4147885 T14409 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@139563b
[junit4] 2> 4147887 T14409 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection2\data\
[junit4] 2> 4147887 T14409 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection2\data\index/
[junit4] 2> 4147887 T14409 oasc.SolrCore.initIndex WARN [collection2] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection2\data\index' doesn't exist. Creating new index...
[junit4] 2> 4147888 T14409 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.handler.component.DistributedDebugComponentTest-C36E36D54DB584BE-001\tempDir-001\collection2\data\index
[junit4] 2> 4147889 T14409 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=50, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=51.12890625, floorSegmentMB=1.966796875, forceMergeDeletesPctAllowed=6.668860537547026, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 4147889 T14409 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@19b1680 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e7fb16)),segFN=segments_1,generation=1}
[junit4] 2> 4147889 T14409 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 4147892 T14409 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 4147896 T14409 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 4147898 T14409 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 4147898 T14409 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 4147898 T14409 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 4147899 T14409 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 4147899 T14409 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 4147899 T14409 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 4147900 T14409 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 4147900 T14409 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 4147903 T14409 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 4147903 T14409 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 4147903 T14409 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 4147903 T14409 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 4147903 T14409 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 4147906 T14409 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 4147906 T14409 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 4147907 T14409 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 4147907 T14409 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 4147909 T14409 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 4147909 T14409 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 4147909 T14409 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
[junit4] 2> 4147910 T14409 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 4147910 T14409 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 4147910 T14409 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 4147913 T14409 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 4147913 T14409 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147914 T14409 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147914 T14409 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147916 T14409 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147916 T14409 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147916 T14409 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147917 T14409 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147918 T14409 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 4147918 T14409 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 4147920 T14409 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 4147922 T14409 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 4147922 T14409 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 4147928 T14409 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 4147929 T14409 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 4147929 T14409 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=83.2041015625, floorSegmentMB=1.412109375, forceMergeDeletesPctAllowed=23.195146029862077, segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 4147932 T14409 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@19b1680 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e7fb16)),segFN=segments_1,generation=1}
[junit4] 2> 4147932 T14409 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 4147934 T14409 oass.SolrIndexSearcher.<init> Opening Searcher@42f783[collection2] main
[junit4] 2> 4147935 T14409 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 4147936 T14409 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 4147936 T14409 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 4147936 T14409 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 4147938 T14409 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 4147938 T14409 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 4147953 T14409 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 4148020 T14418 oasc.SolrCore.registerSearcher [collection2] Registered new searcher Searcher@42f783[collection2] main{UninvertingDirectoryReader()}
[junit4] 2> 4148027 T14409 oasc.CoreContainer.registerCore registering core: collection2
[junit4] 2> 4148027 T14409 oass.SolrDispatchFilter.handleAdminRequest [admin] webapp=null path=/admin/cores params={name=collection2&action=CREATE&wt=javabin&version=2} status=0 QTime=411
[junit4] 2> ASYNC NEW_CORE C2937 name=collection1 org.apache.solr.core.SolrCore@d233c2
[junit4] 2> 4148036 T14412 C2937 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 (1471168241162256384)]} 0 3
[junit4] 2> 4148040 T14413 C2937 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 4148043 T14413 C2937 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f31b0c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@300586)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@f31b0c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@300586)),segFN=segments_2,generation=2}
[junit4] 2> 4148043 T14413 C2937 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 4148045 T14413 C2937 oass.SolrIndexSearcher.<init> Opening Searcher@162e261[collection1] main
[junit4] 2> 4148045 T14413 C2937 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 4148048 T14416 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@162e261[collection1] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1))}
[junit4] 2> 4148049 T14413 C2937 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 9
[junit4] 2> ASYNC NEW_CORE C2938 name=collection2 org.apache.solr.core.SolrCore@170d14
[junit4] 2> 4148056 T14414 C2938 oasup.LogUpdateProcessor.finish [collection2] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2 (1471168241184276480)]} 0 2
[junit4] 2> 4148060 T14410 C2938 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 4148063 T14410 C2938 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@19b1680 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e7fb16)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@19b1680 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1e7fb16)),segFN=segments_2,generation=2}
[junit4] 2> 4148063 T14410 C2938 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 4148066 T14410 C2938 oass.SolrIndexSearcher.<init> Opening Searcher@6b7780[collection2] main
[junit4] 2> 4148066 T14410 C2938 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 4148069 T14418 oasc.SolrCore.registerSearcher [collection2] Registered new searcher Searcher@6b7780[collection2] main{UninvertingDirectoryReader(Uninverting(_0(5.0):C1))}
[junit4] 2> 4148070 T14410 C2938 oasup.LogUpdateProcessor.finish [collection2] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 10
[junit4] 2> 4148081 T14405 oas.SolrTestCaseJ4.setUp ###Starting testRandom
[junit4] 2> 4148091 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1403015366763&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148099 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&debug=timing&debug=results&debug=results&debug=timing&fl=id,text&NOW=1403015366763&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148100 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=timing&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=13
[junit4] 2> 4148107 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1403015366781&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148109 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_&NOW=1403015366781&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148110 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=5
[junit4] 2> 4148116 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015366789-23&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015366789&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148121 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=track&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015366789&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015366789-23&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148123 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015366789-23 hits=1 status=0 QTime=10
[junit4] 2> 4148128 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015366801&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148132 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&debug=timing&debug=timing&fl=id,text&NOW=1403015366801&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148134 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=9
[junit4] 2> 4148141 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015366812-24&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015366812&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148149 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=query&debug=track&debug=query&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015366812&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015366812-24&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 4148149 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015366812-24 hits=1 status=0 QTime=13
[junit4] 2> 4148156 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1403015366829&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148157 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=4
[junit4] 2> 4148163 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015366836&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148164 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=timing&debug=results&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=4
[junit4] 2> 4148174 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1403015366845&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2
[junit4] 2> 4148174 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1403015366845&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2
[junit4] 2> 4148185 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=results&debug=results&fl=id,text&NOW=1403015366845&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 4148186 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=results&debug=results&fl=id,text&NOW=1403015366845&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148187 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=2 status=0 QTime=18
[junit4] 2> 4148200 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015366869-25&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015366869&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2
[junit4] 2> 4148212 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=true&debug=timing&debug=track&fl=id,text&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015366869-25&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015366869&ids=2&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=7
[junit4] 2> 4148215 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=true&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015366869-25 hits=1 status=0 QTime=22
[junit4] 2> 4148232 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015366902-26&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015366902&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148233 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015366902-26&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015366902&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148239 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=query&debug=results&debug=track&debug=query&debug=results&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015366902&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015366902-26&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148240 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=query&debug=results&debug=track&debug=query&debug=results&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015366902&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015366902-26&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148241 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015366902-26 hits=2 status=0 QTime=15
[junit4] 2> 4148251 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015366923-27&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015366921&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1
[junit4] 2> 4148255 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=track&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015366921&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015366923-27&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148256 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015366923-27 hits=1 status=0 QTime=11
[junit4] 2> 4148263 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015366937-28&rows=10&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_TOP_IDS&NOW=1403015366937&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148265 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015366937-28 hits=0 status=0 QTime=4
[junit4] 2> 4148272 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015366945-29&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1403015366945&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148273 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=timing&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015366945-29 hits=0 status=0 QTime=4
[junit4] 2> 4148280 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015366953-30&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1403015366953&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148281 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=true&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015366953-30 hits=0 status=0 QTime=4
[junit4] 2> 4148288 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015366961-31&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015366961&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148294 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=timing&debug=results&debug=track&debug=results&debug=timing&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015366961&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015366961-31&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 4148295 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015366961-31 hits=1 status=0 QTime=10
[junit4] 2> 4148303 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015366975-32&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015366975&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148310 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=query&debug=results&debug=track&debug=query&debug=results&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015366975&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015366975-32&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148312 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015366975-32 hits=1 status=0 QTime=13
[junit4] 2> 4148321 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1403015366992&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1
[junit4] 2> 4148321 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1403015366992&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1
[junit4] 2> 4148328 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&debug=timing&debug=results&debug=results&debug=timing&fl=id,text&NOW=1403015366992&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148331 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=15
[junit4] 2> 4148342 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367014-33&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1403015367014&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1
[junit4] 2> 4148342 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015367014-33&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1403015367014&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148346 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367014-33 hits=0 status=0 QTime=8
[junit4] 2> 4148356 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015367026&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2
[junit4] 2> 4148361 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&debug=timing&debug=timing&fl=id,text&NOW=1403015367026&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148364 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=14
[junit4] 2> 4148375 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367046-34&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367044&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148377 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015367046-34&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367044&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148385 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=track&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367044&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015367046-34&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148385 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=track&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367044&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367046-34&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148389 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367046-34 hits=2 status=0 QTime=21
[junit4] 2> 4148401 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015367070-35&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367070&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148408 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=timing&debug=results&debug=track&debug=results&debug=timing&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367070&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015367070-35&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148411 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=timing&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015367070-35 hits=1 status=0 QTime=17
[junit4] 2> 4148421 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015367091&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148422 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=7
[junit4] 2> 4148433 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015367105-36&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367104&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148441 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=true&debug=timing&debug=track&fl=id,text&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015367105-36&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367104&ids=2&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=1
[junit4] 2> 4148444 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=true&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015367105-36 hits=1 status=0 QTime=16
[junit4] 2> 4148455 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015367126-37&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367126&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148455 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015367126-37&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367126&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1
[junit4] 2> 4148462 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&debug=track&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367126&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015367126-37&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148463 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015367126-37 hits=1 status=0 QTime=13
[junit4] 2> 4148474 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1403015367146&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148474 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1403015367146&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148483 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=timing&debug=results&debug=results&debug=timing&fl=id,text&NOW=1403015367146&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 4148484 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=timing&debug=results&debug=results&debug=timing&fl=id,text&NOW=1403015367146&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148486 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=results&fl=id,text&wt=javabin&version=2} hits=2 status=0 QTime=16
[junit4] 2> 4148497 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015367167&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=2
[junit4] 2> 4148497 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015367167&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2
[junit4] 2> 4148503 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&debug=results&debug=results&fl=id,text&NOW=1403015367167&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148506 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=15
[junit4] 2> 4148516 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015367186&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148523 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&debug=timing&debug=query&debug=results&debug=query&debug=results&debug=timing&fl=id,text&NOW=1403015367186&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 4148526 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=query&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=16
[junit4] 2> 4148535 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015367207-38&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367207&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148535 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367207-38&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367207&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148544 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&debug=query&debug=results&debug=track&debug=query&debug=results&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367207&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015367207-38&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 4148546 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367207-38 hits=1 status=0 QTime=15
[junit4] 2> 4148557 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367228-39&rows=10&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_TOP_IDS&NOW=1403015367228&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1
[junit4] 2> 4148564 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&debug=query&debug=track&debug=query&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367228&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367228-39&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148566 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367228-39 hits=1 status=0 QTime=14
[junit4] 2> 4148577 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1403015367247&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148584 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=results&debug=results&fl=id,text&NOW=1403015367247&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148586 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=15
[junit4] 2> 4148597 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015367269-40&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367269&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1
[junit4] 2> 4148597 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015367269-40&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367269&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1
[junit4] 2> 4148606 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=timing&debug=query&debug=results&debug=track&debug=timing&debug=track&fl=id,text&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015367269-40&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367269&ids=2&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=0
[junit4] 2> 4148608 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015367269-40 hits=1 status=0 QTime=15
[junit4] 2> 4148619 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015367291-41&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367290&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1
[junit4] 2> 4148621 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015367291-41 hits=0 status=0 QTime=7
[junit4] 2> 4148633 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1403015367304&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148636 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=8
[junit4] 2> 4148646 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_&NOW=1403015367317&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=2
[junit4] 2> 4148647 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=6
[junit4] 2> 4148658 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1403015367329&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148665 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&debug=timing&debug=query&debug=results&debug=query&debug=results&debug=timing&fl=id,text&NOW=1403015367329&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148668 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=timing&debug=query&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=15
[junit4] 2> 4148679 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015367351-42&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367351&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=2
[junit4] 2> 4148680 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=timing&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015367351-42 hits=0 status=0 QTime=5
[junit4] 2> 4148691 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367363-43&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367362&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1
[junit4] 2> 4148691 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015367363-43&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367362&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1
[junit4] 2> 4148699 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&debug=query&debug=track&debug=query&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367362&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015367363-43&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148701 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367363-43 hits=1 status=0 QTime=15
[junit4] 2> 4148712 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015367384&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148713 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=5
[junit4] 2> 4148724 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367396-44&rows=10&version=2&q=_query_with_no_results_+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367395&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1
[junit4] 2> 4148726 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=timing&debug=query&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367396-44 hits=0 status=0 QTime=7
[junit4] 2> 4148737 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015367409-45&rows=10&version=2&q=_query_with_no_results_+OR+batman&requestPurpose=GET_TOP_IDS&NOW=1403015367407&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2
[junit4] 2> 4148744 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&distrib=false&debug=query&debug=results&debug=track&debug=query&debug=results&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367407&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection1-1403015367409-45&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 4148746 T14413 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015367409-45 hits=1 status=0 QTime=15
[junit4] 2> 4148757 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman&NOW=1403015367427&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=0
[junit4] 2> 4148759 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=query&fl=id,text&wt=javabin&version=2} hits=0 status=0 QTime=8
[junit4] 2> 4148773 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015367444-46&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367443&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=2
[junit4] 2> 4148778 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=timing&debug=results&debug=track&debug=results&debug=timing&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367443&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection1-1403015367444-46&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148781 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection1-1403015367444-46 hits=1 status=0 QTime=14
[junit4] 2> 4148792 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367464-47&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367462&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148797 T14409 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=timing&debug=query&debug=results&debug=track&debug=timing&debug=track&fl=id,text&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367464-47&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367462&ids=1&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=1
[junit4] 2> 4148800 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=timing&debug=query&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367464-47 hits=1 status=0 QTime=14
[junit4] 2> 4148811 T14411 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367483-48&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&requestPurpose=GET_TOP_IDS&NOW=1403015367482&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1
[junit4] 2> 4148815 T14414 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=results&debug=track&debug=results&debug=track&fl=id,text&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1403015367482&ids=1&isShard=true&shard.url=127.0.0.1:64171/solr/collection1&rid=127.0.0.1-collection2-1403015367483-48&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 4148820 T14412 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&shards=127.0.0.1:64171/solr/collection1&distrib=true&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367483-48 hits=1 status=0 QTime=14
[junit4] 2> 4148829 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rid=127.0.0.1-collection2-1403015367501-49&rows=10&version=2&q=_query_with_no_results_&requestPurpose=GET_TOP_IDS&NOW=1403015367500&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=1
[junit4] 2> 4148832 T14410 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_&shards=127.0.0.1:64171/solr/collection2&distrib=true&debug=timing&debug=results&debug=track&fl=id,text&wt=javabin&version=2} rid=127.0.0.1-collection2-1403015367501-49 hits=0 status=0 QTime=8
[junit4] 2> 4148842 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015367513&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=0
[junit4] 2> 4148842 T14412 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection1&rows=10&version=2&q=_query_with_no_results_+OR+superman&NOW=1403015367513&isShard=true&wt=javabin&debugQuery=false} hits=0 status=0 QTime=2
[junit4] 2> 4148849 T14409 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&distrib=false&debug=results&debug=results&fl=id,text&NOW=1403015367513&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 4148851 T14411 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+superman&shards=127.0.0.1:64171/solr/collection1,127.0.0.1:64171/solr/collection2&distrib=true&debug=results&fl=id,text&wt=javabin&version=2} hits=1 status=0 QTime=14
[junit4] 2> 4148861 T14413 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={distrib=false&debug=false&fl=id,score&start=0&fsv=true&shard.url=127.0.0.1:64171/solr/collection2&rows=10&version=2&q=_query_with_no_results_+OR+batman+OR+superman&NOW=1403015367531&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1
[junit4] 2> 4148866 T14414 C2938 oasc.SolrCore.execute [collection2] webapp=/solr path=/select params={q=_query_with_no_results_+OR+batman+OR+superman&distrib=false&debug=query&debug=results&debug=query&debug=results&fl=id,text&NOW=1403015367531&ids=2&isShard=true&shard.url=127.0.0.1:64171/solr/collection2&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 4148868 T14410 C2937 oasc.SolrCore.execute [collection1] webapp=/solr path=/se
[...truncated too long message...]
order, XmlUpdateRequestHandlerTest, LegacyHTMLStripCharFilterTest, DOMUtilTest, TestSolrJ, SearchHandlerTest, DocumentBuilderTest, RemoteQueryErrorTest, TestMergePolicyConfig, TestCursorMarkWithoutUniqueKey, TestSearchPerf, SpellingQueryConverterTest, DistributedExpandComponentTest, FieldMutatingUpdateProcessorTest, OutputWriterTest, TestReRankQParserPlugin, SolrCoreCheckLockOnStartupTest, AbstractAnalyticsStatsTest, AliasIntegrationTest, DistributedQueryComponentCustomSortTest, TestSolrXMLSerializer, TestMaxScoreQueryParser, TestIBSimilarityFactory, TestOverriddenPrefixQueryForCustomFieldType, TestFieldCollectionResource, TestPseudoReturnFields, ShardRoutingCustomTest, DocValuesTest, TestUniqueKeyFieldResource, TestReplicationHandlerBackup, DirectUpdateHandlerTest, TestCustomSort, SignatureUpdateProcessorFactoryTest, LukeRequestHandlerTest, SolrCmdDistributorTest, TestDefaultSearchFieldResource, DistanceFunctionTest, TestCollationFieldDocValues, PathHierarchyTokenizerFactoryTest, UpdateParamsTest, PluginInfoTest, HdfsLockFactoryTest, TestClassNameShortening, SchemaVersionSpecificBehaviorTest, ResponseHeaderTest, NotRequiredUniqueKeyTest, TestExtendedDismaxParser, TestBlendedInfixSuggestions, TestRandomFaceting, ZkCLITest, SliceStateUpdateTest, TestCollationField, ChangedSchemaMergeTest, DocumentAnalysisRequestHandlerTest, TestManagedSchemaFieldResource, HighlighterMaxOffsetTest, TestStressUserVersions, TestSchemaSimilarityResource, TestJoin, TimeZoneUtilsTest, InfoHandlerTest, TestLMJelinekMercerSimilarityFactory, FieldAnalysisRequestHandlerTest, TestHighFrequencyDictionaryFactory, ZkControllerTest, BadIndexSchemaTest, ShowFileRequestHandlerTest, FullSolrCloudDistribCmdsTest, TestDocBasedVersionConstraints, DirectSolrSpellCheckerTest, TestQueryTypes, DebugComponentTest, DateRangeFieldTest, TestDocumentBuilder, TestSchemaVersionResource, TestTrie, TestValueSourceCache, TestBinaryResponseWriter, TestExceedMaxTermLength, TestManagedResourceStorage, DocValuesMultiTest, CacheHeaderTest, TestNRTOpen, CurrencyFieldOpenExchangeTest, ReturnFieldsTest, ClusterStateUpdateTest, SuggesterWFSTTest, TestCloudInspectUtil, TestSolrIndexConfig, TestFastOutputStream, SimplePostToolTest, TestBadConfig, TestMultiCoreConfBootstrap, TestJmxMonitoredMap, TestRandomMergePolicy, OverseerCollectionProcessorTest, PreAnalyzedFieldTest, SolrIndexSplitterTest, DocExpirationUpdateProcessorFactoryTest, BasicZkTest, AnalysisErrorHandlingTest, TestShortCircuitedRequests, TestLuceneMatchVersion, FastVectorHighlighterTest, TestManagedResource, TestPerFieldSimilarity, IndexSchemaTest, TestFastWriter, FunctionTest, PrimUtilsTest, TestFileDictionaryLookup, AutoCommitTest, StatsComponentTest, TestSearcherReuse, MigrateRouteKeyTest, SpellCheckComponentTest, TestLFUCache, BlockCacheTest, TestDynamicFieldResource, LeaderElectionIntegrationTest, ResourceLoaderTest, TestModifyConfFiles, PreAnalyzedUpdateProcessorTest, TestPostingsSolrHighlighter, NoFacetTest, TestConfig, URLClassifyProcessorTest, TermsComponentTest, TestWordDelimiterFilterFactory, TestExpandComponent, TestRangeQuery, AnalysisAfterCoreReloadTest, TestFieldSortValues, UpdateRequestProcessorFactoryTest, TestSchemaResource, IndexBasedSpellCheckerTest, OpenExchangeRatesOrgProviderTest, TestBM25SimilarityFactory, TestCSVLoader, QueryResultKeyTest, FieldFacetExtrasTest, JSONWriterTest, TestDynamicFieldCollectionResource, AnalyticsQueryTest, SpellPossibilityIteratorTest, TestFieldTypeResource, TestFreeTextSuggestions, QueryElevationComponentTest, TestNoOpRegenerator, StatelessScriptUpdateProcessorFactoryTest, TestCloudManagedSchemaAddFields, BasicDistributedZkTest, SolrTestCaseJ4Test, ChaosMonkeySafeLeaderTest, ShardRoutingTest, TestSolrQueryParser, TestZkChroot, HdfsDirectoryTest, SimpleFacetsTest, TestSurroundQueryParser, SolrCoreTest, TestFastLRUCache, TestSolrQueryParserResource, TestCloudManagedSchema, HdfsChaosMonkeySafeLeaderTest, AlternateDirectoryTest, UniqFieldsUpdateProcessorFactoryTest, SOLR749Test, ConvertedLegacyTest, DeleteShardTest, CurrencyFieldXmlFileTest, TestNonNRTOpen, RangeFacetTest, SolrPluginUtilsTest, DocValuesMissingTest, TestCloudManagedSchemaCopyFields, HdfsRecoveryZkTest, TestReloadAndDeleteDocs, PrimitiveFieldTypeTest, EnumFieldTest, DirectUpdateHandlerOptimizeTest, DistributedSuggestComponentTest, CSVRequestHandlerTest, TestQuerySenderNoQuery, TestSolrCoreProperties, PeerSyncTest, TestConfigSets, TestFieldTypeCollectionResource, TestSuggestSpellingConverter, JsonLoaderTest, TestSolrDeletionPolicy1, TestStressVersions, TestReload, FieldFacetTest, SpatialFilterTest, TestManagedSchema, QueryFacetTest, OverseerTest, LeaderElectionTest, TestAnalyzedSuggestions, TestCollapseQParserPlugin, BasicDistributedZk2Test, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, RecoveryZkTest, TestReplicationHandler, ZkSolrClientTest, TestRandomDVFaceting, TestDistributedSearch, TestDistributedGrouping, TestFaceting, TestRecovery, TestHashPartitioner, DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, TestRealTimeGet, HardAutoCommitTest, DistributedTermsComponentTest, TestCoreContainer, TestSolr4Spatial, TestGroupingSearch, TestSort, TestFiltering, TestFunctionQuery, BasicFunctionalityTest, TestLazyCores, TestIndexSearcher, HighlighterTest, SoftAutoCommitTest, DistributedQueryElevationComponentTest, TestCoreDiscovery, SpellCheckCollatorTest, SuggesterFSTTest, CoreAdminHandlerTest, SolrRequestParserTest, TestFoldingMultitermQuery, SuggesterTSTTest, SuggesterTest, TestStressLucene, PolyFieldTest, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, TestUpdate, TestAtomicUpdateErrorCases, QueryEqualityTest, DefaultValueUpdateProcessorTest, SortByFunctionTest, TestRemoteStreaming, SolrInfoMBeanTest, XsltUpdateRequestHandlerTest, DisMaxRequestHandlerTest, TestQueryUtils, StandardRequestHandlerTest, TestWriterPerf, TestReversedWildcardFilterFactory, TestOmitPositions, FileBasedSpellCheckerTest, RequestHandlersTest, TermVectorComponentTest, TestIndexingPerformance, MoreLikeThisHandlerTest, RequiredFieldsTest, TestArbitraryIndexDir, IndexSchemaRuntimeFieldTest, LoggingHandlerTest, RegexBoostProcessorTest, TestJmxIntegration, TestCSVResponseWriter, MBeansHandlerTest, QueryParsingTest, BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, PingRequestHandlerTest, TestComponentsName, CoreContainerCoreInitFailuresTest, HighlighterConfigTest, TestQuerySenderListener, CopyFieldTest, ResponseLogComponentTest, SolrIndexConfigTest, BadComponentTest, TestStressRecovery, TestSolrDeletionPolicy2, MultiTermTest, SampleTest, TestDocSet, TestBinaryField, NumericFieldsTest, MinimalSchemaTest, TestElisionMultitermQuery, TestFuzzyAnalyzedSuggestions, ExternalFileFieldSortTest, DirectSolrConnectionTest, TestPhraseSuggestions, TestCharFilters, TestCodecSupport, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, TestSweetSpotSimilarityFactory, TestDFRSimilarityFactory, TestLMDirichletSimilarityFactory, TestDefaultSimilarityFactory, ScriptEngineTest, DateMathParserTest, ChaosMonkeyNothingIsSafeTest, TestSystemIdResolver, DateFieldTest, RAMDirectoryFactoryTest, ClusterStateTest, TestLRUCache, TestUtils, ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, UUIDFieldTest, FileUtilsTest, CircularListTest, TestRTGBase, CursorPagingTest, TestDistributedMissingSort, TestHighlightDedupGrouping, ExpressionTest, AbstractAnalyticsFacetTest, AssignTest, AsyncMigrateRouteKeyTest, CollectionsAPIAsyncDistributedZkTest, ConnectionManagerTest, CustomCollectionTest, DeleteInactiveReplicaTest, DeleteReplicaTest, DistribCursorPagingTest, DistribDocExpirationUpdateProcessorTest, HttpPartitionTest, MultiThreadedOCPTest, OverseerRolesTest, OverseerStatusTest, ReplicationFactorTest, SSLMigrationTest, ShardSplitTest, SolrXmlInZkTest, TestCollectionAPI, TestDistribDocBasedVersion, TestMiniSolrCloudCluster, TestRequestStatusCollectionAPI, TriLevelCompositeIdRoutingTest, HdfsBasicDistributedZk2Test, HdfsBasicDistributedZkTest, HdfsCollectionsAPIDistributedZkTest, HdfsSyncSliceTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, CachingDirectoryFactoryTest, TestImplicitCoreProperties, TestInfoStreamLogging, TestShardHandlerFactory, TestSolrXml, TestSolrXmlPersistence, TestSolrXmlPersistor, CoreAdminCreateDiscoverTest, CoreAdminRequestStatusTest, CoreMergeIndexesAdminHandlerTest, DistributedDebugComponentTest]
[junit4] Completed in 2.54s, 5 tests, 1 failure <<< FAILURES!
[...truncated 113 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:447: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:45: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:496: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1296: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:920: There were test failures: 416 suites, 1704 tests, 1 failure, 41 ignored (20 assumptions)
Total time: 104 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.8.0_20-ea-b15 -server -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any