lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0-ea-b65) - Build # 3277 - Failure!
Date Tue, 18 Dec 2012 19:15:49 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/3277/
Java: 32bit/jdk1.8.0-ea-b65 -server -XX:+UseSerialGC

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

Error Message:
.grouped.id:5!=a_t:kings OR a_t:eggs (unordered or missing)

Stack Trace:
junit.framework.AssertionFailedError: .grouped.id:5!=a_t:kings OR a_t:eggs (unordered or missing)
	at __randomizedtesting.SeedInfo.seed([C46F7E0AF00D76FE:4589F012875216C2]:0)
	at junit.framework.Assert.fail(Assert.java:50)
	at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:785)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:495)
	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:475)
	at org.apache.solr.TestDistributedGrouping.doTest(TestDistributedGrouping.java:168)
	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:800)
	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:474)
	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:722)




Build Log:
[...truncated 8640 lines...]
[junit4:junit4] Suite: org.apache.solr.TestDistributedGrouping
[junit4:junit4]   2> 1 T349 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4:junit4]   2> 7 T349 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> 555 T349 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 685 T349 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:55757
[junit4:junit4]   2> 697 T349 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 698 T349 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 699 T349 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 712 T349 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 712 T349 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 713 T349 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 713 T349 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 714 T349 oasc.CoreContainer.<init> New CoreContainer 8181037
[junit4:junit4]   2> 715 T349 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 715 T349 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 741 T349 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4]   2> 742 T349 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 743 T349 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 743 T349 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 744 T349 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 744 T349 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 745 T349 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 745 T349 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 746 T349 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 755 T349 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4]   2> 955 T349 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 984 T360 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 985 T360 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 986 T360 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 986 T360 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1056 T360 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 1173 T360 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1174 T360 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1179 T360 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1646 T360 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1655 T360 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1658 T360 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1684 T360 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1688 T360 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1693 T360 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1694 T360 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1694 T360 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/
[junit4:junit4]   2> 1695 T360 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4fd89b
[junit4:junit4]   2> 1696 T360 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 1697 T360 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data forceNew:false
[junit4:junit4]   2> 1697 T360 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data
[junit4:junit4]   2> 1698 T360 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index/
[junit4:junit4]   2> 1698 T360 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1699 T360 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index forceNew:false
[junit4:junit4]   2> 1702 T360 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1c10172 lockFactory=org.apache.lucene.store.NativeFSLockFactory@148b390)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1703 T360 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 1704 T360 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index
[junit4:junit4]   2> 1704 T360 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1706 T360 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1706 T360 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1706 T360 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1707 T360 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1707 T360 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1708 T360 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1708 T360 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1709 T360 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1711 T360 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1712 T360 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1713 T360 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1713 T360 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1714 T360 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1714 T360 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1714 T360 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1715 T360 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1716 T360 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1717 T360 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1717 T360 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1718 T360 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1719 T360 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1723 T360 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1724 T360 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1725 T360 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1726 T360 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1727 T360 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1731 T360 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1733 T360 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1735 T360 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [HUNSPELL-TEST.AFF, SOLRCONFIG-NOCACHE.XML, STOPTYPES-2.TXT, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-BEHAVIOR.XML, STOPWITHBOM.TXT, SOLRCONFIG-MASTER2.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, MAPPING-ISOLATIN1ACCENT.TXT, SCHEMA-IB.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-SLAVE1.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SCHEMA-TFIDF.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA12.XML, SCHEMA-REPLICATION1.XML, SOLRCONFIG-SIMPLELOCK.XML, HYPHENATION.DTD, SOLRCONFIG-ELEVATE.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA15.XML, SCHEMA-CHARFILTERS.XML, CURRENCY.XML, SCHEMA-REQUIRED-FIELDS.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, DA_COMPOUNDDICTIONARY.TXT, TRIVIAL.UPDATEPROCESSOR0.JS, FRENCHARTICLES.TXT, SOLRCONFIG-MERGEPOLICY.XML, OPEN-EXCHANGE-RATES.JSON, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-PHRASESUGGEST.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-NATIVELOCK.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-XINCLUDE.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SOLRCONFIG-CACHING.XML, SOLRCONFIG-MASTER1.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, STOP-SNOWBALL.TXT, SOLRCONFIG-DELPOLICY1.XML, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, TRIVIAL.UPDATEPROCESSOR1.JS, STOPWORDS.TXT, SCHEMA-BINARYFIELD.XML, SCHEMA-DFR.XML, SCHEMA-FOLDING.XML, SCHEMA-TRIE.XML, SOLRCONFIG-DELPOLICY2.XML, SOLRCONFIG-SOLR-749.XML, SCHEMA-EFF.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA-LUCENEMATCHVERSION.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-NUMERIC.XML, SCHEMA-LMJELINEKMERCER.XML, SOLRCONFIG-SLAVE.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SCHEMA11.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SOLRCONFIG-LAZYWRITER.XML, OLD_SYNONYMS.TXT, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, BAD_SOLRCONFIG.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, HUNSPELL-TEST.DIC, SCHEMA-XINCLUDE.XML, DA_UTF8.XML, SCHEMA-REPLICATION2.XML, SOLRCONFIG-REQHANDLER.INCL, SOLRCONFIG-BASIC.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, STEMDICT.TXT, ELEVATE.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SCHEMA-SPATIAL.XML, COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, BAD-SCHEMA-DUP-FIELD.XML, SYNONYMS.TXT, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG_CODEC.XML, WDFTYPES.TXT, STOPWORDSWRONGENCODING.TXT, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, KEEP-2.TXT, SOLRCONFIG-MASTER.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, FUZZYSUGGEST.TXT, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SCHEMA-SNIPPET-TYPE.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SCHEMASURROUND.XML, STOPTYPES-1.TXT, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-MASTER3.XML, SCHEMA-COLLATE.XML, KEEP-1.TXT, SOLRCONFIG_PERF.XML, SOLRCONFIG-ALTDIRECTORY.XML, SOLRCONFIG-HIGHLIGHT.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, STOP-2.TXT, PROTWORDS.TXT, STOP-1.TXT, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, BAD-MP-SOLRCONFIG.XML, PHRASESUGGEST.TXT, SOLRCONFIG-TRANSFORMERS.XML, SOLRCONFIG-PROPINJECT.XML, SCHEMA.XML, SCHEMA-LMDIRICHLET.XML, SCHEMA-REVERSED.XML, SCHEMA-MINIMAL.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-BM25.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, XSLT, SCHEMA-SIM.XML, ADDFIELDS.UPDATEPROCESSOR.JS, CONDITIONAL.UPDATEPROCESSOR.JS, SOLRCONFIG-TLOG.XML, SCHEMA-STOP-KEEP.XML, JASUGGEST.TXT, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-ENABLEPLUGIN.XML, SOLRCONFIG-REPEATER.XML, SCHEMA_CODEC.XML]
[junit4:junit4]   2> 1744 T360 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data
[junit4:junit4]   2> 1744 T360 oass.SolrIndexSearcher.<init> Opening Searcher@1722fe6 main
[junit4:junit4]   2> 1745 T360 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1745 T360 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1745 T360 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1830 T360 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1859 T361 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1722fe6 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1863 T360 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 1863 T349 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 1864 T349 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 1883 T349 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 1904 T349 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 1989 T349 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:56003
[junit4:junit4]   2> 1992 T349 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 1992 T349 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 1993 T349 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2010 T349 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 2011 T349 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 2011 T349 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 2012 T349 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 2012 T349 oasc.CoreContainer.<init> New CoreContainer 28791658
[junit4:junit4]   2> 2013 T349 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2013 T349 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 2025 T349 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4]   2> 2026 T349 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 2026 T349 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 2026 T349 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 2027 T349 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 2027 T349 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 2027 T349 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 2028 T349 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 2028 T349 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 2029 T349 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4]   2> 2035 T349 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 2058 T371 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 2059 T371 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 2059 T371 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 2060 T371 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 2095 T371 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 2144 T371 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 2144 T371 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 2149 T371 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2494 T371 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2500 T371 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2512 T371 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2523 T371 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2525 T371 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2527 T371 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2528 T371 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2528 T371 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/
[junit4:junit4]   2> 2529 T371 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4fd89b
[junit4:junit4]   2> 2530 T371 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 2530 T371 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data forceNew:false
[junit4:junit4]   2> 2531 T371 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data
[junit4:junit4]   2> 2531 T371 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index/
[junit4:junit4]   2> 2531 T371 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2532 T371 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index forceNew:false
[junit4:junit4]   2> 2533 T371 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@b3b8d lockFactory=org.apache.lucene.store.NativeFSLockFactory@132a165)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2533 T371 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 2533 T371 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index
[junit4:junit4]   2> 2534 T371 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2535 T371 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2535 T371 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2535 T371 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2536 T371 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2536 T371 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2536 T371 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2536 T371 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2537 T371 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2538 T371 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2538 T371 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2539 T371 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2539 T371 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2540 T371 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2540 T371 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2540 T371 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2540 T371 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2541 T371 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2541 T371 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2542 T371 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2542 T371 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2543 T371 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2543 T371 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2544 T371 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2544 T371 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2545 T371 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2546 T371 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2548 T371 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2549 T371 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2550 T371 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [HUNSPELL-TEST.AFF, SOLRCONFIG-NOCACHE.XML, STOPTYPES-2.TXT, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-BEHAVIOR.XML, STOPWITHBOM.TXT, SOLRCONFIG-MASTER2.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, MAPPING-ISOLATIN1ACCENT.TXT, SCHEMA-IB.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-SLAVE1.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SCHEMA-TFIDF.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA12.XML, SCHEMA-REPLICATION1.XML, SOLRCONFIG-SIMPLELOCK.XML, HYPHENATION.DTD, SOLRCONFIG-ELEVATE.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA15.XML, SCHEMA-CHARFILTERS.XML, CURRENCY.XML, SCHEMA-REQUIRED-FIELDS.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, DA_COMPOUNDDICTIONARY.TXT, TRIVIAL.UPDATEPROCESSOR0.JS, FRENCHARTICLES.TXT, SOLRCONFIG-MERGEPOLICY.XML, OPEN-EXCHANGE-RATES.JSON, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-PHRASESUGGEST.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-NATIVELOCK.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-XINCLUDE.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SOLRCONFIG-CACHING.XML, SOLRCONFIG-MASTER1.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, STOP-SNOWBALL.TXT, SOLRCONFIG-DELPOLICY1.XML, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, TRIVIAL.UPDATEPROCESSOR1.JS, STOPWORDS.TXT, SCHEMA-BINARYFIELD.XML, SCHEMA-DFR.XML, SCHEMA-FOLDING.XML, SCHEMA-TRIE.XML, SOLRCONFIG-DELPOLICY2.XML, SOLRCONFIG-SOLR-749.XML, SCHEMA-EFF.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA-LUCENEMATCHVERSION.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-NUMERIC.XML, SCHEMA-LMJELINEKMERCER.XML, SOLRCONFIG-SLAVE.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SCHEMA11.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SOLRCONFIG-LAZYWRITER.XML, OLD_SYNONYMS.TXT, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, BAD_SOLRCONFIG.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, HUNSPELL-TEST.DIC, SCHEMA-XINCLUDE.XML, DA_UTF8.XML, SCHEMA-REPLICATION2.XML, SOLRCONFIG-REQHANDLER.INCL, SOLRCONFIG-BASIC.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, STEMDICT.TXT, ELEVATE.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SCHEMA-SPATIAL.XML, COMPOUNDDICTIONARY.TXT, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, BAD-SCHEMA-DUP-FIELD.XML, SYNONYMS.TXT, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG_CODEC.XML, WDFTYPES.TXT, STOPWORDSWRONGENCODING.TXT, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, KEEP-2.TXT, SOLRCONFIG-MASTER.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, FUZZYSUGGEST.TXT, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SCHEMA-SNIPPET-TYPE.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SCHEMASURROUND.XML, STOPTYPES-1.TXT, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-MASTER3.XML, SCHEMA-COLLATE.XML, KEEP-1.TXT, SOLRCONFIG_PERF.XML, SOLRCONFIG-ALTDIRECTORY.XML, SOLRCONFIG-HIGHLIGHT.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, STOP-2.TXT, PROTWORDS.TXT, STOP-1.TXT, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, BAD-MP-SOLRCONFIG.XML, PHRASESUGGEST.TXT, SOLRCONFIG-TRANSFORMERS.XML, SOLRCONFIG-PROPINJECT.XML, SCHEMA.XML, SCHEMA-LMDIRICHLET.XML, SCHEMA-REVERSED.XML, SCHEMA-MINIMAL.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-BM25.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, XSLT, SCHEMA-SIM.XML, ADDFIELDS.UPDATEPROCESSOR.JS, CONDITIONAL.UPDATEPROCESSOR.JS, SOLRCONFIG-TLOG.XML, SCHEMA-STOP-KEEP.XML, JASUGGEST.TXT, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-ENABLEPLUGIN.XML, SOLRCONFIG-REPEATER.XML, SCHEMA_CODEC.XML]
[junit4:junit4]   2> 2552 T371 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data
[junit4:junit4]   2> 2552 T371 oass.SolrIndexSearcher.<init> Opening Searcher@10d8429 main
[junit4:junit4]   2> 2552 T371 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2552 T371 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2553 T371 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2720 T371 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2742 T372 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10d8429 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2744 T371 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 2745 T349 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 2745 T349 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 2746 T349 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C9 name=collection1 org.apache.solr.core.SolrCore@1f87588
[junit4:junit4]   2> 3670 T357 C9 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 3671 T357 C9 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data
[junit4:junit4]   2> 3672 T357 C9 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1c10172 lockFactory=org.apache.lucene.store.NativeFSLockFactory@148b390)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3673 T357 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 3673 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 6
[junit4:junit4]   2> ASYNC  NEW_CORE C10 name=collection1 org.apache.solr.core.SolrCore@23a265
[junit4:junit4]   2> 3705 T368 C10 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 3706 T368 C10 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data
[junit4:junit4]   2> 3710 T368 C10 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@b3b8d lockFactory=org.apache.lucene.store.NativeFSLockFactory@132a165)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 3711 T368 C10 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 3711 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 6
[junit4:junit4]   2> 3727 T359 C9 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 3730 T359 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1c10172 lockFactory=org.apache.lucene.store.NativeFSLockFactory@148b390)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1c10172 lockFactory=org.apache.lucene.store.NativeFSLockFactory@148b390)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 3730 T359 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4]   2> 3731 T359 C9 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data
[junit4:junit4]   2> 3731 T359 C9 oass.SolrIndexSearcher.<init> Opening Searcher@1720ce6 main
[junit4:junit4]   2> 3732 T359 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 3733 T361 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1720ce6 main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 3734 T361 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index
[junit4:junit4]   2> 3734 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&waitSearcher=true&wt=javabin&commit=true&softCommit=false} {commit=} 0 8
[junit4:junit4]   2> 3737 T369 C10 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 3739 T369 C10 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@b3b8d lockFactory=org.apache.lucene.store.NativeFSLockFactory@132a165)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@b3b8d lockFactory=org.apache.lucene.store.NativeFSLockFactory@132a165)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 3739 T369 C10 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4]   2> 3740 T369 C10 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data
[junit4:junit4]   2> 3741 T369 C10 oass.SolrIndexSearcher.<init> Opening Searcher@ac308f main
[junit4:junit4]   2> 3741 T369 C10 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 3742 T372 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ac308f main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 3743 T372 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index
[junit4:junit4]   2> 3743 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&waitSearcher=true&wt=javabin&commit=true&softCommit=false} {commit=} 0 6
[junit4:junit4]   2> 3801 T358 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&group.limit=10&wt=javabin&q=*:*&group=true&distrib=false} hits=0 status=0 QTime=48 
[junit4:junit4]   2> 3839 T368 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&distrib=false&group=true&q=*:*&group.field=a_si&version=2&start=0&rows=100&NOW=1355857616309&fl=id&shard.url=127.0.0.1:56003/&group.limit=10} status=0 QTime=19 
[junit4:junit4]   2> 3857 T367 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&shards=127.0.0.1:56003/&group.limit=10&wt=javabin&q=*:*&group=true} status=0 QTime=50 
[junit4:junit4]   2> 3860 T356 C9 REQ [collection1] webapp= path=/select params={hl=true&sort=a_si+asc,+id+asc&hl.fl=a_t&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&fl=id,a_si&group.limit=10} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 3974 T370 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&hl=false&isShard=true&sort=a_si+asc,+id+asc&hl.fl=a_t&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857616365&fl=id&shard.url=[ff01::083]:33332/|[ff01::114]:33332/|127.0.0.1:56003/|[ff01::213]:33332/&group.limit=10} status=0 QTime=0 
[junit4:junit4]   2> 3975 T369 C10 REQ [collection1] webapp= path=/select params={hl=true&sort=a_si+asc,+id+asc&hl.fl=a_t&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&fl=id,a_si&shards=[ff01::083]:33332/|[ff01::114]:33332/|127.0.0.1:56003/|[ff01::213]:33332/&group.limit=10} status=0 QTime=112 
[junit4:junit4]   2> 3980 T359 C9 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=4288,tindexSize=0,time=0,phase1=0,nTerms=0,bigTerms=0,termInstances=0,uses=0}
[junit4:junit4]   2> 3981 T359 C9 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&fl=id,a_si&facet=true&group.limit=10&facet.field=a_t} hits=0 status=0 QTime=3 
[junit4:junit4]   2> 3987 T367 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857616487&fl=id&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&facet=false&group.limit=10&facet.field=a_t} status=0 QTime=0 
[junit4:junit4]   2> 3999 T370 C10 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=4288,tindexSize=0,time=0,phase1=0,nTerms=0,bigTerms=0,termInstances=0,uses=0}
[junit4:junit4]   2> 3999 T370 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&f.a_t.facet.limit=160&NOW=1355857616487&fl=id&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&group.distributed.second=true&facet=true&group.limit=10&facet.field=a_t} status=0 QTime=5 
[junit4:junit4]   2> 4005 T368 C10 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&fl=id,a_si&shards=[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&facet=true&group.limit=10&facet.field=a_t} status=0 QTime=20 
[junit4:junit4]   2> 4015 T356 C9 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&stats=true&fl=id,a_si&stats.field=a_si&group.limit=10} hits=0 status=0 QTime=7 
[junit4:junit4]   2> 4022 T370 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&stats=false&start=0&NOW=1355857616520&fl=id&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&stats.field=a_si&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 4026 T367 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&stats=true&start=0&NOW=1355857616520&fl=id&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&group.distributed.second=true&stats.field=a_si&group.limit=10} status=0 QTime=0 
[junit4:junit4]   2> 4027 T369 C10 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&stats=true&fl=id,a_si&shards=127.0.0.1:56003/|[ff01::213]:33332/&stats.field=a_si&group.limit=10} status=0 QTime=9 
[junit4:junit4]   2> 4084 T357 C9 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&distrib=false&group=true&q=kings&spellcheck.build=true&group.field=a_si&version=2&rows=100&spellcheck=true&fl=id,a_si&qt=spellCheckCompRH&group.limit=10} hits=0 status=0 QTime=55 
[junit4:junit4]   2> 4115 T370 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&spellcheck.count=1&group=true&q=kings&distrib=false&spellcheck.build=true&group.field=a_si&version=2&spellcheck.onlyMorePopular=false&rows=100&start=0&NOW=1355857616590&spellcheck=false&fl=id&shard.url=[ff01::213]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&spellcheck.extendedResults=false&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 4118 T368 C10 oashc.SpellCheckComponent.finishStage [ff01::213]:33332/|[ff01::083]:33332/|127.0.0.1:56003/ null
[junit4:junit4]   2> 4118 T368 C10 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&group=true&q=kings&spellcheck.build=true&group.field=a_si&version=2&rows=100&shards=[ff01::213]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&spellcheck=true&fl=id,a_si&qt=spellCheckCompRH&group.limit=10} status=0 QTime=30 
[junit4:junit4]   2> 4131 T358 C9 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&fl=id,a_si&fq=a_s:a&facet=true&group.limit=10&group.truncate=true&facet.field=a_t} hits=0 status=0 QTime=10 
[junit4:junit4]   2> 4137 T369 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857616636&fl=id&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|127.0.0.1:56003/&fq=a_s:a&facet=false&group.limit=10&group.truncate=true&facet.field=a_t} status=0 QTime=1 
[junit4:junit4]   2> 4150 T370 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&f.a_t.facet.limit=160&NOW=1355857616636&fl=id&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|127.0.0.1:56003/&group.distributed.second=true&fq=a_s:a&facet=true&group.limit=10&group.truncate=true&facet.field=a_t} status=0 QTime=10 
[junit4:junit4]   2> 4151 T367 C10 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&fl=id,a_si&shards=[ff01::114]:33332/|[ff01::213]:33332/|127.0.0.1:56003/&fq=a_s:a&facet=true&group.limit=10&group.truncate=true&facet.field=a_t} status=0 QTime=17 
[junit4:junit4]   2> 4160 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1]} 0 2
[junit4:junit4]   2> 4165 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1]} 0 2
[junit4:junit4]   2> 4170 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2]} 0 2
[junit4:junit4]   2> 4175 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2]} 0 1
[junit4:junit4]   2> 4179 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3]} 0 1
[junit4:junit4]   2> 4184 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3]} 0 2
[junit4:junit4]   2> 4189 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4]} 0 2
[junit4:junit4]   2> 4193 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4]} 0 2
[junit4:junit4]   2> 4203 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5]} 0 8
[junit4:junit4]   2> 4209 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5]} 0 3
[junit4:junit4]   2> 4220 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6]} 0 2
[junit4:junit4]   2> 4224 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6]} 0 1
[junit4:junit4]   2> 4228 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7]} 0 1
[junit4:junit4]   2> 4231 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7]} 0 0
[junit4:junit4]   2> 4236 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8]} 0 2
[junit4:junit4]   2> 4239 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8]} 0 1
[junit4:junit4]   2> 4243 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9]} 0 0
[junit4:junit4]   2> 4247 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9]} 0 1
[junit4:junit4]   2> 4265 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10]} 0 15
[junit4:junit4]   2> 4278 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10]} 0 9
[junit4:junit4]   2> 4284 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[11]} 0 2
[junit4:junit4]   2> 4289 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[11]} 0 2
[junit4:junit4]   2> 4294 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12]} 0 1
[junit4:junit4]   2> 4298 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12]} 0 1
[junit4:junit4]   2> 4303 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14]} 0 1
[junit4:junit4]   2> 4308 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14]} 0 2
[junit4:junit4]   2> 4318 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15]} 0 1
[junit4:junit4]   2> 4323 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15]} 0 2
[junit4:junit4]   2> 4328 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16]} 0 1
[junit4:junit4]   2> 4332 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16]} 0 1
[junit4:junit4]   2> 4338 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17]} 0 3
[junit4:junit4]   2> 4344 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17]} 0 2
[junit4:junit4]   2> 4365 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[18]} 0 18
[junit4:junit4]   2> 4369 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[18]} 0 1
[junit4:junit4]   2> 4373 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[19]} 0 1
[junit4:junit4]   2> 4378 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[19]} 0 1
[junit4:junit4]   2> 4382 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[20]} 0 1
[junit4:junit4]   2> 4386 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[20]} 0 1
[junit4:junit4]   2> 4399 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[21]} 0 10
[junit4:junit4]   2> 4414 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[21]} 0 12
[junit4:junit4]   2> 4420 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[22]} 0 2
[junit4:junit4]   2> 4424 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[22]} 0 2
[junit4:junit4]   2> 4429 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[23]} 0 2
[junit4:junit4]   2> 4433 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[23]} 0 2
[junit4:junit4]   2> 4436 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[100]} 0 1
[junit4:junit4]   2> 4440 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[100]} 0 1
[junit4:junit4]   2> 4443 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[101]} 0 0
[junit4:junit4]   2> 4447 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[101]} 0 1
[junit4:junit4]   2> 4452 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[102]} 0 2
[junit4:junit4]   2> 4455 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[102]} 0 1
[junit4:junit4]   2> 4459 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[103]} 0 1
[junit4:junit4]   2> 4462 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[103]} 0 1
[junit4:junit4]   2> 4467 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[104]} 0 1
[junit4:junit4]   2> 4471 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[104]} 0 1
[junit4:junit4]   2> 4475 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[105]} 0 1
[junit4:junit4]   2> 4478 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[105]} 0 0
[junit4:junit4]   2> 4482 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[106]} 0 1
[junit4:junit4]   2> 4486 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[106]} 0 1
[junit4:junit4]   2> 4495 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[107]} 0 6
[junit4:junit4]   2> 4504 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[107]} 0 7
[junit4:junit4]   2> 4508 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[108]} 0 1
[junit4:junit4]   2> 4512 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[108]} 0 1
[junit4:junit4]   2> 4516 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[109]} 0 1
[junit4:junit4]   2> 4520 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[109]} 0 1
[junit4:junit4]   2> 4523 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[110]} 0 0
[junit4:junit4]   2> 4529 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[110]} 0 1
[junit4:junit4]   2> 4534 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[111]} 0 1
[junit4:junit4]   2> 4538 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[111]} 0 0
[junit4:junit4]   2> 4542 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[112]} 0 1
[junit4:junit4]   2> 4547 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[112]} 0 1
[junit4:junit4]   2> 4551 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[113]} 0 1
[junit4:junit4]   2> 4555 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[113]} 0 1
[junit4:junit4]   2> 4559 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[114]} 0 1
[junit4:junit4]   2> 4563 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[114]} 0 1
[junit4:junit4]   2> 4568 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[115]} 0 1
[junit4:junit4]   2> 4571 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[115]} 0 0
[junit4:junit4]   2> 4576 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[116]} 0 1
[junit4:junit4]   2> 4579 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[116]} 0 0
[junit4:junit4]   2> 4591 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[117]} 0 8
[junit4:junit4]   2> 4601 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[117]} 0 7
[junit4:junit4]   2> 4605 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[118]} 0 1
[junit4:junit4]   2> 4609 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[118]} 0 1
[junit4:junit4]   2> 4614 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[119]} 0 1
[junit4:junit4]   2> 4618 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[119]} 0 1
[junit4:junit4]   2> 4621 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[120]} 0 0
[junit4:junit4]   2> 4625 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[120]} 0 1
[junit4:junit4]   2> 4628 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[121]} 0 1
[junit4:junit4]   2> 4631 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[121]} 0 1
[junit4:junit4]   2> 4635 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[122]} 0 1
[junit4:junit4]   2> 4638 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[122]} 0 1
[junit4:junit4]   2> 4641 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[123]} 0 0
[junit4:junit4]   2> 4644 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[123]} 0 0
[junit4:junit4]   2> 4647 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[124]} 0 0
[junit4:junit4]   2> 4650 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[124]} 0 0
[junit4:junit4]   2> 4654 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[125]} 0 1
[junit4:junit4]   2> 4658 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[125]} 0 1
[junit4:junit4]   2> 4661 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[126]} 0 0
[junit4:junit4]   2> 4665 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[126]} 0 1
[junit4:junit4]   2> 4674 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[127]} 0 7
[junit4:junit4]   2> 4682 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[127]} 0 6
[junit4:junit4]   2> 4685 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[128]} 0 0
[junit4:junit4]   2> 4689 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[128]} 0 1
[junit4:junit4]   2> 4692 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[129]} 0 0
[junit4:junit4]   2> 4696 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[129]} 0 1
[junit4:junit4]   2> 4699 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[130]} 0 1
[junit4:junit4]   2> 4702 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[130]} 0 1
[junit4:junit4]   2> 4705 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[131]} 0 1
[junit4:junit4]   2> 4708 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[131]} 0 0
[junit4:junit4]   2> 4712 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[132]} 0 1
[junit4:junit4]   2> 4717 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[132]} 0 0
[junit4:junit4]   2> 4720 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[133]} 0 0
[junit4:junit4]   2> 4723 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[133]} 0 0
[junit4:junit4]   2> 4727 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[134]} 0 1
[junit4:junit4]   2> 4730 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[134]} 0 0
[junit4:junit4]   2> 4734 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[135]} 0 1
[junit4:junit4]   2> 4737 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[135]} 0 1
[junit4:junit4]   2> 4740 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[136]} 0 1
[junit4:junit4]   2> 4743 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[136]} 0 0
[junit4:junit4]   2> 4751 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[137]} 0 5
[junit4:junit4]   2> 4760 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[137]} 0 6
[junit4:junit4]   2> 4765 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[138]} 0 1
[junit4:junit4]   2> 4770 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[138]} 0 1
[junit4:junit4]   2> 4774 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[139]} 0 1
[junit4:junit4]   2> 4777 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[139]} 0 0
[junit4:junit4]   2> 4781 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[140]} 0 1
[junit4:junit4]   2> 4784 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[140]} 0 1
[junit4:junit4]   2> 4787 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[141]} 0 1
[junit4:junit4]   2> 4790 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[141]} 0 1
[junit4:junit4]   2> 4794 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[142]} 0 1
[junit4:junit4]   2> 4797 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[142]} 0 1
[junit4:junit4]   2> 4800 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[143]} 0 1
[junit4:junit4]   2> 4803 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[143]} 0 1
[junit4:junit4]   2> 4805 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[144]} 0 0
[junit4:junit4]   2> 4809 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[144]} 0 1
[junit4:junit4]   2> 4812 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[145]} 0 1
[junit4:junit4]   2> 4815 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[145]} 0 0
[junit4:junit4]   2> 4819 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[146]} 0 1
[junit4:junit4]   2> 4823 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[146]} 0 1
[junit4:junit4]   2> 4832 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[147]} 0 7
[junit4:junit4]   2> 4842 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[147]} 0 7
[junit4:junit4]   2> 4845 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[148]} 0 0
[junit4:junit4]   2> 4849 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[148]} 0 1
[junit4:junit4]   2> 4852 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[149]} 0 0
[junit4:junit4]   2> 4855 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[149]} 0 0
[junit4:junit4]   2> 4858 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[500]} 0 0
[junit4:junit4]   2> 4862 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[500]} 0 1
[junit4:junit4]   2> 4865 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[501]} 0 0
[junit4:junit4]   2> 4868 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[501]} 0 0
[junit4:junit4]   2> 4872 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[502]} 0 1
[junit4:junit4]   2> 4875 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[502]} 0 1
[junit4:junit4]   2> 4878 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[503]} 0 1
[junit4:junit4]   2> 4880 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[503]} 0 0
[junit4:junit4]   2> 4883 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[504]} 0 1
[junit4:junit4]   2> 4885 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[504]} 0 0
[junit4:junit4]   2> 4888 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[505]} 0 0
[junit4:junit4]   2> 4891 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[505]} 0 0
[junit4:junit4]   2> 4894 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[506]} 0 1
[junit4:junit4]   2> 4896 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[506]} 0 0
[junit4:junit4]   2> 4904 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[507]} 0 5
[junit4:junit4]   2> 4911 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[507]} 0 5
[junit4:junit4]   2> 4960 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[508]} 0 46
[junit4:junit4]   2> 4965 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[508]} 0 3
[junit4:junit4]   2> 4968 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[509]} 0 0
[junit4:junit4]   2> 4971 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[509]} 0 1
[junit4:junit4]   2> 4974 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[510]} 0 1
[junit4:junit4]   2> 4977 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[510]} 0 1
[junit4:junit4]   2> 4984 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[511]} 0 0
[junit4:junit4]   2> 4987 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[511]} 0 0
[junit4:junit4]   2> 4990 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[512]} 0 0
[junit4:junit4]   2> 4993 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[512]} 0 0
[junit4:junit4]   2> 4996 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[513]} 0 0
[junit4:junit4]   2> 4999 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[513]} 0 0
[junit4:junit4]   2> 5002 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[514]} 0 0
[junit4:junit4]   2> 5005 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[514]} 0 1
[junit4:junit4]   2> 5008 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[515]} 0 1
[junit4:junit4]   2> 5011 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[515]} 0 0
[junit4:junit4]   2> 5014 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[516]} 0 0
[junit4:junit4]   2> 5017 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[516]} 0 1
[junit4:junit4]   2> 5026 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[517]} 0 7
[junit4:junit4]   2> 5033 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[517]} 0 4
[junit4:junit4]   2> 5081 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[518]} 0 45
[junit4:junit4]   2> 5085 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[518]} 0 1
[junit4:junit4]   2> 5088 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[519]} 0 1
[junit4:junit4]   2> 5091 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[519]} 0 0
[junit4:junit4]   2> 5094 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[520]} 0 1
[junit4:junit4]   2> 5096 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[520]} 0 0
[junit4:junit4]   2> 5099 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[521]} 0 0
[junit4:junit4]   2> 5102 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[521]} 0 0
[junit4:junit4]   2> 5105 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[522]} 0 0
[junit4:junit4]   2> 5108 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[522]} 0 0
[junit4:junit4]   2> 5111 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[523]} 0 0
[junit4:junit4]   2> 5114 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[523]} 0 0
[junit4:junit4]   2> 5117 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[524]} 0 0
[junit4:junit4]   2> 5120 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[524]} 0 0
[junit4:junit4]   2> 5123 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[525]} 0 0
[junit4:junit4]   2> 5126 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[525]} 0 0
[junit4:junit4]   2> 5129 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[526]} 0 0
[junit4:junit4]   2> 5132 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[526]} 0 0
[junit4:junit4]   2> 5137 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[527]} 0 3
[junit4:junit4]   2> 5144 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[527]} 0 4
[junit4:junit4]   2> 5149 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[528]} 0 1
[junit4:junit4]   2> 5152 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[528]} 0 1
[junit4:junit4]   2> 5155 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[529]} 0 0
[junit4:junit4]   2> 5168 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[529]} 0 1
[junit4:junit4]   2> 5171 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[530]} 0 1
[junit4:junit4]   2> 5174 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[530]} 0 0
[junit4:junit4]   2> 5178 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[531]} 0 1
[junit4:junit4]   2> 5181 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[531]} 0 1
[junit4:junit4]   2> 5185 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[532]} 0 1
[junit4:junit4]   2> 5187 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[532]} 0 0
[junit4:junit4]   2> 5191 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[533]} 0 1
[junit4:junit4]   2> 5193 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[533]} 0 0
[junit4:junit4]   2> 5196 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[534]} 0 1
[junit4:junit4]   2> 5198 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[534]} 0 0
[junit4:junit4]   2> 5200 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[535]} 0 0
[junit4:junit4]   2> 5203 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[535]} 0 1
[junit4:junit4]   2> 5220 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[536]} 0 1
[junit4:junit4]   2> 5223 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[536]} 0 1
[junit4:junit4]   2> 5239 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[537]} 0 13
[junit4:junit4]   2> 5244 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[537]} 0 3
[junit4:junit4]   2> 5247 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[538]} 0 1
[junit4:junit4]   2> 5250 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[538]} 0 1
[junit4:junit4]   2> 5252 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[539]} 0 0
[junit4:junit4]   2> 5255 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[539]} 0 1
[junit4:junit4]   2> 5258 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[540]} 0 1
[junit4:junit4]   2> 5260 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[540]} 0 0
[junit4:junit4]   2> 5263 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[541]} 0 1
[junit4:junit4]   2> 5266 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[541]} 0 1
[junit4:junit4]   2> 5271 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[542]} 0 1
[junit4:junit4]   2> 5274 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[542]} 0 0
[junit4:junit4]   2> 5277 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[543]} 0 0
[junit4:junit4]   2> 5281 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[543]} 0 0
[junit4:junit4]   2> 5284 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[544]} 0 0
[junit4:junit4]   2> 5288 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[544]} 0 1
[junit4:junit4]   2> 5293 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[545]} 0 1
[junit4:junit4]   2> 5296 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[545]} 0 0
[junit4:junit4]   2> 5300 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[546]} 0 1
[junit4:junit4]   2> 5303 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[546]} 0 0
[junit4:junit4]   2> 5309 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[547]} 0 3
[junit4:junit4]   2> 5316 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[547]} 0 3
[junit4:junit4]   2> 5320 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[548]} 0 1
[junit4:junit4]   2> 5323 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[548]} 0 1
[junit4:junit4]   2> 5327 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[549]} 0 1
[junit4:junit4]   2> 5330 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[549]} 0 1
[junit4:junit4]   2> 5333 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[550]} 0 0
[junit4:junit4]   2> 5337 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[550]} 0 1
[junit4:junit4]   2> 5340 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[551]} 0 1
[junit4:junit4]   2> 5343 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[551]} 0 0
[junit4:junit4]   2> 5346 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[552]} 0 0
[junit4:junit4]   2> 5349 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[552]} 0 0
[junit4:junit4]   2> 5352 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[553]} 0 0
[junit4:junit4]   2> 5355 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[553]} 0 0
[junit4:junit4]   2> 5358 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[554]} 0 0
[junit4:junit4]   2> 5362 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[554]} 0 1
[junit4:junit4]   2> 5365 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[555]} 0 1
[junit4:junit4]   2> 5368 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[555]} 0 1
[junit4:junit4]   2> 5371 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[556]} 0 1
[junit4:junit4]   2> 5373 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[556]} 0 0
[junit4:junit4]   2> 5379 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[557]} 0 3
[junit4:junit4]   2> 5385 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[557]} 0 3
[junit4:junit4]   2> 5388 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[558]} 0 0
[junit4:junit4]   2> 5391 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[558]} 0 0
[junit4:junit4]   2> 5394 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[559]} 0 0
[junit4:junit4]   2> 5397 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[559]} 0 0
[junit4:junit4]   2> 5400 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[560]} 0 0
[junit4:junit4]   2> 5403 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[560]} 0 0
[junit4:junit4]   2> 5407 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[561]} 0 0
[junit4:junit4]   2> 5410 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[561]} 0 1
[junit4:junit4]   2> 5413 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[562]} 0 1
[junit4:junit4]   2> 5416 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[562]} 0 1
[junit4:junit4]   2> 5418 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[563]} 0 0
[junit4:junit4]   2> 5421 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[563]} 0 0
[junit4:junit4]   2> 5424 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[564]} 0 0
[junit4:junit4]   2> 5427 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[564]} 0 0
[junit4:junit4]   2> 5430 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[565]} 0 0
[junit4:junit4]   2> 5433 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[565]} 0 1
[junit4:junit4]   2> 5436 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[566]} 0 0
[junit4:junit4]   2> 5439 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[566]} 0 1
[junit4:junit4]   2> 5444 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[567]} 0 3
[junit4:junit4]   2> 5450 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[567]} 0 3
[junit4:junit4]   2> 5454 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[568]} 0 1
[junit4:junit4]   2> 5458 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[568]} 0 0
[junit4:junit4]   2> 5461 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[569]} 0 0
[junit4:junit4]   2> 5464 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[569]} 0 0
[junit4:junit4]   2> 5467 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[570]} 0 1
[junit4:junit4]   2> 5469 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[570]} 0 0
[junit4:junit4]   2> 5472 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[571]} 0 0
[junit4:junit4]   2> 5475 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[571]} 0 1
[junit4:junit4]   2> 5477 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[572]} 0 0
[junit4:junit4]   2> 5480 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[572]} 0 1
[junit4:junit4]   2> 5483 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[573]} 0 1
[junit4:junit4]   2> 5485 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[573]} 0 0
[junit4:junit4]   2> 5488 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[574]} 0 0
[junit4:junit4]   2> 5491 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[574]} 0 1
[junit4:junit4]   2> 5493 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[575]} 0 0
[junit4:junit4]   2> 5496 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[575]} 0 1
[junit4:junit4]   2> 5499 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[576]} 0 1
[junit4:junit4]   2> 5501 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[576]} 0 0
[junit4:junit4]   2> 5507 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[577]} 0 3
[junit4:junit4]   2> 5513 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[577]} 0 4
[junit4:junit4]   2> 5516 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[578]} 0 1
[junit4:junit4]   2> 5520 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[578]} 0 1
[junit4:junit4]   2> 5523 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[579]} 0 1
[junit4:junit4]   2> 5526 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[579]} 0 1
[junit4:junit4]   2> 5528 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[580]} 0 0
[junit4:junit4]   2> 5531 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[580]} 0 0
[junit4:junit4]   2> 5533 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[581]} 0 0
[junit4:junit4]   2> 5536 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[581]} 0 0
[junit4:junit4]   2> 5538 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[582]} 0 0
[junit4:junit4]   2> 5541 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[582]} 0 0
[junit4:junit4]   2> 5543 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[583]} 0 0
[junit4:junit4]   2> 5546 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[583]} 0 0
[junit4:junit4]   2> 5548 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[584]} 0 0
[junit4:junit4]   2> 5551 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[584]} 0 0
[junit4:junit4]   2> 5553 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[585]} 0 0
[junit4:junit4]   2> 5556 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[585]} 0 1
[junit4:junit4]   2> 5558 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[586]} 0 0
[junit4:junit4]   2> 5561 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[586]} 0 1
[junit4:junit4]   2> 5572 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[587]} 0 9
[junit4:junit4]   2> 5578 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[587]} 0 3
[junit4:junit4]   2> 5581 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[588]} 0 1
[junit4:junit4]   2> 5584 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[588]} 0 1
[junit4:junit4]   2> 5587 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[589]} 0 0
[junit4:junit4]   2> 5590 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[589]} 0 1
[junit4:junit4]   2> 5593 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[590]} 0 1
[junit4:junit4]   2> 5596 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[590]} 0 1
[junit4:junit4]   2> 5598 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[591]} 0 0
[junit4:junit4]   2> 5601 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[591]} 0 0
[junit4:junit4]   2> 5604 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[592]} 0 1
[junit4:junit4]   2> 5607 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[592]} 0 1
[junit4:junit4]   2> 5609 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[593]} 0 0
[junit4:junit4]   2> 5612 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[593]} 0 0
[junit4:junit4]   2> 5614 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[594]} 0 0
[junit4:junit4]   2> 5617 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[594]} 0 0
[junit4:junit4]   2> 5620 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[595]} 0 1
[junit4:junit4]   2> 5622 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[595]} 0 0
[junit4:junit4]   2> 5625 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[596]} 0 0
[junit4:junit4]   2> 5628 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[596]} 0 1
[junit4:junit4]   2> 5659 T356 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[597]} 0 29
[junit4:junit4]   2> 5665 T368 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[597]} 0 3
[junit4:junit4]   2> 5669 T358 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[598]} 0 1
[junit4:junit4]   2> 5672 T370 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[598]} 0 1
[junit4:junit4]   2> 5675 T359 C9 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[599]} 0 1
[junit4:junit4]   2> 5681 T367 C10 UPDATE [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[599]} 0 0
[junit4:junit4]   2> 5685 T357 C9 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5693 T357 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1c10172 lockFactory=org.apache.lucene.store.NativeFSLockFactory@148b390)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1c10172 lockFactory=org.apache.lucene.store.NativeFSLockFactory@148b390)),segFN=segments_3,generation=3,filenames=[_g_nrm.cfs, _g_MockFixedIntBlock_0.frq, _g_NestedPulsing_0.doc, _g_MockRandom_0.sd, _g_MockFixedIntBlock_0.doc, _h_nrm.cfe, _i_NestedPulsing_0.doc, _j_MockRandom_0.doc, _j_MockFixedIntBlock_0.frq, _i_NestedPulsing_0.pos, _g_MockFixedIntBlock_0.pos, _h_NestedPulsing_0.pos, _g_MockFixedIntBlock_0.skp, _g_MockRandom_0.tib, _g_MockFixedIntBlock_0.tii, _g_MockRandom_0.pyl, _i.fdt, _g_MockRandom_0.skp, _g_NestedPulsing_0.tim, _j_Pulsing41_0.pos, _j_Pulsing41_0.doc, _h_MockRandom_0.sd, _i_Pulsing41_0.doc, _j_MockFixedIntBlock_0.pos, _j_MockRandom_0.tip, _g_MockRandom_0.tiv, _j_nrm.cfs, _i_MockFixedIntBlock_0.pos, _j_NestedPulsing_0.pos, _g_NestedPulsing_0.tip, _g_MockRandom_0.doc, _i_MockRandom_0.sd, _j_NestedPulsing_0.tip, _i_MockFixedIntBlock_0.tii, _j_Pulsing41_0.tip, _g_Pulsing41_0.tim, _i.fnm, _i_MockRandom_0.pos, _h_Pulsing41_0.tip, _j.fnm, _i_MockFixedIntBlock_0.frq, _i_Pulsing41_0.tim, _j.fdx, _h_MockFixedIntBlock_0.frq, _j.si, _j_NestedPulsing_0.doc, _h_MockRandom_0.tim, _h_MockRandom_0.skp, _h_MockRandom_0.tip, _i.si, _j_MockFixedIntBlock_0.doc, _h.si, _j_MockFixedIntBlock_0.tii, _j_MockRandom_0.sd, _h_MockFixedIntBlock_0.tib, _i_MockFixedIntBlock_0.skp, _h_NestedPulsing_0.doc, _g_nrm.cfe, _j_nrm.cfe, _j_MockFixedIntBlock_0.tib, _h_MockRandom_0.frq, _i.fdx, _j_MockRandom_0.tim, _i_Pulsing41_0.tip, _g_Pulsing41_0.tip, _h_Pulsing41_0.doc, _i_MockFixedIntBlock_0.tib, _j_MockFixedIntBlock_0.pyl, _h.fdx, _h_Pulsing41_0.tim, _h_MockFixedIntBlock_0.pos, _i_MockRandom_0.tii, _i_NestedPulsing_0.tip, _j_NestedPulsing_0.tim, _g_Pulsing41_0.pos, _h_NestedPulsing_0.tip, _g.fdx, _h_MockRandom_0.pos, _i_Pulsing41_0.pos, _g_MockFixedIntBlock_0.tib, _i_MockFixedIntBlock_0.doc, _h.fdt, _g.fnm, _i_MockRandom_0.doc, _i_NestedPulsing_0.tim, _j_MockRandom_0.pos, _g.si, _h_MockFixedIntBlock_0.pyl, _h_MockFixedIntBlock_0.skp, _i_nrm.cfe, _i_MockFixedIntBlock_0.pyl, _g_MockRandom_0.frq, _g_MockFixedIntBlock_0.pyl, _j.fdt, _h_MockFixedIntBlock_0.tii, _h.fnm, _j_Pulsing41_0.tim, _i_nrm.cfs, _g_MockRandom_0.pos, _h_NestedPulsing_0.tim, _h_MockFixedIntBlock_0.doc, _g_Pulsing41_0.doc, _g_NestedPulsing_0.pos, segments_3, _i_MockRandom_0.tib, _j_MockFixedIntBlock_0.skp, _h_nrm.cfs, _h_MockRandom_0.pyl, _h_Pulsing41_0.pos, _h_MockRandom_0.doc, _g.fdt]
[junit4:junit4]   2> 5694 T357 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_g_nrm.cfs, _g_MockFixedIntBlock_0.frq, _g_NestedPulsing_0.doc, _g_MockRandom_0.sd, _g_MockFixedIntBlock_0.doc, _h_nrm.cfe, _i_NestedPulsing_0.doc, _j_MockRandom_0.doc, _j_MockFixedIntBlock_0.frq, _i_NestedPulsing_0.pos, _g_MockFixedIntBlock_0.pos, _h_NestedPulsing_0.pos, _g_MockFixedIntBlock_0.skp, _g_MockRandom_0.tib, _g_MockFixedIntBlock_0.tii, _g_MockRandom_0.pyl, _i.fdt, _g_MockRandom_0.skp, _g_NestedPulsing_0.tim, _j_Pulsing41_0.pos, _j_Pulsing41_0.doc, _h_MockRandom_0.sd, _i_Pulsing41_0.doc, _j_MockFixedIntBlock_0.pos, _j_MockRandom_0.tip, _g_MockRandom_0.tiv, _j_nrm.cfs, _i_MockFixedIntBlock_0.pos, _j_NestedPulsing_0.pos, _g_NestedPulsing_0.tip, _g_MockRandom_0.doc, _i_MockRandom_0.sd, _j_NestedPulsing_0.tip, _i_MockFixedIntBlock_0.tii, _j_Pulsing41_0.tip, _g_Pulsing41_0.tim, _i.fnm, _i_MockRandom_0.pos, _h_Pulsing41_0.tip, _j.fnm, _i_MockFixedIntBlock_0.frq, _i_Pulsing41_0.tim, _j.fdx, _h_MockFixedIntBlock_0.frq, _j.si, _j_NestedPulsing_0.doc, _h_MockRandom_0.tim, _h_MockRandom_0.skp, _h_MockRandom_0.tip, _i.si, _j_MockFixedIntBlock_0.doc, _h.si, _j_MockFixedIntBlock_0.tii, _j_MockRandom_0.sd, _h_MockFixedIntBlock_0.tib, _i_MockFixedIntBlock_0.skp, _h_NestedPulsing_0.doc, _g_nrm.cfe, _j_nrm.cfe, _j_MockFixedIntBlock_0.tib, _h_MockRandom_0.frq, _i.fdx, _j_MockRandom_0.tim, _i_Pulsing41_0.tip, _g_Pulsing41_0.tip, _h_Pulsing41_0.doc, _i_MockFixedIntBlock_0.tib, _j_MockFixedIntBlock_0.pyl, _h.fdx, _h_Pulsing41_0.tim, _h_MockFixedIntBlock_0.pos, _i_MockRandom_0.tii, _i_NestedPulsing_0.tip, _j_NestedPulsing_0.tim, _g_Pulsing41_0.pos, _h_NestedPulsing_0.tip, _g.fdx, _h_MockRandom_0.pos, _i_Pulsing41_0.pos, _g_MockFixedIntBlock_0.tib, _i_MockFixedIntBlock_0.doc, _h.fdt, _g.fnm, _i_MockRandom_0.doc, _i_NestedPulsing_0.tim, _j_MockRandom_0.pos, _g.si, _h_MockFixedIntBlock_0.pyl, _h_MockFixedIntBlock_0.skp, _i_nrm.cfe, _i_MockFixedIntBlock_0.pyl, _g_MockRandom_0.frq, _g_MockFixedIntBlock_0.pyl, _j.fdt, _h_MockFixedIntBlock_0.tii, _h.fnm, _j_Pulsing41_0.tim, _i_nrm.cfs, _g_MockRandom_0.pos, _h_NestedPulsing_0.tim, _h_MockFixedIntBlock_0.doc, _g_Pulsing41_0.doc, _g_NestedPulsing_0.pos, segments_3, _i_MockRandom_0.tib, _j_MockFixedIntBlock_0.skp, _h_nrm.cfs, _h_MockRandom_0.pyl, _h_Pulsing41_0.pos, _h_MockRandom_0.doc, _g.fdt]
[junit4:junit4]   2> 5696 T357 C9 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data
[junit4:junit4]   2> 5702 T357 C9 oass.SolrIndexSearcher.<init> Opening Searcher@6acf79 main
[junit4:junit4]   2> 5703 T357 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5705 T361 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6acf79 main{StandardDirectoryReader(segments_3:42 _h(4.1):C150 _g(4.1):C10 _i(4.1):C10 _j(4.1):C2)}
[junit4:junit4]   2> 5705 T361 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index
[junit4:junit4]   2> 5706 T357 C9 UPDATE [collection1] webapp= path=/update params={version=2&waitSearcher=true&commit=true&wt=javabin&softCommit=false} {commit=} 0 22
[junit4:junit4]   2> 5708 T369 C10 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 5717 T369 C10 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@b3b8d lockFactory=org.apache.lucene.store.NativeFSLockFactory@132a165)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@b3b8d lockFactory=org.apache.lucene.store.NativeFSLockFactory@132a165)),segFN=segments_3,generation=3,filenames=[_g_nrm.cfs, _g_MockFixedIntBlock_0.frq, _i_MockRandom_0.pyl, _g_NestedPulsing_0.doc, _g_MockRandom_0.sd, _g_MockFixedIntBlock_0.doc, _h_nrm.cfe, _i_NestedPulsing_0.doc, _j_MockRandom_0.doc, _j_MockFixedIntBlock_0.frq, _i_NestedPulsing_0.pos, _g_MockFixedIntBlock_0.pos, _h_NestedPulsing_0.pos, _g_MockFixedIntBlock_0.skp, _g_MockRandom_0.tib, _g_MockFixedIntBlock_0.tii, _g_MockRandom_0.pyl, _i.fdt, _g_MockRandom_0.skp, _g_NestedPulsing_0.tim, _j_Pulsing41_0.pos, _j_Pulsing41_0.doc, _h_MockRandom_0.sd, _i_Pulsing41_0.doc, _j_MockFixedIntBlock_0.pos, _j_nrm.cfs, _i_MockFixedIntBlock_0.pos, _j_NestedPulsing_0.pos, _g_NestedPulsing_0.tip, _g_MockRandom_0.doc, _i_MockRandom_0.sd, _j_NestedPulsing_0.tip, _i_MockFixedIntBlock_0.tii, _j_Pulsing41_0.tip, _g_MockRandom_0.tii, _g_Pulsing41_0.tim, _i.fnm, _i_MockRandom_0.pos, _h_MockRandom_0.tii, _h_Pulsing41_0.tip, _j.fnm, _i_MockFixedIntBlock_0.frq, _i_Pulsing41_0.tim, _j.fdx, _h_MockFixedIntBlock_0.frq, _j.si, _j_NestedPulsing_0.doc, _h_MockRandom_0.skp, _i.si, _i_MockRandom_0.tip, _j_MockFixedIntBlock_0.doc, _h.si, _j_MockRandom_0.skp, _j_MockFixedIntBlock_0.tii, _j_MockRandom_0.sd, _h_MockFixedIntBlock_0.tib, _i_MockFixedIntBlock_0.skp, _h_NestedPulsing_0.doc, _g_nrm.cfe, _j_nrm.cfe, _j_MockFixedIntBlock_0.tib, _h_MockRandom_0.frq, _i.fdx, _i_Pulsing41_0.tip, _g_Pulsing41_0.tip, _h_Pulsing41_0.doc, _i_MockFixedIntBlock_0.tib, _j_MockFixedIntBlock_0.pyl, _h.fdx, _h_Pulsing41_0.tim, _h_MockFixedIntBlock_0.pos, _i_NestedPulsing_0.tip, _j_NestedPulsing_0.tim, _g_Pulsing41_0.pos, _h_NestedPulsing_0.tip, _h_MockRandom_0.tib, _g.fdx, _h_MockRandom_0.pos, _i_Pulsing41_0.pos, _g_MockFixedIntBlock_0.tib, _i_MockFixedIntBlock_0.doc, _h.fdt, _g.fnm, _i_MockRandom_0.doc, _i_MockRandom_0.skp, _j_MockRandom_0.pos, _i_NestedPulsing_0.tim, _j_MockRandom_0.frq, _g.si, _h_MockFixedIntBlock_0.pyl, _h_MockFixedIntBlock_0.skp, _i_nrm.cfe, _i_MockFixedIntBlock_0.pyl, _g_MockRandom_0.frq, _j_MockRandom_0.pyl, _i_MockRandom_0.tim, _g_MockFixedIntBlock_0.pyl, _j.fdt, _h_MockFixedIntBlock_0.tii, _h.fnm, _j_Pulsing41_0.tim, _i_nrm.cfs, _g_MockRandom_0.pos, _h_NestedPulsing_0.tim, _h_MockFixedIntBlock_0.doc, _g_Pulsing41_0.doc, _g_NestedPulsing_0.pos, _i_MockRandom_0.frq, segments_3, _j_MockRandom_0.tii, _j_MockFixedIntBlock_0.skp, _j_MockRandom_0.tib, _h_nrm.cfs, _h_MockRandom_0.pyl, _h_Pulsing41_0.pos, _h_MockRandom_0.doc, _g.fdt]
[junit4:junit4]   2> 5718 T369 C10 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_g_nrm.cfs, _g_MockFixedIntBlock_0.frq, _i_MockRandom_0.pyl, _g_NestedPulsing_0.doc, _g_MockRandom_0.sd, _g_MockFixedIntBlock_0.doc, _h_nrm.cfe, _i_NestedPulsing_0.doc, _j_MockRandom_0.doc, _j_MockFixedIntBlock_0.frq, _i_NestedPulsing_0.pos, _g_MockFixedIntBlock_0.pos, _h_NestedPulsing_0.pos, _g_MockFixedIntBlock_0.skp, _g_MockRandom_0.tib, _g_MockFixedIntBlock_0.tii, _g_MockRandom_0.pyl, _i.fdt, _g_MockRandom_0.skp, _g_NestedPulsing_0.tim, _j_Pulsing41_0.pos, _j_Pulsing41_0.doc, _h_MockRandom_0.sd, _i_Pulsing41_0.doc, _j_MockFixedIntBlock_0.pos, _j_nrm.cfs, _i_MockFixedIntBlock_0.pos, _j_NestedPulsing_0.pos, _g_NestedPulsing_0.tip, _g_MockRandom_0.doc, _i_MockRandom_0.sd, _j_NestedPulsing_0.tip, _i_MockFixedIntBlock_0.tii, _j_Pulsing41_0.tip, _g_MockRandom_0.tii, _g_Pulsing41_0.tim, _i.fnm, _i_MockRandom_0.pos, _h_MockRandom_0.tii, _h_Pulsing41_0.tip, _j.fnm, _i_MockFixedIntBlock_0.frq, _i_Pulsing41_0.tim, _j.fdx, _h_MockFixedIntBlock_0.frq, _j.si, _j_NestedPulsing_0.doc, _h_MockRandom_0.skp, _i.si, _i_MockRandom_0.tip, _j_MockFixedIntBlock_0.doc, _h.si, _j_MockRandom_0.skp, _j_MockFixedIntBlock_0.tii, _j_MockRandom_0.sd, _h_MockFixedIntBlock_0.tib, _i_MockFixedIntBlock_0.skp, _h_NestedPulsing_0.doc, _g_nrm.cfe, _j_nrm.cfe, _j_MockFixedIntBlock_0.tib, _h_MockRandom_0.frq, _i.fdx, _i_Pulsing41_0.tip, _g_Pulsing41_0.tip, _h_Pulsing41_0.doc, _i_MockFixedIntBlock_0.tib, _j_MockFixedIntBlock_0.pyl, _h.fdx, _h_Pulsing41_0.tim, _h_MockFixedIntBlock_0.pos, _i_NestedPulsing_0.tip, _j_NestedPulsing_0.tim, _g_Pulsing41_0.pos, _h_NestedPulsing_0.tip, _h_MockRandom_0.tib, _g.fdx, _h_MockRandom_0.pos, _i_Pulsing41_0.pos, _g_MockFixedIntBlock_0.tib, _i_MockFixedIntBlock_0.doc, _h.fdt, _g.fnm, _i_MockRandom_0.doc, _i_MockRandom_0.skp, _j_MockRandom_0.pos, _i_NestedPulsing_0.tim, _j_MockRandom_0.frq, _g.si, _h_MockFixedIntBlock_0.pyl, _h_MockFixedIntBlock_0.skp, _i_nrm.cfe, _i_MockFixedIntBlock_0.pyl, _g_MockRandom_0.frq, _j_MockRandom_0.pyl, _i_MockRandom_0.tim, _g_MockFixedIntBlock_0.pyl, _j.fdt, _h_MockFixedIntBlock_0.tii, _h.fnm, _j_Pulsing41_0.tim, _i_nrm.cfs, _g_MockRandom_0.pos, _h_NestedPulsing_0.tim, _h_MockFixedIntBlock_0.doc, _g_Pulsing41_0.doc, _g_NestedPulsing_0.pos, _i_MockRandom_0.frq, segments_3, _j_MockRandom_0.tii, _j_MockFixedIntBlock_0.skp, _j_MockRandom_0.tib, _h_nrm.cfs, _h_MockRandom_0.pyl, _h_Pulsing41_0.pos, _h_MockRandom_0.doc, _g.fdt]
[junit4:junit4]   2> 5719 T369 C10 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data
[junit4:junit4]   2> 5725 T369 C10 oass.SolrIndexSearcher.<init> Opening Searcher@131befb main
[junit4:junit4]   2> 5726 T369 C10 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 5728 T372 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@131befb main{StandardDirectoryReader(segments_3:42 _h(4.1):C150 _g(4.1):C10 _i(4.1):C10 _j(4.1):C2)}
[junit4:junit4]   2> 5729 T372 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index
[junit4:junit4]   2> 5729 T369 C10 UPDATE [collection1] webapp= path=/update params={version=2&waitSearcher=true&commit=true&wt=javabin&softCommit=false} {commit=} 0 21
[junit4:junit4]   2> 5778 T356 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&group.limit=10&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=43 
[junit4:junit4]   2> 5793 T370 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618289&fl=id&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&group.limit=10} status=0 QTime=3 
[junit4:junit4]   2> 5812 T369 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618289&fl=id&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&group.distributed.second=true&group.limit=10} status=0 QTime=14 
[junit4:junit4]   2> 5824 T367 C10 REQ [collection1] webapp= path=/select params={isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&NOW=1355857618289&fl=id,a_si,id&ids=22,23,501,502,500,505,506,503,504,509,507,508,9,8,3,2,1,10,7,6,5,4,17,18,15,16,14,11,12,19,105,104,103,102,101,100,21,20&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&group.limit=10} status=0 QTime=3 
[junit4:junit4]   2> 5831 T368 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&shards=127.0.0.1:56003/|[ff01::213]:33332/&group.limit=10&wt=javabin&q=*:*&group=true} status=0 QTime=44 
[junit4:junit4]   2> 5837 T358 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=id+asc,+_docid_+asc&fl=id,a_si&group.limit=10&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=2 
[junit4:junit4]   2> 5843 T369 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=id+asc,+_docid_+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618343&fl=id&shard.url=127.0.0.1:56003/&group.limit=10} status=0 QTime=0 
[junit4:junit4]   2> 5851 T367 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=id+asc,+_docid_+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=100&group.topgroups.a_si=50&group.topgroups.a_si=2&group.topgroups.a_si=-100&group.topgroups.a_si=500&group.topgroups.a_si=-600&group.topgroups.a_si=123&group.topgroups.a_si=876&group.topgroups.a_si=7&group.topgroups.a_si=4321&group.topgroups.a_si=-987&group.topgroups.a_si=379&group.topgroups.a_si=%01&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=9999&NOW=1355857618343&fl=id&shard.url=127.0.0.1:56003/&group.distributed.second=true&group.limit=10} status=0 QTime=5 
[junit4:junit4]   2> 5857 T368 C10 REQ [collection1] webapp= path=/select params={isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&NOW=1355857618343&fl=id,a_si,id&ids=22,23,501,502,500,505,506,503,504,509,507,508,9,8,3,2,10,1,7,6,5,4,17,18,15,16,14,11,12,19,105,104,103,102,101,100,21,20&shard.url=127.0.0.1:56003/&group.limit=10} status=0 QTime=2 
[junit4:junit4]   2> 5859 T370 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=id+asc,+_docid_+asc&fl=id,a_si&shards=127.0.0.1:56003/&group.limit=10&wt=javabin&q=*:*&group=true} status=0 QTime=18 
[junit4:junit4]   2> 5874 T359 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort={!func}add(a_si,5)+asc,+id+asc&fl=id,a_si&group.limit=10&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=11 
[junit4:junit4]   2> 5881 T367 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort={!func}add(a_si,5)+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618380&fl=id&shard.url=127.0.0.1:56003/|[ff01::083]:33332/&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 5888 T368 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort={!func}add(a_si,5)+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=%01&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&NOW=1355857618380&fl=id&shard.url=127.0.0.1:56003/|[ff01::083]:33332/&group.distributed.second=true&group.limit=10} status=0 QTime=4 
[junit4:junit4]   2> 5894 T370 C10 REQ [collection1] webapp= path=/select params={isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&NOW=1355857618380&fl=id,a_si,id&ids=19,12,11,14,16,15,18,17,20,21,100,101,102,103,104,105,508,507,509,504,503,506,505,500,502,501,23,22,4,5,6,7,10,1,2,3,8,9&shard.url=127.0.0.1:56003/|[ff01::083]:33332/&group.limit=10} status=0 QTime=2 
[junit4:junit4]   2> 5896 T369 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort={!func}add(a_si,5)+asc,+id+asc&fl=id,a_si&shards=127.0.0.1:56003/|[ff01::083]:33332/&group.limit=10&wt=javabin&q=*:*&group=true} status=0 QTime=18 
[junit4:junit4]   2> 5902 T356 C9 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=5158,tindexSize=41,time=1,phase1=1,nTerms=55,bigTerms=1,termInstances=77,uses=0}
[junit4:junit4]   2> 5902 T356 C9 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&fl=id,a_si&facet=true&group.limit=10&facet.field=a_t} hits=172 status=0 QTime=3 
[junit4:junit4]   2> 5909 T368 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618408&fl=id&shard.url=127.0.0.1:56003/&facet=false&group.limit=10&facet.field=a_t} status=0 QTime=1 
[junit4:junit4]   2> 5917 T370 C10 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=5158,tindexSize=41,time=0,phase1=0,nTerms=55,bigTerms=1,termInstances=77,uses=0}
[junit4:junit4]   2> 5918 T370 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&f.a_t.facet.limit=160&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618408&fl=id&shard.url=127.0.0.1:56003/&group.distributed.second=true&facet=true&group.limit=10&facet.field=a_t} status=0 QTime=6 
[junit4:junit4]   2> 5925 T369 C10 REQ [collection1] webapp= path=/select params={isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&NOW=1355857618408&fl=id,a_si,id&ids=102,101,100,105,104,103,21,20,14,11,12,17,18,15,16,19,9,8,7,6,5,4,3,2,1,10,501,502,500,22,23,509,507,508,505,506,503,504&shard.url=127.0.0.1:56003/&facet=false&group.limit=10&facet.field=a_t} status=0 QTime=2 
[junit4:junit4]   2> 5926 T367 C10 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&fl=id,a_si&shards=127.0.0.1:56003/&facet=true&group.limit=10&facet.field=a_t} status=0 QTime=20 
[junit4:junit4]   2> 5931 T358 C9 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=other_tl1,memSize=5027,tindexSize=51,time=0,phase1=0,nTerms=18,bigTerms=0,termInstances=18,uses=0}
[junit4:junit4]   2> 5933 T358 C9 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&stats=true&fl=id,a_si&stats.field=other_tl1&group.limit=10} hits=172 status=0 QTime=3 
[junit4:junit4]   2> 5940 T370 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&stats=false&start=0&NOW=1355857618439&fl=id&shard.url=[ff01::213]:33332/|127.0.0.1:56003/&stats.field=other_tl1&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 5947 T369 C10 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=other_tl1,memSize=5027,tindexSize=51,time=0,phase1=0,nTerms=18,bigTerms=0,termInstances=18,uses=0}
[junit4:junit4]   2> 5948 T369 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&stats=true&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618439&fl=id&shard.url=[ff01::213]:33332/|127.0.0.1:56003/&group.distributed.second=true&stats.field=other_tl1&group.limit=10} status=0 QTime=5 
[junit4:junit4]   2> 5966 T367 C10 REQ [collection1] webapp= path=/select params={isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&stats=false&NOW=1355857618439&fl=id,a_si,id&ids=8,9,6,7,4,5,2,3,1,10,502,501,500,23,22,509,508,507,506,505,504,503,101,102,100,105,103,104,20,21,14,12,11,18,17,16,15,19&shard.url=[ff01::213]:33332/|127.0.0.1:56003/&stats.field=other_tl1&group.limit=10} status=0 QTime=2 
[junit4:junit4]   2> 5968 T368 C10 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&stats=true&fl=id,a_si&shards=[ff01::213]:33332/|127.0.0.1:56003/&stats.field=other_tl1&group.limit=10} status=0 QTime=31 
[junit4:junit4]   2> 5984 T359 C9 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=kings&group=true&distrib=false&group.field=a_si&spellcheck.build=true&version=2&rows=100&fl=id,a_si&spellcheck=true&group.limit=10&qt=spellCheckCompRH} hits=1 status=0 QTime=13 
[junit4:junit4]   2> 6013 T369 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&spellcheck.count=1&q=kings&group=true&distrib=false&group.field=a_si&spellcheck.build=true&version=2&spellcheck.onlyMorePopular=false&rows=100&start=0&NOW=1355857618489&fl=id&spellcheck=false&shard.url=127.0.0.1:56003/&spellcheck.extendedResults=false&group.limit=10} status=0 QTime=0 
[junit4:junit4]   2> 6017 T367 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&spellcheck.count=5&q=kings&group=true&distrib=false&group.field=a_si&spellcheck.build=true&version=2&spellcheck.onlyMorePopular=false&rows=100&start=0&group.topgroups.a_si=876&NOW=1355857618489&fl=id&spellcheck=true&shard.url=127.0.0.1:56003/&group.distributed.second=true&spellcheck.extendedResults=false&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 6020 T368 C10 REQ [collection1] webapp= path=/select params={isShard=true&wt=javabin&spellcheck.count=1&q=kings&distrib=false&group.field=a_si&spellcheck.build=true&version=2&spellcheck.onlyMorePopular=false&rows=100&NOW=1355857618489&fl=id,a_si,id&spellcheck=false&ids=8&shard.url=127.0.0.1:56003/&spellcheck.extendedResults=false&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 6020 T370 C10 oashc.SpellCheckComponent.finishStage 127.0.0.1:56003/ null
[junit4:junit4]   2> 6021 T370 C10 oashc.SpellCheckComponent.finishStage 127.0.0.1:56003/ null
[junit4:junit4]   2> 6021 T370 C10 oashc.SpellCheckComponent.finishStage 127.0.0.1:56003/ null
[junit4:junit4]   2> 6021 T370 C10 REQ [collection1] webapp= path=/select params={sort=a_si+asc,+id+asc&wt=javabin&q=kings&group=true&group.field=a_si&spellcheck.build=true&version=2&rows=100&fl=id,a_si&spellcheck=true&shards=127.0.0.1:56003/&group.limit=10&qt=spellCheckCompRH} status=0 QTime=34 
[junit4:junit4]   2> 6050 T357 C9 REQ [collection1] webapp= path=/select params={hl=true&sort=a_si+asc,+id+asc&hl.fl=a_t&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&fl=id,a_si&facet=true&group.limit=10} hits=172 status=0 QTime=27 
[junit4:junit4]   2> 6056 T368 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&hl=false&isShard=true&sort=a_si+asc,+id+asc&hl.fl=a_t&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618555&fl=id&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|127.0.0.1:56003/|[ff01::213]:33332/&facet=false&group.limit=10} status=0 QTime=0 
[junit4:junit4]   2> 6062 T370 C10 REQ [collection1] webapp= path=/select params={hl=false&isShard=true&sort=a_si+asc,+id+asc&hl.fl=a_t&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618555&fl=id&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|127.0.0.1:56003/|[ff01::213]:33332/&group.distributed.second=true&facet=true&group.limit=10} status=0 QTime=3 
[junit4:junit4]   2> 6084 T367 C10 REQ [collection1] webapp= path=/select params={hl=true&isShard=true&hl.fl=a_t&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&NOW=1355857618555&fl=id,a_si,id&ids=11,12,14,15,16,17,18,19,100,102,101,104,103,105,21,20,500,501,502,22,23,507,508,509,503,504,505,506,9,8,5,4,7,6,1,10,3,2&shard.url=[ff01::114]:33332/|[ff01::083]:33332/|127.0.0.1:56003/|[ff01::213]:33332/&facet=false&group.limit=10} status=0 QTime=19 
[junit4:junit4]   2> 6086 T369 C10 REQ [collection1] webapp= path=/select params={hl=true&sort=a_si+asc,+id+asc&hl.fl=a_t&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&fl=id,a_si&shards=[ff01::114]:33332/|[ff01::083]:33332/|127.0.0.1:56003/|[ff01::213]:33332/&facet=true&group.limit=10} status=0 QTime=33 
[junit4:junit4]   2> 6093 T358 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&group.limit=10&wt=javabin&group.sort=id+desc&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=2 
[junit4:junit4]   2> 6099 T370 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&group.sort=id+desc&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618598&fl=id&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 6104 T367 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&group.sort=id+desc&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618598&fl=id&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&group.distributed.second=true&group.limit=10} status=0 QTime=2 
[junit4:junit4]   2> 6108 T369 C10 REQ [collection1] webapp= path=/select params={isShard=true&wt=javabin&group.sort=id+desc&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&NOW=1355857618598&fl=id,a_si,id&ids=146,596,145,597,144,594,143,595,149,148,598,147,599,23,22,1,10,2,3,4,5,6,7,8,9,141,593,142,592,591,140,590,19,18,12,11,20,21&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 6110 T368 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&shards=127.0.0.1:56003/|[ff01::213]:33332/&group.limit=10&wt=javabin&group.sort=id+desc&q=*:*&group=true} status=0 QTime=14 
[junit4:junit4]   2> 6113 T359 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&group.offset=5&group.limit=5&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=0 
[junit4:junit4]   2> 6119 T367 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618618&fl=id&shard.url=127.0.0.1:56003/&group.offset=5&group.limit=5} status=0 QTime=1 
[junit4:junit4]   2> 6127 T369 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618618&fl=id&shard.url=127.0.0.1:56003/&group.distributed.second=true&group.offset=5&group.limit=5} status=0 QTime=5 
[junit4:junit4]   2> 6131 T368 C10 REQ [collection1] webapp= path=/select params={isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&NOW=1355857618618&fl=id,a_si,id&ids=507,508,509,505,506,102,101,104,103,105&shard.url=127.0.0.1:56003/&group.offset=5&group.limit=5} status=0 QTime=0 
[junit4:junit4]   2> 6133 T370 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&shards=127.0.0.1:56003/&group.offset=5&group.limit=5&wt=javabin&q=*:*&group=true} status=0 QTime=17 
[junit4:junit4]   2> 6137 T356 C9 REQ [collection1] webapp= path=/select params={offset=5&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&rows=5&fl=id,a_si&group.offset=5&group.limit=5} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 6143 T369 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618642&fl=id&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&group.offset=5&group.limit=5} status=0 QTime=0 
[junit4:junit4]   2> 6152 T368 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618642&fl=id&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&group.distributed.second=true&group.offset=5&group.limit=5} status=0 QTime=3 
[junit4:junit4]   2> 6156 T370 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&rows=5&NOW=1355857618642&fl=id,a_si,id&ids=105,104,103,102,101,505,506,509,507,508&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&group.offset=5&group.limit=5} status=0 QTime=0 
[junit4:junit4]   2> 6157 T367 C10 REQ [collection1] webapp= path=/select params={offset=5&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&rows=5&fl=id,a_si&shards=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|127.0.0.1:56003/&group.offset=5&group.limit=5} status=0 QTime=17 
[junit4:junit4]   2> 6169 T357 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&rows=5&offset=5&sort=a_si+asc,+id+asc&fl=id,a_si&group.format=simple&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=9 
[junit4:junit4]   2> 6174 T368 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618674&fl=id&group.format=simple&shard.url=127.0.0.1:56003/|[ff01::213]:33332/} status=0 QTime=0 
[junit4:junit4]   2> 6178 T370 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618674&fl=id&group.format=simple&shard.url=127.0.0.1:56003/|[ff01::213]:33332/&group.distributed.second=true} status=0 QTime=1 
[junit4:junit4]   2> 6182 T367 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&rows=5&NOW=1355857618674&fl=id,a_si,id&ids=11,500,12,14,18,23,9,8,5,4,7,6,10,1,3,2&group.format=simple&shard.url=127.0.0.1:56003/|[ff01::213]:33332/} status=0 QTime=1 
[junit4:junit4]   2> 6183 T369 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&rows=5&offset=5&sort=a_si+asc,+id+asc&fl=id,a_si&shards=127.0.0.1:56003/|[ff01::213]:33332/&group.format=simple&wt=javabin&q=*:*&group=true} status=0 QTime=11 
[junit4:junit4]   2> 6186 T358 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&rows=5&offset=5&sort=a_si+asc,+id+asc&fl=id,a_si&group.main=true&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=0 
[junit4:junit4]   2> 6192 T370 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618691&fl=id&group.main=true&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:56003/} status=0 QTime=1 
[junit4:junit4]   2> 6197 T369 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618691&fl=id&group.main=true&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:56003/&group.distributed.second=true} status=0 QTime=2 
[junit4:junit4]   2> 6202 T367 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&rows=5&NOW=1355857618691&fl=id,a_si,id&group.main=true&ids=18,23,11,500,12,14,9,8,10,1,3,2,5,4,7,6&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:56003/} status=0 QTime=1 
[junit4:junit4]   2> 6203 T368 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&rows=5&offset=5&sort=a_si+asc,+id+asc&fl=id,a_si&group.main=true&shards=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:56003/&wt=javabin&q=*:*&group=true} status=0 QTime=14 
[junit4:junit4]   2> 6208 T359 C9 REQ [collection1] webapp= path=/select params={offset=5&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&rows=5&fl=id,a_si&group.format=simple&group.offset=5&group.limit=5} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 6215 T369 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618713&fl=id&group.format=simple&shard.url=127.0.0.1:56003/|[ff01::083]:33332/&group.offset=5&group.limit=5} status=0 QTime=1 
[junit4:junit4]   2> 6221 T367 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618713&fl=id&group.format=simple&shard.url=127.0.0.1:56003/|[ff01::083]:33332/&group.distributed.second=true&group.limit=5} status=0 QTime=3 
[junit4:junit4]   2> 6226 T368 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&rows=5&NOW=1355857618713&fl=id,a_si,id&ids=19,11,12,14,15,16,17,18,21,20,100,503,504,500,501,502,22,23,5,4,7,6,1,10,3,2,9,8&group.format=simple&shard.url=127.0.0.1:56003/|[ff01::083]:33332/&group.offset=5&group.limit=5} status=0 QTime=1 
[junit4:junit4]   2> 6227 T370 C10 REQ [collection1] webapp= path=/select params={offset=5&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&rows=5&fl=id,a_si&shards=127.0.0.1:56003/|[ff01::083]:33332/&group.format=simple&group.offset=5&group.limit=5} status=0 QTime=16 
[junit4:junit4]   2> 6231 T356 C9 REQ [collection1] webapp= path=/select params={offset=5&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&rows=5&fl=id,a_si&group.main=true&group.offset=5&group.limit=5} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 6237 T367 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618735&fl=id&group.main=true&shard.url=127.0.0.1:56003/|[ff01::114]:33332/&group.offset=5&group.limit=5} status=0 QTime=1 
[junit4:junit4]   2> 6245 T368 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618735&fl=id&group.main=true&shard.url=127.0.0.1:56003/|[ff01::114]:33332/&group.distributed.second=true&group.limit=5} status=0 QTime=5 
[junit4:junit4]   2> 6251 T370 C10 REQ [collection1] webapp= path=/select params={offset=5&isShard=true&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&rows=5&NOW=1355857618735&fl=id,a_si,id&group.main=true&ids=100,21,20,11,12,14,15,16,17,18,19,9,8,5,4,7,6,1,10,3,2,500,501,502,22,23,503,504&shard.url=127.0.0.1:56003/|[ff01::114]:33332/&group.offset=5&group.limit=5} status=0 QTime=1 
[junit4:junit4]   2> 6253 T369 C10 REQ [collection1] webapp= path=/select params={offset=5&sort=a_si+asc,+id+asc&wt=javabin&q=*:*&group=true&group.field=a_si&version=2&rows=100&rows=5&fl=id,a_si&group.main=true&shards=127.0.0.1:56003/|[ff01::114]:33332/&group.offset=5&group.limit=5} status=0 QTime=20 
[junit4:junit4]   2> 6265 T357 C9 REQ [collection1] webapp= path=/select params={version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&group.query=a_t:kings+OR+a_t:eggs&group.limit=10&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=10 
[junit4:junit4]   2> 6276 T368 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&wt=javabin&q=*:*&group=true&distrib=false&version=2&rows=100&start=0&NOW=1355857618769&fl=id&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:56003/|[ff01::083]:33332/&group.distributed.second=true&group.limit=10} status=0 QTime=5 
[junit4:junit4]   2> 6279 T370 C10 REQ [collection1] webapp= path=/select params={isShard=true&group.query=a_t:kings+OR+a_t:eggs&wt=javabin&q=*:*&distrib=false&version=2&rows=100&NOW=1355857618769&fl=id,a_si,id&ids=19,21,20,8,22,23,18&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:56003/|[ff01::083]:33332/&group.limit=10} status=0 QTime=0 
[junit4:junit4]   2> 6280 T367 C10 REQ [collection1] webapp= path=/select params={version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&shards=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:56003/|[ff01::083]:33332/&group.query=a_t:kings+OR+a_t:eggs&group.limit=10&wt=javabin&q=*:*&group=true} status=0 QTime=13 
[junit4:junit4]   2> 6284 T358 C9 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&group.query=a_t:kings+OR+a_t:eggs&group.limit=10&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 6290 T368 C10 REQ [collection1] webapp= path=/select params={group.distributed.first=true&isShard=true&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&NOW=1355857618789&fl=id&shard.url=127.0.0.1:56003/&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 6297 T370 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&wt=javabin&q=*:*&group=true&distrib=false&group.field=a_si&version=2&rows=100&start=0&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&NOW=1355857618789&fl=id&shard.url=127.0.0.1:56003/&group.distributed.second=true&group.limit=10} status=0 QTime=4 
[junit4:junit4]   2> 6302 T367 C10 REQ [collection1] webapp= path=/select params={isShard=true&group.query=a_t:kings+OR+a_t:eggs&wt=javabin&q=*:*&distrib=false&group.field=a_si&version=2&rows=100&NOW=1355857618789&fl=id,a_si,id&ids=509,507,508,505,506,503,504,501,502,500,22,23,7,6,5,4,3,2,1,10,9,8,19,14,11,12,17,18,15,16,21,20,102,101,100,105,104,103&shard.url=127.0.0.1:56003/&group.limit=10} status=0 QTime=2 
[junit4:junit4]   2> 6303 T369 C10 REQ [collection1] webapp= path=/select params={group.field=a_si&version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&shards=127.0.0.1:56003/&group.query=a_t:kings+OR+a_t:eggs&group.limit=10&wt=javabin&q=*:*&group=true} status=0 QTime=16 
[junit4:junit4]   2> 6309 T356 C9 REQ [collection1] webapp= path=/select params={version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&group.limit=10&wt=javabin&q=*:*&group=true&distrib=false} hits=172 status=0 QTime=3 
[junit4:junit4]   2> 6314 T370 C10 REQ [collection1] webapp= path=/select params={isShard=true&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&wt=javabin&q=*:*&group=true&distrib=false&version=2&rows=100&start=0&NOW=1355857618813&fl=id&shard.url=127.0.0.1:56003/&group.distributed.second=true&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 6318 T367 C10 REQ [collection1] webapp= path=/select params={isShard=true&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&wt=javabin&q=*:*&distrib=false&version=2&rows=100&NOW=1355857618813&fl=id,a_si,id&ids=8,22,23,18,19,5,21,20&shard.url=127.0.0.1:56003/&group.limit=10} status=0 QTime=1 
[junit4:junit4]   2> 6319 T368 C10 REQ [collection1] webapp= path=/select params={version=2&rows=100&sort=a_si+asc,+id+asc&fl=id,a_si&shards=127.0.0.1:56003/&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&group.limit=10&wt=javabin&q=*:*&group=true} status=0 QTime=8 
[junit4:junit4]   2> 6320 T349 oas.BaseDistributedSearchTestCase.compareResponses SEVERE Mismatched responses:
[junit4:junit4]   2> 	{responseHeader={status=0,QTime=8},grouped={id:5={matches=172,doclist={numFound=1,start=0,docs=[SolrDocument{id=5, a_si=500}]}},a_t:kings OR a_t:eggs={matches=172,doclist={numFound=7,start=0,docs=[SolrDocument{id=18, a_si=232}, SolrDocument{id=19, a_si=232}, SolrDocument{id=20, a_si=232}, SolrDocument{id=21, a_si=232}, SolrDocument{id=22, a_si=232}, SolrDocument{id=23, a_si=233}, SolrDocument{id=8, a_si=876}]}}}}
[junit4:junit4]   2> 	{responseHeader={status=0,QTime=3},grouped={a_t:kings OR a_t:eggs={matches=172,doclist={numFound=7,start=0,docs=[SolrDocument{id=18, a_si=232}, SolrDocument{id=19, a_si=232}, SolrDocument{id=20, a_si=232}, SolrDocument{id=21, a_si=232}, SolrDocument{id=22, a_si=232}, SolrDocument{id=23, a_si=233}, SolrDocument{id=8, a_si=876}]}},id:5={matches=172,doclist={numFound=1,start=0,docs=[SolrDocument{id=5, a_si=500}]}}}}
[junit4:junit4]   2> 6349 T349 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=8181037
[junit4:junit4]   2> 6350 T349 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1f87588
[junit4:junit4]   2> 6358 T349 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=172,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4:junit4]   2> 6359 T349 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 6360 T349 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 6360 T349 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 6362 T349 C9 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index
[junit4:junit4]   2> 6363 T349 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 6364 T349 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index
[junit4:junit4]   2> 6364 T349 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data/index
[junit4:junit4]   2> 6365 T349 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/control/data
[junit4:junit4]   2> 6366 T349 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
[junit4:junit4]   2> 6441 T349 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=28791658
[junit4:junit4]   2> 6442 T349 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@23a265
[junit4:junit4]   2> 6467 T349 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=172,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4:junit4]   2> 6469 T349 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 6470 T349 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 6471 T349 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 6473 T349 C10 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index
[junit4:junit4]   2> 6475 T349 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 6476 T349 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index
[junit4:junit4]   2> 6477 T349 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data
[junit4:junit4]   2> 6478 T349 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355857612509/shard0/data/index
[junit4:junit4]   2> 6480 T349 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
[junit4:junit4]   2> 6540 T349 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedGrouping -Dtests.method=testDistribSearch -Dtests.seed=C46F7E0AF00D76FE -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=uk_UA -Dtests.timezone=BST -Dtests.file.encoding=US-ASCII
[junit4:junit4] FAILURE 6.64s J1 | TestDistributedGrouping.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: junit.framework.AssertionFailedError: .grouped.id:5!=a_t:kings OR a_t:eggs (unordered or missing)
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([C46F7E0AF00D76FE:4589F012875216C2]:0)
[junit4:junit4]    > 	at junit.framework.Assert.fail(Assert.java:50)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:785)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:495)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:475)
[junit4:junit4]    > 	at org.apache.solr.TestDistributedGrouping.doTest(TestDistributedGrouping.java:168)
[junit4:junit4]    > 	at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:800)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 6639 T349 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene41: {n_td1=MockFixedIntBlock(blockSize=1923), n_tdt1=PostingsFormat(name=NestedPulsing), a_n_tdt=PostingsFormat(name=MockRandom), range_facet_si=MockFixedIntBlock(blockSize=1923), foo_b=Pulsing41(freqCutoff=19 minBlockSize=100 maxBlockSize=251), n_d1=PostingsFormat(name=NestedPulsing), rnd_b=PostingsFormat(name=MockRandom), a_s=Pulsing41(freqCutoff=19 minBlockSize=100 maxBlockSize=251), other_tl1=PostingsFormat(name=NestedPulsing), n_tf1=PostingsFormat(name=NestedPulsing), a_t=PostingsFormat(name=NestedPulsing), n_tl1=MockFixedIntBlock(blockSize=1923), n_ti1=PostingsFormat(name=MockRandom), multiDefault=MockFixedIntBlock(blockSize=1923), n_f1=MockFixedIntBlock(blockSize=1923), SubjectTerms_mfacet=PostingsFormat(name=NestedPulsing), n_l1=PostingsFormat(name=NestedPulsing), id=PostingsFormat(name=MockRandom), n_dt1=MockFixedIntBlock(blockSize=1923), oddField_s=Pulsing41(freqCutoff=19 minBlockSize=100 maxBlockSize=251), foo_f=Pulsing41(freqCutoff=19 minBlockSize=100 maxBlockSize=251), text=Pulsing41(freqCutoff=19 minBlockSize=100 maxBlockSize=251), range_facet_l=PostingsFormat(name=NestedPulsing), range_facet_sl=Pulsing41(freqCutoff=19 minBlockSize=100 maxBlockSize=251), b_n_tdt=PostingsFormat(name=NestedPulsing), timestamp=PostingsFormat(name=NestedPulsing), intDefault=PostingsFormat(name=NestedPulsing), a_si=MockFixedIntBlock(blockSize=1923), foo_d=PostingsFormat(name=MockRandom)}, sim=DefaultSimilarity, locale=uk_UA, timezone=BST
[junit4:junit4]   2> NOTE: Linux 3.2.0-35-generic i386/Oracle Corporation 1.8.0-ea (32-bit)/cpus=8,threads=1,free=96823424,total=218435584
[junit4:junit4]   2> NOTE: All tests run in this JVM: [SuggesterTest, TimeZoneUtilsTest, TestArbitraryIndexDir, DOMUtilTest, TestAnalyzedSuggestions, IndexReaderFactoryTest, TestStressVersions, URLClassifyProcessorTest, TestWriterPerf, LukeRequestHandlerTest, PingRequestHandlerTest, SignatureUpdateProcessorFactoryTest, TestCSVResponseWriter, TestDistributedGrouping]
[junit4:junit4] Completed on J1 in 6.67s, 1 test, 1 failure <<< FAILURES!

[...truncated 669 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:353: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:178: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:438: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1175: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:840: There were test failures: 243 suites, 1010 tests, 1 failure, 7 ignored (2 assumptions)

Total time: 27 minutes 21 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 32bit/jdk1.8.0-ea-b65 -server -XX:+UseSerialGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message