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/02/12 06:08:29 UTC

[JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.7.0_51) - Build # 9446 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/9446/
Java: 64bit/jdk1.7.0_51 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

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

Error Message:
Expected the partialResults header to be null

Stack Trace:
java.lang.AssertionError: Expected the partialResults header to be null
	at __randomizedtesting.SeedInfo.seed([3F59596341DAD68:82131B8E4342CD54]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.junit.Assert.assertNull(Assert.java:551)
	at org.apache.solr.TestDistributedSearch.validateControlData(TestDistributedSearch.java:525)
	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:445)
	at org.apache.solr.TestDistributedSearch.doTest(TestDistributedSearch.java:379)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:874)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	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.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	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:70)
	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:358)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	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 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:70)
	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:358)
	at java.lang.Thread.run(Thread.java:744)




Build Log:
[...truncated 10577 lines...]
   [junit4] Suite: org.apache.solr.TestDistributedSearch
   [junit4]   2> 1117159 T4423 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (true)
   [junit4]   2> 1117159 T4423 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /qeex/fg
   [junit4]   2> 1117163 T4423 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
   [junit4]   2> 1117164 T4423 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 1117167 T4423 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:46379
   [junit4]   2> 1117167 T4423 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 1117168 T4423 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1117168 T4423 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
   [junit4]   2> 1117168 T4423 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
   [junit4]   2> 1117183 T4423 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
   [junit4]   2> 1117215 T3 oasc.CoreContainer.finalize ERROR CoreContainer was not shutdown prior to finalize(), indicates a bug -- POSSIBLE RESOURCE LEAK!!!  instance=558556041
   [junit4]   2> 1117215 T3 oasc.CoreContainer.finalize ERROR CoreContainer was not shutdown prior to finalize(), indicates a bug -- POSSIBLE RESOURCE LEAK!!!  instance=590828537
   [junit4]   2> 1117247 T4423 oasc.CoreContainer.<init> New CoreContainer 441151919
   [junit4]   2> 1117247 T4423 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/]
   [junit4]   2> 1117248 T4423 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1117248 T4423 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1117248 T4423 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1117249 T4423 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1117249 T4423 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1117249 T4423 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1117249 T4423 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1117250 T4423 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1117250 T4423 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1117252 T4423 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1117252 T4423 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1117252 T4423 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 1117256 T4433 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
   [junit4]   2> 1117256 T4433 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 1117257 T4433 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1117257 T4433 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1117305 T4433 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
   [junit4]   2> 1117356 T4433 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1117356 T4433 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 1117364 T4433 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 1117708 T4433 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1117714 T4433 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1117716 T4433 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1117721 T4433 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1117723 T4433 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1117726 T4433 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1117726 T4433 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1117726 T4433 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1117726 T4433 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1117727 T4433 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1117727 T4433 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1117727 T4433 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1117727 T4433 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedSearch-1392181196396/control/data/
   [junit4]   2> 1117728 T4433 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6dad2bfb
   [junit4]   2> 1117728 T4433 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.TestDistributedSearch-1392181196396/control/data
   [junit4]   2> 1117728 T4433 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedSearch-1392181196396/control/data/index/
   [junit4]   2> 1117728 T4433 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.TestDistributedSearch-1392181196396/control/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1117729 T4433 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.TestDistributedSearch-1392181196396/control/data/index
   [junit4]   2> 1117729 T4433 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=14, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=79.001953125, floorSegmentMB=2.0048828125, forceMergeDeletesPctAllowed=0.5533141356508342, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6289603927612917
   [junit4]   2> 1117730 T4433 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@36efc304 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39a1a59f)),segFN=segments_1,generation=1}
   [junit4]   2> 1117730 T4433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1117730 T4433 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
   [junit4]   2> 1117733 T4433 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1117733 T4433 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1117733 T4433 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1117734 T4433 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1117734 T4433 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1117734 T4433 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1117734 T4433 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1117734 T4433 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1117734 T4433 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1117735 T4433 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1117735 T4433 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1117735 T4433 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1117735 T4433 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 1117736 T4433 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 1117736 T4433 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 1117736 T4433 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 1117737 T4433 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
   [junit4]   2> 1117737 T4433 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 1117737 T4433 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 1117738 T4433 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 1117738 T4433 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 1117738 T4433 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 1117738 T4433 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 1117739 T4433 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 1117739 T4433 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 1117739 T4433 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1117739 T4433 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1117740 T4433 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1117740 T4433 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1117740 T4433 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1117741 T4433 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1117741 T4433 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1117741 T4433 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1117741 T4433 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 1117742 T4433 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 1117744 T4433 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1117745 T4433 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 1117748 T4433 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1117748 T4433 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1117748 T4433 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 1117749 T4433 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@36efc304 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39a1a59f)),segFN=segments_1,generation=1}
   [junit4]   2> 1117749 T4433 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1117749 T4433 oass.SolrIndexSearcher.<init> Opening Searcher@282493fe[collection1] main
   [junit4]   2> 1117749 T4433 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 1117846 T4433 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1117865 T4434 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@282493fe[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 1117868 T4433 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1117868 T4423 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1117869 T4423 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1117870 T4423 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 1117871 T4423 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:43091
   [junit4]   2> 1117872 T4423 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
   [junit4]   2> 1117872 T4423 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1117872 T4423 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
   [junit4]   2> 1117873 T4423 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
   [junit4]   2> 1117889 T4423 oasc.ConfigSolr.fromFile Loading container configuration from /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
   [junit4]   2> 1117938 T4423 oasc.CoreContainer.<init> New CoreContainer 624420630
   [junit4]   2> 1117938 T4423 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/]
   [junit4]   2> 1117939 T4423 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
   [junit4]   2> 1117940 T4423 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: 
   [junit4]   2> 1117940 T4423 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
   [junit4]   2> 1117940 T4423 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
   [junit4]   2> 1117940 T4423 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
   [junit4]   2> 1117941 T4423 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
   [junit4]   2> 1117941 T4423 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
   [junit4]   2> 1117941 T4423 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
   [junit4]   2> 1117941 T4423 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
   [junit4]   2> 1117943 T4423 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1117944 T4423 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1117944 T4423 oasc.CoreContainer.load Host Name: 127.0.0.1
   [junit4]   2> 1117947 T4445 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
   [junit4]   2> 1117947 T4445 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
   [junit4]   2> 1117948 T4445 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 1117948 T4445 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 1117989 T4445 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
   [junit4]   2> 1118036 T4445 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1118037 T4445 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
   [junit4]   2> 1118045 T4445 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 1118392 T4445 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1118397 T4445 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1118399 T4445 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1118404 T4445 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1118406 T4445 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1118409 T4445 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1118409 T4445 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1118410 T4445 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1118410 T4445 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1118410 T4445 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1118410 T4445 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1118411 T4445 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1118411 T4445 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data/
   [junit4]   2> 1118411 T4445 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6dad2bfb
   [junit4]   2> 1118412 T4445 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data
   [junit4]   2> 1118412 T4445 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data/index/
   [junit4]   2> 1118412 T4445 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.TestDistributedSearch-1392181196396/shard0/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1118412 T4445 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data/index
   [junit4]   2> 1118412 T4445 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=14, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=79.001953125, floorSegmentMB=2.0048828125, forceMergeDeletesPctAllowed=0.5533141356508342, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6289603927612917
   [junit4]   2> 1118413 T4445 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@5d3a0514 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6955089a)),segFN=segments_1,generation=1}
   [junit4]   2> 1118413 T4445 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1118414 T4445 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
   [junit4]   2> 1118417 T4445 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1118418 T4445 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1118418 T4445 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1118418 T4445 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1118418 T4445 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1118418 T4445 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1118418 T4445 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1118419 T4445 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1118419 T4445 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1118419 T4445 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1118419 T4445 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1118420 T4445 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1118420 T4445 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
   [junit4]   2> 1118420 T4445 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
   [junit4]   2> 1118420 T4445 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
   [junit4]   2> 1118421 T4445 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
   [junit4]   2> 1118421 T4445 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
   [junit4]   2> 1118422 T4445 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
   [junit4]   2> 1118422 T4445 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
   [junit4]   2> 1118423 T4445 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
   [junit4]   2> 1118423 T4445 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler
   [junit4]   2> 1118423 T4445 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
   [junit4]   2> 1118423 T4445 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
   [junit4]   2> 1118424 T4445 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
   [junit4]   2> 1118424 T4445 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
   [junit4]   2> 1118425 T4445 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1118425 T4445 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1118425 T4445 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1118426 T4445 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1118426 T4445 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1118426 T4445 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1118427 T4445 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1118427 T4445 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
   [junit4]   2> 1118428 T4445 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
   [junit4]   2> 1118428 T4445 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
   [junit4]   2> 1118430 T4445 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1118432 T4445 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 1118434 T4445 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1118434 T4445 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1118435 T4445 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 1118435 T4445 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@5d3a0514 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6955089a)),segFN=segments_1,generation=1}
   [junit4]   2> 1118435 T4445 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1118436 T4445 oass.SolrIndexSearcher.<init> Opening Searcher@28175286[collection1] main
   [junit4]   2> 1118436 T4445 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 1118440 T4445 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1118463 T4446 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@28175286[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
   [junit4]   2> 1118468 T4445 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1118469 T4423 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1118469 T4423 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> ASYNC  NEW_CORE C15591 name=collection1 org.apache.solr.core.SolrCore@273c8612
   [junit4]   2> 1118472 T4429 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1459807791563669504)} 0 1
   [junit4]   2> ASYNC  NEW_CORE C15592 name=collection1 org.apache.solr.core.SolrCore@5079f9fe
   [junit4]   2> 1118474 T4443 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1459807791565766656)} 0 1
   [junit4]   2> 1118479 T4430 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[1 (1459807791569960960)]} 0 2
   [junit4]   2> 1118483 T4444 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[1 (1459807791575203840)]} 0 1
   [junit4]   2> 1118487 T4431 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[2 (1459807791579398144)]} 0 1
   [junit4]   2> 1118490 T4438 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[2 (1459807791582543872)]} 0 1
   [junit4]   2> 1118493 T4432 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[3 (1459807791585689600)]} 0 1
   [junit4]   2> 1118497 T4442 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[3 (1459807791589883904)]} 0 1
   [junit4]   2> 1118500 T4429 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[4 (1459807791593029632)]} 0 1
   [junit4]   2> 1118503 T4443 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[4 (1459807791596175360)]} 0 1
   [junit4]   2> 1118506 T4430 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[5 (1459807791600369664)]} 0 0
   [junit4]   2> 1118510 T4444 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[5 (1459807791602466816)]} 0 2
   [junit4]   2> 1118513 T4431 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[6 (1459807791606661120)]} 0 1
   [junit4]   2> 1118515 T4438 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[6 (1459807791609806848)]} 0 1
   [junit4]   2> 1118518 T4432 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[7 (1459807791611904000)]} 0 1
   [junit4]   2> 1118520 T4442 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[7 (1459807791615049728)]} 0 0
   [junit4]   2> 1118523 T4429 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[8 (1459807791618195456)]} 0 0
   [junit4]   2> 1118526 T4443 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[8 (1459807791620292608)]} 0 1
   [junit4]   2> 1118529 T4430 C15591 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[9 (1459807791623438336)]} 0 1
   [junit4]   2> 1118532 T4444 C15592 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[9 (1459807791626584064)]} 0 1
   [junit4]   2> 1118534 T4431 C15591 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> ASYNC  NEW_CORE C15593 name=collection1 org.apache.solr.core.SolrCore@273c8612
   [junit4]   2> 1118556 T4431 C15593 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@36efc304 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39a1a59f)),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@36efc304 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39a1a59f)),segFN=segments_2,generation=2}
   [junit4]   2> 1118557 T4431 C15593 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 1118559 T4431 C15593 oass.SolrIndexSearcher.<init> Opening Searcher@770ff22[collection1] main
   [junit4]   2> 1118560 T4431 C15593 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1118561 T4434 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@770ff22[collection1] main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):c9)}
   [junit4]   2> 1118562 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&softCommit=false&waitSearcher=true&commit=true&version=2} {commit=} 0 28
   [junit4]   2> ASYNC  NEW_CORE C15594 name=collection1 org.apache.solr.core.SolrCore@5079f9fe
   [junit4]   2> 1118564 T4438 C15594 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1118576 T4438 C15594 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@5d3a0514 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6955089a)),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@5d3a0514 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6955089a)),segFN=segments_2,generation=2}
   [junit4]   2> 1118577 T4438 C15594 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 1118579 T4438 C15594 oass.SolrIndexSearcher.<init> Opening Searcher@2cbb3a93[collection1] main
   [junit4]   2> 1118580 T4438 C15594 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1118581 T4446 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2cbb3a93[collection1] main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):c9)}
   [junit4]   2> 1118582 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&softCommit=false&waitSearcher=true&commit=true&version=2} {commit=} 0 18
   [junit4]   2> 1118586 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[10 (1459807791682158592)]} 0 2
   [junit4]   2> 1118590 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[10 (1459807791686352896)]} 0 2
   [junit4]   2> 1118593 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[11 (1459807791690547200)]} 0 1
   [junit4]   2> 1118596 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[11 (1459807791693692928)]} 0 1
   [junit4]   2> 1118599 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[12 (1459807791696838656)]} 0 1
   [junit4]   2> 1118602 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[12 (1459807791699984384)]} 0 1
   [junit4]   2> 1118605 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[13 (1459807791703130112)]} 0 1
   [junit4]   2> 1118607 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[13 (1459807791706275840)]} 0 0
   [junit4]   2> 1118611 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[1001 (1459807791708372992)]} 0 2
   [junit4]   2> 1118614 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[1001 (1459807791712567296)]} 0 1
   [junit4]   2> 1118617 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[14 (1459807791715713024)]} 0 1
   [junit4]   2> 1118619 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[14 (1459807791718858752)]} 0 0
   [junit4]   2> 1118622 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[15 (1459807791722004480)]} 0 0
   [junit4]   2> 1118625 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[15 (1459807791724101632)]} 0 1
   [junit4]   2> 1118628 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[16 (1459807791727247360)]} 0 1
   [junit4]   2> 1118630 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[16 (1459807791730393088)]} 0 1
   [junit4]   2> 1118634 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[17 (1459807791733538816)]} 0 2
   [junit4]   2> 1118638 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[17 (1459807791736684544)]} 0 2
   [junit4]   2> 1118641 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[100 (1459807791740878848)]} 0 1
   [junit4]   2> 1118644 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[100 (1459807791744024576)]} 0 1
   [junit4]   2> 1118647 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[101 (1459807791747170304)]} 0 1
   [junit4]   2> 1118649 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[101 (1459807791750316032)]} 0 0
   [junit4]   2> 1118652 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[102 (1459807791753461760)]} 0 0
   [junit4]   2> 1118656 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[102 (1459807791756607488)]} 0 1
   [junit4]   2> 1118660 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[103 (1459807791760801792)]} 0 1
   [junit4]   2> 1118663 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[103 (1459807791763947520)]} 0 1
   [junit4]   2> 1118666 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[104 (1459807791767093248)]} 0 1
   [junit4]   2> 1118669 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[104 (1459807791770238976)]} 0 1
   [junit4]   2> 1118672 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[105 (1459807791774433280)]} 0 0
   [junit4]   2> 1118676 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[105 (1459807791777579008)]} 0 2
   [junit4]   2> 1118679 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[106 (1459807791780724736)]} 0 1
   [junit4]   2> 1118682 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[106 (1459807791783870464)]} 0 1
   [junit4]   2> 1118685 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[107 (1459807791788064768)]} 0 0
   [junit4]   2> 1118688 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[107 (1459807791790161920)]} 0 1
   [junit4]   2> 1118691 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[108 (1459807791794356224)]} 0 1
   [junit4]   2> 1118694 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[108 (1459807791796453376)]} 0 1
   [junit4]   2> 1118697 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[109 (1459807791799599104)]} 0 1
   [junit4]   2> 1118704 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[109 (1459807791806939136)]} 0 1
   [junit4]   2> 1118707 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[110 (1459807791810084864)]} 0 1
   [junit4]   2> 1118710 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[110 (1459807791813230592)]} 0 1
   [junit4]   2> 1118713 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[111 (1459807791816376320)]} 0 1
   [junit4]   2> 1118715 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[111 (1459807791819522048)]} 0 0
   [junit4]   2> 1118718 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[112 (1459807791822667776)]} 0 0
   [junit4]   2> 1118721 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[112 (1459807791824764928)]} 0 1
   [junit4]   2> 1118724 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[113 (1459807791827910656)]} 0 1
   [junit4]   2> 1118726 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[113 (1459807791831056384)]} 0 1
   [junit4]   2> 1118729 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[114 (1459807791833153536)]} 0 1
   [junit4]   2> 1118731 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[114 (1459807791836299264)]} 0 0
   [junit4]   2> 1118735 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[115 (1459807791839444992)]} 0 2
   [junit4]   2> 1118737 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[115 (1459807791842590720)]} 0 0
   [junit4]   2> 1118740 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[116 (1459807791845736448)]} 0 1
   [junit4]   2> 1118743 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[116 (1459807791847833600)]} 0 1
   [junit4]   2> 1118746 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[117 (1459807791850979328)]} 0 1
   [junit4]   2> 1118748 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[117 (1459807791854125056)]} 0 0
   [junit4]   2> 1118751 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[118 (1459807791857270784)]} 0 0
   [junit4]   2> 1118754 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[118 (1459807791860416512)]} 0 1
   [junit4]   2> 1118758 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[119 (1459807791863562240)]} 0 2
   [junit4]   2> 1118761 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[119 (1459807791866707968)]} 0 1
   [junit4]   2> 1118764 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[120 (1459807791869853696)]} 0 1
   [junit4]   2> 1118767 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[120 (1459807791872999424)]} 0 1
   [junit4]   2> 1118770 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[121 (1459807791876145152)]} 0 1
   [junit4]   2> 1118773 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[121 (1459807791879290880)]} 0 1
   [junit4]   2> 1118776 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[122 (1459807791882436608)]} 0 1
   [junit4]   2> 1118779 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[122 (1459807791885582336)]} 0 1
   [junit4]   2> 1118782 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[123 (1459807791888728064)]} 0 1
   [junit4]   2> 1118785 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[123 (1459807791891873792)]} 0 1
   [junit4]   2> 1118788 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[124 (1459807791895019520)]} 0 1
   [junit4]   2> 1118791 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[124 (1459807791898165248)]} 0 1
   [junit4]   2> 1118794 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[125 (1459807791901310976)]} 0 1
   [junit4]   2> 1118797 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[125 (1459807791905505280)]} 0 1
   [junit4]   2> 1118801 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[126 (1459807791908651008)]} 0 1
   [junit4]   2> 1118804 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[126 (1459807791911796736)]} 0 1
   [junit4]   2> 1118807 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[127 (1459807791914942464)]} 0 1
   [junit4]   2> 1118810 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[127 (1459807791918088192)]} 0 1
   [junit4]   2> 1118813 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[128 (1459807791921233920)]} 0 1
   [junit4]   2> 1118816 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[128 (1459807791924379648)]} 0 1
   [junit4]   2> 1118829 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[129 (1459807791938011136)]} 0 1
   [junit4]   2> 1118832 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[129 (1459807791941156864)]} 0 1
   [junit4]   2> 1118835 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[130 (1459807791944302592)]} 0 1
   [junit4]   2> 1118838 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[130 (1459807791947448320)]} 0 1
   [junit4]   2> 1118841 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[131 (1459807791950594048)]} 0 1
   [junit4]   2> 1118844 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[131 (1459807791953739776)]} 0 1
   [junit4]   2> 1118846 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[132 (1459807791956885504)]} 0 0
   [junit4]   2> 1118849 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[132 (1459807791958982656)]} 0 1
   [junit4]   2> 1118852 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[133 (1459807791962128384)]} 0 1
   [junit4]   2> 1118854 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[133 (1459807791965274112)]} 0 0
   [junit4]   2> 1118857 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[134 (1459807791968419840)]} 0 1
   [junit4]   2> 1118860 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[134 (1459807791970516992)]} 0 1
   [junit4]   2> 1118862 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[135 (1459807791973662720)]} 0 0
   [junit4]   2> 1118865 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[135 (1459807791975759872)]} 0 1
   [junit4]   2> 1118867 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[136 (1459807791978905600)]} 0 0
   [junit4]   2> 1118870 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[136 (1459807791981002752)]} 0 1
   [junit4]   2> 1118873 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[137 (1459807791984148480)]} 0 1
   [junit4]   2> 1118875 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[137 (1459807791987294208)]} 0 1
   [junit4]   2> 1118878 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[138 (1459807791989391360)]} 0 1
   [junit4]   2> 1118880 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[138 (1459807791992537088)]} 0 1
   [junit4]   2> 1118883 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[139 (1459807791994634240)]} 0 1
   [junit4]   2> 1118886 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[139 (1459807791998828544)]} 0 2
   [junit4]   2> 1118890 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[140 (1459807792001974272)]} 0 1
   [junit4]   2> 1118893 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[140 (1459807792005120000)]} 0 1
   [junit4]   2> 1118896 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[141 (1459807792008265728)]} 0 1
   [junit4]   2> 1118899 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[141 (1459807792011411456)]} 0 1
   [junit4]   2> 1118902 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[142 (1459807792014557184)]} 0 1
   [junit4]   2> 1118905 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[142 (1459807792018751488)]} 0 1
   [junit4]   2> 1118908 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[143 (1459807792020848640)]} 0 1
   [junit4]   2> 1118911 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[143 (1459807792023994368)]} 0 1
   [junit4]   2> 1118914 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[144 (1459807792027140096)]} 0 1
   [junit4]   2> 1118917 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[144 (1459807792030285824)]} 0 1
   [junit4]   2> 1118919 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[145 (1459807792033431552)]} 0 0
   [junit4]   2> 1118922 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[145 (1459807792035528704)]} 0 1
   [junit4]   2> 1118925 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[146 (1459807792038674432)]} 0 1
   [junit4]   2> 1118928 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[146 (1459807792041820160)]} 0 1
   [junit4]   2> 1118931 T4429 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[147 (1459807792044965888)]} 0 1
   [junit4]   2> 1118934 T4443 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[147 (1459807792048111616)]} 0 1
   [junit4]   2> 1118937 T4431 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[148 (1459807792051257344)]} 0 1
   [junit4]   2> 1118940 T4438 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[148 (1459807792054403072)]} 0 1
   [junit4]   2> 1118943 T4430 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[149 (1459807792057548800)]} 0 1
   [junit4]   2> 1118946 T4444 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&version=2} {add=[149 (1459807792061743104)]} 0 1
   [junit4]   2> 1118949 T4432 C15593 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1118981 T4432 C15593 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@36efc304 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39a1a59f)),segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@36efc304 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@39a1a59f)),segFN=segments_3,generation=3}
   [junit4]   2> 1118982 T4432 C15593 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 1118985 T4432 C15593 oass.SolrIndexSearcher.<init> Opening Searcher@20f1279[collection1] main
   [junit4]   2> 1118986 T4432 C15593 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1118987 T4434 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@20f1279[collection1] main{StandardDirectoryReader(segments_3:5:nrt _0(5.0):c9 _1(5.0):c59)}
   [junit4]   2> 1118988 T4432 C15593 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&softCommit=false&waitSearcher=true&commit=true&version=2} {commit=} 0 39
   [junit4]   2> 1118990 T4442 C15594 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1119022 T4442 C15594 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@5d3a0514 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6955089a)),segFN=segments_2,generation=2}
   [junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@5d3a0514 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6955089a)),segFN=segments_3,generation=3}
   [junit4]   2> 1119023 T4442 C15594 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
   [junit4]   2> 1119026 T4442 C15594 oass.SolrIndexSearcher.<init> Opening Searcher@e6c4a2[collection1] main
   [junit4]   2> 1119027 T4442 C15594 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1119028 T4446 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e6c4a2[collection1] main{StandardDirectoryReader(segments_3:5:nrt _0(5.0):c9 _1(5.0):c59)}
   [junit4]   2> 1119029 T4442 C15594 oasup.LogUpdateProcessor.finish [collection1] webapp=/qeex/fg path=/update params={wt=javabin&softCommit=false&waitSearcher=true&commit=true&version=2} {commit=} 0 39
   [junit4]   2> 1119041 T4429 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=10 
   [junit4]   2> 1119064 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_ti1+desc&wt=javabin&shard.url=[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198277&isShard=true&version=2} hits=68 status=0 QTime=16 
   [junit4]   2> 1119073 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=103,102,111,8,104,128,17,14,145,109&distrib=false&wt=javabin&shard.url=[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&NOW=1392181198277&isShard=true&version=2} status=0 QTime=4 
   [junit4]   2> 1119077 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&sort=n_ti1+desc&wt=javabin&version=2} hits=68 status=0 QTime=33 
   [junit4]   2> 1119081 T4431 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119095 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_ti1+asc&wt=javabin&shard.url=[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198318&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119100 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=127,146,130,114,105,147,112,117,137,135&distrib=false&wt=javabin&shard.url=[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&NOW=1392181198318&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119104 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&sort=n_ti1+asc&wt=javabin&version=2} hits=68 status=0 QTime=19 
   [junit4]   2> 1119108 T4430 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119115 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_f1+desc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198345&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119119 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=4,129,13,108,138,113,105,136,124,135&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&NOW=1392181198345&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119122 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg&sort=n_f1+desc&wt=javabin&version=2} hits=68 status=0 QTime=10 
   [junit4]   2> 1119126 T4432 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119131 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_f1+asc&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::114]:33332/qeex/fg&fsv=true&NOW=1392181198362&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119136 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=146,127,132,111,121,101,100,106,116,137&distrib=false&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::114]:33332/qeex/fg&NOW=1392181198362&isShard=true&version=2} status=0 QTime=0 
   [junit4]   2> 1119138 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::213]:33332/qeex/fg|[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::114]:33332/qeex/fg&sort=n_f1+asc&wt=javabin&version=2} hits=68 status=0 QTime=9 
   [junit4]   2> 1119142 T4429 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119148 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_tf1+desc&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&fsv=true&NOW=1392181198378&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119152 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=11,103,126,13,113,123,5,115,101,117&distrib=false&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&NOW=1392181198378&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119155 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&sort=n_tf1+desc&wt=javabin&version=2} hits=68 status=0 QTime=10 
   [junit4]   2> 1119159 T4431 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119164 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_tf1+asc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198395&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119169 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=127,119,141,130,108,6,17,136,112,9&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&NOW=1392181198395&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119171 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg&sort=n_tf1+asc&wt=javabin&version=2} hits=68 status=0 QTime=9 
   [junit4]   2> 1119176 T4432 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=2 
   [junit4]   2> 1119182 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_d1+desc&wt=javabin&shard.url=[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::213]:33332/qeex/fg&fsv=true&NOW=1392181198412&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119186 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=146,103,131,134,113,10,8,128,148,144&distrib=false&wt=javabin&shard.url=[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::213]:33332/qeex/fg&NOW=1392181198412&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119188 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::213]:33332/qeex/fg&sort=n_d1+desc&wt=javabin&version=2} hits=68 status=0 QTime=9 
   [junit4]   2> 1119191 T4431 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119196 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_d1+asc&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg&fsv=true&NOW=1392181198427&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119200 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=4,118,13,111,6,115,117,116,137,1&distrib=false&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg&NOW=1392181198427&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119202 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg&sort=n_d1+asc&wt=javabin&version=2} hits=68 status=0 QTime=8 
   [junit4]   2> 1119205 T4430 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119217 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_td1+desc&wt=javabin&shard.url=[ff01::083]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198441&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119221 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=127,4,132,13,143,134,104,117,149,144&distrib=false&wt=javabin&shard.url=[ff01::083]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&NOW=1392181198441&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119223 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::083]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|[ff01::114]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&sort=n_td1+desc&wt=javabin&version=2} hits=68 status=0 QTime=14 
   [junit4]   2> 1119226 T4429 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119231 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_td1+asc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&fsv=true&NOW=1392181198461&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119234 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=130,142,108,8,101,17,145,124,7,116&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&NOW=1392181198461&isShard=true&version=2} status=0 QTime=0 
   [junit4]   2> 1119236 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&sort=n_td1+asc&wt=javabin&version=2} hits=68 status=0 QTime=8 
   [junit4]   2> 1119240 T4432 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119245 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_l1+desc&wt=javabin&shard.url=[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&fsv=true&NOW=1392181198475&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119249 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=12,4,114,143,5,120,10,112,1001,9&distrib=false&wt=javabin&shard.url=[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&NOW=1392181198475&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119250 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&sort=n_l1+desc&wt=javabin&version=2} hits=68 status=0 QTime=8 
   [junit4]   2> 1119253 T4431 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119257 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_l1+asc&wt=javabin&shard.url=[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198488&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119260 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=131,107,105,110,17,128,106,116,124,135&distrib=false&wt=javabin&shard.url=[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&NOW=1392181198488&isShard=true&version=2} status=0 QTime=0 
   [junit4]   2> 1119261 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&sort=n_l1+asc&wt=javabin&version=2} hits=68 status=0 QTime=6 
   [junit4]   2> 1119265 T4430 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119270 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_tl1+desc&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg&fsv=true&NOW=1392181198500&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119273 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=2,11,127,130,126,107,111,8,125,137&distrib=false&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg&NOW=1392181198500&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119274 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg|[ff01::114]:33332/qeex/fg&sort=n_tl1+desc&wt=javabin&version=2} hits=68 status=0 QTime=7 
   [junit4]   2> 1119277 T4429 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119281 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_tl1+asc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&fsv=true&NOW=1392181198512&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119284 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=3,103,102,129,13,121,147,112,109,135&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&NOW=1392181198512&isShard=true&version=2} status=0 QTime=0 
   [junit4]   2> 1119286 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=7 
   [junit4]   2> 1119288 T4432 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_dt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119293 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_dt1+desc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198524&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119296 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=127,119,8,123,128,145,1001,7,148,144&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&NOW=1392181198524&isShard=true&version=2} status=0 QTime=0 
   [junit4]   2> 1119297 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg&sort=n_dt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=6 
   [junit4]   2> 1119300 T4431 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_dt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119305 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_dt1+asc&wt=javabin&shard.url=[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198535&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119308 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=146,107,108,134,138,5,125,115,106,112&distrib=false&wt=javabin&shard.url=[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&NOW=1392181198535&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119309 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::114]:33332/qeex/fg|[ff01::213]:33332/qeex/fg|[ff01::083]:33332/qeex/fg|127.0.0.1:43091/qeex/fg&sort=n_dt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=7 
   [junit4]   2> 1119312 T4430 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119317 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_tdt1+desc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&fsv=true&NOW=1392181198547&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119321 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=119,140,132,105,104,121,110,106,149,135&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&NOW=1392181198547&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119323 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&sort=n_tdt1+desc&wt=javabin&version=2} hits=68 status=0 QTime=9 
   [junit4]   2> 1119325 T4429 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119330 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=n_tdt1+asc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::114]:33332/qeex/fg&fsv=true&NOW=1392181198561&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119334 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=127,2,141,16,108,17,7,148,1,109&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::114]:33332/qeex/fg&NOW=1392181198561&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119335 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg|[ff01::114]:33332/qeex/fg&sort=n_tdt1+asc&wt=javabin&version=2} hits=68 status=0 QTime=7 
   [junit4]   2> 1119338 T4432 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=a_si+desc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119344 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=a_si+desc&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&fsv=true&NOW=1392181198574&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119347 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=2,3,12,13,10,8,5,7,1,9&distrib=false&wt=javabin&shard.url=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&NOW=1392181198574&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119348 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=[ff01::213]:33332/qeex/fg|127.0.0.1:43091/qeex/fg|[ff01::083]:33332/qeex/fg&sort=a_si+desc&wt=javabin&version=2} hits=68 status=0 QTime=7 
   [junit4]   2> 1119351 T4431 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort={!func}testfunc(add(a_si,5))+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119356 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort={!func}testfunc(add(a_si,5))+desc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198586&isShard=true&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119359 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=2,3,12,13,10,8,5,7,1,9&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&NOW=1392181198586&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119360 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg&sort={!func}testfunc(add(a_si,5))+desc&wt=javabin&version=2} hits=68 status=0 QTime=7 
   [junit4]   2> 1119362 T4430 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&sort=a_si+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119367 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=id&rows=10&start=0&sort=a_si+asc&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198598&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119370 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=11,3,2,12,4,13,6,7,9,1&distrib=false&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&NOW=1392181198598&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119371 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg&sort=a_si+asc&wt=javabin&version=2} hits=68 status=0 QTime=6 
   [junit4]   2> 1119374 T4429 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=*,score&sort=a_si+desc&wt=javabin&version=2} hits=68 status=0 QTime=1 
   [junit4]   2> 1119378 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&rows=10&start=0&sort=a_si+desc&fl=id,score&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&fsv=true&NOW=1392181198609&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119381 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=2,3,12,13,10,8,5,7,1,9&distrib=false&fl=*,score&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg&NOW=1392181198609&isShard=true&version=2} status=0 QTime=0 
   [junit4]   2> 1119383 T4444 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg&fl=*,score&sort=a_si+desc&wt=javabin&version=2} hits=68 status=0 QTime=7 
   [junit4]   2> 1119385 T4432 C15593 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&fl=*,score&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119390 T4442 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&distrib=false&rows=10&start=0&sort=n_tl1+asc&fl=id,score&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::213]:33332/qeex/fg&fsv=true&NOW=1392181198621&isShard=true&version=2} hits=68 status=0 QTime=0 
   [junit4]   2> 1119393 T4443 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&ids=3,103,102,129,13,121,147,112,109,135&distrib=false&fl=*,score&wt=javabin&shard.url=127.0.0.1:43091/qeex/fg|[ff01::213]:33332/qeex/fg&NOW=1392181198621&isShard=true&version=2} status=0 QTime=1 
   [junit4]   2> 1119394 T4438 C15594 oasc.SolrCore.execute [collection1] webapp=/qeex/fg path=/select params={q=*:*&shards=127.0.0.1:43091/qeex/fg|[ff01::213]:33332/qeex/fg&fl=*,score&sort=n_tl1+asc&wt=javabin&version=2} hits=68 status=0 QTime=6 
   [junit4]   2> 1119396 T4431 C15593 oasc.SolrCore

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

r
   [junit4]   2> 1129221 T4423 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 1129222 T4423 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1129222 T4423 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data/index [CachedDir<<refCount=0;path=./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data/index;done=false>>]
   [junit4]   2> 1129222 T4423 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data/index
   [junit4]   2> 1129223 T4423 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data [CachedDir<<refCount=0;path=./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data;done=false>>]
   [junit4]   2> 1129223 T4423 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.TestDistributedSearch-1392181196396/shard0/data
   [junit4]   2> 1129224 T4423 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/qeex/fg,null}
   [junit4]   2> 1129296 T4423 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=164602143
   [junit4]   2> 1129297 T4423 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@266188d
   [junit4]   2> 1129308 T4423 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=36,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=8897,transaction_logs_total_number=3}
   [junit4]   2> 1129309 T4423 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 1129309 T4423 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1129309 T4423 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1129310 T4423 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 1129311 T4423 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1129311 T4423 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.TestDistributedSearch-1392181196396/shard1/data [CachedDir<<refCount=0;path=./org.apache.solr.TestDistributedSearch-1392181196396/shard1/data;done=false>>]
   [junit4]   2> 1129311 T4423 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.TestDistributedSearch-1392181196396/shard1/data
   [junit4]   2> 1129312 T4423 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.TestDistributedSearch-1392181196396/shard1/data/index [CachedDir<<refCount=0;path=./org.apache.solr.TestDistributedSearch-1392181196396/shard1/data/index;done=false>>]
   [junit4]   2> 1129312 T4423 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.TestDistributedSearch-1392181196396/shard1/data/index
   [junit4]   2> 1129312 T4423 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/qeex/fg,null}
   [junit4]   2> 1129372 T4423 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedSearch -Dtests.method=testDistribSearch -Dtests.seed=3F59596341DAD68 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_NI -Dtests.timezone=America/Indiana/Indianapolis -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 12.2s J1 | TestDistributedSearch.testDistribSearch <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Expected the partialResults header to be null
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([3F59596341DAD68:82131B8E4342CD54]:0)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.validateControlData(TestDistributedSearch.java:525)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:445)
   [junit4]    > 	at org.apache.solr.TestDistributedSearch.doTest(TestDistributedSearch.java:379)
   [junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:874)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:744)
   [junit4]   2> 1129380 T4423 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Lucene46: {lowerfilt=PostingsFormat(name=MockSep), range_facet_sl=PostingsFormat(name=SimpleText), foo_d=PostingsFormat(name=SimpleText), n_l1=PostingsFormat(name=MockSep), range_facet_si=PostingsFormat(name=MockSep), foo_f=PostingsFormat(name=Memory doPackFST= true), oddField_s=PostingsFormat(name=SimpleText), a_n_tdt=PostingsFormat(name=Memory doPackFST= true), a_t=PostingsFormat(name=MockSep), text=PostingsFormat(name=Memory doPackFST= true), multiDefault=PostingsFormat(name=MockSep), a_si=PostingsFormat(name=FSTPulsing41), n_f1=PostingsFormat(name=FSTPulsing41), lowerfilt1and2=PostingsFormat(name=MockSep), n_tf1=PostingsFormat(name=MockSep), other_tl1=PostingsFormat(name=FSTPulsing41), n_d1=PostingsFormat(name=MockSep), foo_b=PostingsFormat(name=Memory doPackFST= true), n_dt1=PostingsFormat(name=FSTPulsing41), rnd_b=PostingsFormat(name=SimpleText), id=PostingsFormat(name=SimpleText), b_n_tdt=PostingsFormat(name=FSTPulsing41), n_tdt1=PostingsFormat(name=FSTPulsing41), intDefault=PostingsFormat(name=FSTPulsing41), SubjectTerms_mfacet=PostingsFormat(name=FSTPulsing41), n_tl1=PostingsFormat(name=FSTPulsing41), _version_=PostingsFormat(name=FSTPulsing41), range_facet_l=PostingsFormat(name=MockSep), n_ti1=PostingsFormat(name=SimpleText), n_td1=PostingsFormat(name=FSTPulsing41), timestamp=PostingsFormat(name=MockSep)}, docValues:{timestamp=DocValuesFormat(name=Disk)}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=es_NI, timezone=America/Indiana/Indianapolis
   [junit4]   2> NOTE: Linux 3.8.0-35-generic amd64/Oracle Corporation 1.7.0_51 (64-bit)/cpus=8,threads=1,free=184928536,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [DistribCursorPagingTest, TestSolrQueryParserDefaultOperatorResource, TestFastWriter, CursorMarkTest, TestSchemaResource, TestNRTOpen, NotRequiredUniqueKeyTest, SpellingQueryConverterTest, DocValuesMultiTest, ShardRoutingCustomTest, TestStressRecovery, TestPartialUpdateDeduplication, TestFuzzyAnalyzedSuggestions, HdfsBasicDistributedZk2Test, IndexSchemaRuntimeFieldTest, TestCSVResponseWriter, TestCoreDiscovery, TestQueryTypes, OpenExchangeRatesOrgProviderTest, ChaosMonkeySafeLeaderTest, TestRangeQuery, TestImplicitCoreProperties, RequestHandlersTest, IndexBasedSpellCheckerTest, CachingDirectoryFactoryTest, HdfsBasicDistributedZkTest, StressHdfsTest, TestReload, ConvertedLegacyTest, RequiredFieldsTest, TermVectorComponentDistributedTest, SortByFunctionTest, TestStressLucene, DisMaxRequestHandlerTest, TestRandomFaceting, AssignTest, TestFastOutputStream, SuggesterTSTTest, MinimalSchemaTest, SpellCheckCollatorTest, CollectionsAPIDistributedZkTest, TestAtomicUpdateErrorCases, TestReloadAndDeleteDocs, TestNumberUtils, HdfsLockFactoryTest, TestDFRSimilarityFactory, SpellCheckComponentTest, TestUpdate, TestBlendedInfixSuggestions, StandardRequestHandlerTest, TestNonDefinedSimilarityFactory, TestSolrDeletionPolicy2, SuggestComponentTest, DirectSolrConnectionTest, TestCollationFieldDocValues, TestFieldTypeResource, TestCSVLoader, TestIBSimilarityFactory, HighlighterTest, HdfsUnloadDistributedZkTest, TestSolrCoreProperties, TestAnalyzedSuggestions, TestSweetSpotSimilarityFactory, TestIndexingPerformance, TestOmitPositions, TestQuerySenderNoQuery, TestXIncludeConfig, DirectSolrSpellCheckerTest, TestCloudManagedSchemaAddField, RAMDirectoryFactoryTest, TestClassNameShortening, TestFieldResource, SuggesterWFSTTest, ZkNodePropsTest, TestDynamicFieldCollectionResource, HdfsCollectionsAPIDistributedZkTest, FileUtilsTest, TestRecovery, SimplePostToolTest, TestUtils, TestDistributedGrouping, TestSimpleQParserPlugin, EnumFieldTest, StatsComponentTest, TestRTGBase, PreAnalyzedUpdateProcessorTest, DirectUpdateHandlerTest, ZkSolrClientTest, CoreMergeIndexesAdminHandlerTest, LeaderElectionIntegrationTest, RecoveryZkTest, TestReplicationHandler, TestZkChroot, ZkCLITest, TestDistributedSearch]
   [junit4] Completed on J1 in 12.24s, 1 test, 1 failure <<< FAILURES!

[...truncated 538 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:453: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:433: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:37: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:189: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:491: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1268: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:901: There were test failures: 372 suites, 1603 tests, 1 failure, 35 ignored (7 assumptions)

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