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 # 3272 - Failure!
Date Tue, 18 Dec 2012 13:20:36 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/3272/
Java: 32bit/jdk1.8.0-ea-b65 -client -XX:+UseG1GC

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([5FE7096DADF4B9C9:DE018775DAABD9F5]: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 8952 lines...]
[junit4:junit4] Suite: org.apache.solr.TestDistributedGrouping
[junit4:junit4]   2> 0 T1915 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /_wv/
[junit4:junit4]   2> 4 T1915 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> 5 T1915 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 13 T1915 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:53405
[junit4:junit4]   2> 14 T1915 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 15 T1915 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> 15 T1915 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> 34 T1915 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 35 T1915 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 35 T1915 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> 36 T1915 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> 36 T1915 oasc.CoreContainer.<init> New CoreContainer 5841273
[junit4:junit4]   2> 37 T1915 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> 38 T1915 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> 50 T1915 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4]   2> 51 T1915 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 52 T1915 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 52 T1915 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 52 T1915 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 53 T1915 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 53 T1915 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 54 T1915 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 54 T1915 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 55 T1915 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4]   2> 62 T1915 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 78 T1925 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> 78 T1925 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> 79 T1925 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> 79 T1925 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> 120 T1925 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 170 T1925 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 171 T1925 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 176 T1925 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 609 T1925 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 615 T1925 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 618 T1925 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 622 T1925 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 624 T1925 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 626 T1925 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 627 T1925 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 627 T1925 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-1355836571093/control/data/
[junit4:junit4]   2> 628 T1925 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@9c38d5
[junit4:junit4]   2> 628 T1925 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 629 T1925 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data forceNew:false
[junit4:junit4]   2> 629 T1925 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data
[junit4:junit4]   2> 629 T1925 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index/
[junit4:junit4]   2> 629 T1925 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 630 T1925 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index forceNew:false
[junit4:junit4]   2> 631 T1925 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1288e67 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1bf6449)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 631 T1925 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 631 T1925 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index
[junit4:junit4]   2> 632 T1925 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 633 T1925 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 633 T1925 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 633 T1925 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 634 T1925 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 634 T1925 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 634 T1925 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 635 T1925 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 635 T1925 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 636 T1925 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 637 T1925 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 637 T1925 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 638 T1925 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 638 T1925 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 638 T1925 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 639 T1925 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 639 T1925 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 640 T1925 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 641 T1925 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 641 T1925 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 642 T1925 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 642 T1925 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 643 T1925 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 644 T1925 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 644 T1925 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 645 T1925 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 646 T1925 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 648 T1925 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 650 T1925 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 651 T1925 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-REPEATER.XML, SCHEMA-LMJELINEKMERCER.XML, SOLRCONFIG-TERMINDEX.XML, SCHEMA-COLLATEFILTER.XML, SCHEMASURROUND.XML, SOLRCONFIG-FUNCTIONQUERY.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-SPATIAL.XML, SCHEMA-REQUIRED-FIELDS.XML, PHRASESUGGEST.TXT, SOLRCONFIG-ENABLEPLUGIN.XML, BAD-SCHEMA-DUP-FIELD.XML, STOP-SNOWBALL.TXT, SOLRCONFIG-SNIPPET-PROCESSOR.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, DA_UTF8.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-LAZYWRITER.XML, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA11.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, STOP-1.TXT, SCHEMA-BM25.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SOLRCONFIG-DELPOLICY2.XML, SOLRCONFIG-TRANSFORMERS.XML, BAD-MP-SOLRCONFIG.XML, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG_CODEC.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, FRENCHARTICLES.TXT, SOLRCONFIG-SOLCOREPROPERTIES.XML, SCHEMA_CODEC.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, SCHEMA12.XML, XSLT, SOLRCONFIG-PROPINJECT.XML, JASUGGEST.TXT, SCHEMA-CHARFILTERS.XML, SOLRCONFIG-NATIVELOCK.XML, STOPTYPES-2.TXT, STOPWORDS.TXT, SOLRCONFIG-MERGEPOLICY.XML, SCHEMA-REPLICATION1.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SOLRCONFIG-MASTER1.XML, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, CURRENCY.XML, SCHEMA-LMDIRICHLET.XML, COMPOUNDDICTIONARY.TXT, OPEN-EXCHANGE-RATES.JSON, BAD-SCHEMA-DUP-FIELDTYPE.XML, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, FUZZYSUGGEST.TXT, WDFTYPES.TXT, SOLRCONFIG-MASTER2.XML, SOLRCONFIG-XINCLUDE.XML, STEMDICT.TXT, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-ALTDIRECTORY.XML, SCHEMA-TRIE.XML, SCHEMA-SNIPPET-TYPE.XML, SCHEMA-MINIMAL.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, KEEP-2.TXT, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SCHEMA-SPELLCHECKER.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SOLRCONFIG-DELPOLICY1.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-ELEVATE.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG-SLAVE.XML, SCHEMA-REPLICATION2.XML, SCHEMA-XINCLUDE.XML, SCHEMA.XML, KEEP-1.TXT, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-SIMPLELOCK.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA-REVERSED.XML, SOLRCONFIG_PERF.XML, SCHEMA-STOP-KEEP.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, HUNSPELL-TEST.DIC, TRIVIAL.UPDATEPROCESSOR0.JS, SCHEMA15.XML, SOLRCONFIG-SOLR-749.XML, SCHEMA-EFF.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, STOPTYPES-1.TXT, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-HIGHLIGHT.XML, SOLRCONFIG-TLOG.XML, BAD_SOLRCONFIG.XML, SCHEMA-LUCENEMATCHVERSION.XML, STOPWITHBOM.TXT, SCHEMA-FOLDING.XML, SCHEMA-TFIDF.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SYNONYMS.TXT, SCHEMA-DFR.XML, SOLRCONFIG-NOCACHE.XML, HYPHENATION.DTD, CONDITIONAL.UPDATEPROCESSOR.JS, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-MASTER3.XML, SCHEMA-SIM.XML, DA_COMPOUNDDICTIONARY.TXT, SOLRCONFIG-REQHANDLER.INCL, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, MAPPING-ISOLATIN1ACCENT.TXT, SCHEMA-IB.XML, SOLRCONFIG-SLAVE1.XML, SCHEMA-COLLATE.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-BEHAVIOR.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, HUNSPELL-TEST.AFF, ELEVATE.XML, STOP-2.TXT, TRIVIAL.UPDATEPROCESSOR1.JS, SCHEMA-SNIPPET-FIELD.XML, SOLRCONFIG-CACHING.XML]
[junit4:junit4]   2> 653 T1925 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data
[junit4:junit4]   2> 653 T1925 oass.SolrIndexSearcher.<init> Opening Searcher@4fa21 main
[junit4:junit4]   2> 654 T1925 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 654 T1925 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 654 T1925 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 672 T1925 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 709 T1926 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4fa21 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 717 T1925 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 717 T1915 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 719 T1915 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 720 T1915 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 728 T1915 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 732 T1915 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:45766
[junit4:junit4]   2> 734 T1915 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 735 T1915 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> 736 T1915 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> 763 T1915 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 764 T1915 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 765 T1915 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> 765 T1915 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> 765 T1915 oasc.CoreContainer.<init> New CoreContainer 16157560
[junit4:junit4]   2> 766 T1915 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> 766 T1915 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> 778 T1915 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4]   2> 779 T1915 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 779 T1915 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 780 T1915 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 780 T1915 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 781 T1915 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 781 T1915 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 782 T1915 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 782 T1915 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 783 T1915 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4]   2> 789 T1915 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 804 T1936 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> 805 T1936 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> 805 T1936 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> 806 T1936 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> 845 T1936 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 892 T1936 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 892 T1936 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 897 T1936 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1319 T1936 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1325 T1936 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1328 T1936 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1332 T1936 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1335 T1936 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1337 T1936 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1337 T1936 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1338 T1936 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-1355836571093/shard0/data/
[junit4:junit4]   2> 1338 T1936 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@9c38d5
[junit4:junit4]   2> 1339 T1936 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 1339 T1936 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data forceNew:false
[junit4:junit4]   2> 1339 T1936 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data
[junit4:junit4]   2> 1340 T1936 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index/
[junit4:junit4]   2> 1340 T1936 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1341 T1936 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index forceNew:false
[junit4:junit4]   2> 1342 T1936 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1394978 lockFactory=org.apache.lucene.store.NativeFSLockFactory@10c28fd)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1342 T1936 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 1343 T1936 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index
[junit4:junit4]   2> 1343 T1936 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1344 T1936 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1345 T1936 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1345 T1936 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1345 T1936 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1346 T1936 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1346 T1936 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1346 T1936 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1347 T1936 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1348 T1936 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1349 T1936 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1349 T1936 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1350 T1936 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1350 T1936 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1351 T1936 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1351 T1936 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1352 T1936 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1352 T1936 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1353 T1936 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1354 T1936 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1355 T1936 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1355 T1936 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1356 T1936 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1357 T1936 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1358 T1936 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1358 T1936 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1359 T1936 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1362 T1936 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1364 T1936 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1365 T1936 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [OLD_SYNONYMS.TXT, PROTWORDS.TXT, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-REPEATER.XML, SCHEMA-LMJELINEKMERCER.XML, SOLRCONFIG-TERMINDEX.XML, SCHEMA-COLLATEFILTER.XML, SCHEMASURROUND.XML, SOLRCONFIG-FUNCTIONQUERY.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-SPATIAL.XML, SCHEMA-REQUIRED-FIELDS.XML, PHRASESUGGEST.TXT, SOLRCONFIG-ENABLEPLUGIN.XML, BAD-SCHEMA-DUP-FIELD.XML, STOP-SNOWBALL.TXT, SOLRCONFIG-SNIPPET-PROCESSOR.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, DA_UTF8.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-LAZYWRITER.XML, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA11.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, STOP-1.TXT, SCHEMA-BM25.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SOLRCONFIG-DELPOLICY2.XML, SOLRCONFIG-TRANSFORMERS.XML, BAD-MP-SOLRCONFIG.XML, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG_CODEC.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, FRENCHARTICLES.TXT, SOLRCONFIG-SOLCOREPROPERTIES.XML, SCHEMA_CODEC.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, SCHEMA12.XML, XSLT, SOLRCONFIG-PROPINJECT.XML, JASUGGEST.TXT, SCHEMA-CHARFILTERS.XML, SOLRCONFIG-NATIVELOCK.XML, STOPTYPES-2.TXT, STOPWORDS.TXT, SOLRCONFIG-MERGEPOLICY.XML, SCHEMA-REPLICATION1.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SOLRCONFIG-MASTER1.XML, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, CURRENCY.XML, SCHEMA-LMDIRICHLET.XML, COMPOUNDDICTIONARY.TXT, OPEN-EXCHANGE-RATES.JSON, BAD-SCHEMA-DUP-FIELDTYPE.XML, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, FUZZYSUGGEST.TXT, WDFTYPES.TXT, SOLRCONFIG-MASTER2.XML, SOLRCONFIG-XINCLUDE.XML, STEMDICT.TXT, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-ALTDIRECTORY.XML, SCHEMA-TRIE.XML, SCHEMA-SNIPPET-TYPE.XML, SCHEMA-MINIMAL.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, KEEP-2.TXT, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SCHEMA-SPELLCHECKER.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SOLRCONFIG-DELPOLICY1.XML, SOLRCONFIG-QUERYSENDER.XML, SOLRCONFIG-ELEVATE.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG-SLAVE.XML, SCHEMA-REPLICATION2.XML, SCHEMA-XINCLUDE.XML, SCHEMA.XML, KEEP-1.TXT, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-SIMPLELOCK.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA-REVERSED.XML, SOLRCONFIG_PERF.XML, SCHEMA-STOP-KEEP.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, HUNSPELL-TEST.DIC, TRIVIAL.UPDATEPROCESSOR0.JS, SCHEMA15.XML, SOLRCONFIG-SOLR-749.XML, SCHEMA-EFF.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, STOPTYPES-1.TXT, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-HIGHLIGHT.XML, SOLRCONFIG-TLOG.XML, BAD_SOLRCONFIG.XML, SCHEMA-LUCENEMATCHVERSION.XML, STOPWITHBOM.TXT, SCHEMA-FOLDING.XML, SCHEMA-TFIDF.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SYNONYMS.TXT, SCHEMA-DFR.XML, SOLRCONFIG-NOCACHE.XML, HYPHENATION.DTD, CONDITIONAL.UPDATEPROCESSOR.JS, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-MASTER3.XML, SCHEMA-SIM.XML, DA_COMPOUNDDICTIONARY.TXT, SOLRCONFIG-REQHANDLER.INCL, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, MAPPING-ISOLATIN1ACCENT.TXT, SCHEMA-IB.XML, SOLRCONFIG-SLAVE1.XML, SCHEMA-COLLATE.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-BEHAVIOR.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, HUNSPELL-TEST.AFF, ELEVATE.XML, STOP-2.TXT, TRIVIAL.UPDATEPROCESSOR1.JS, SCHEMA-SNIPPET-FIELD.XML, SOLRCONFIG-CACHING.XML]
[junit4:junit4]   2> 1367 T1936 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data
[junit4:junit4]   2> 1368 T1936 oass.SolrIndexSearcher.<init> Opening Searcher@6d35bc main
[junit4:junit4]   2> 1368 T1936 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1368 T1936 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1369 T1936 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1372 T1936 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1395 T1937 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d35bc main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1401 T1936 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 1402 T1915 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 1403 T1915 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 1404 T1915 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C185 name=collection1 org.apache.solr.core.SolrCore@ff199e
[junit4:junit4]   2> 1420 T1924 C185 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 1421 T1924 C185 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data
[junit4:junit4]   2> 1422 T1924 C185 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1288e67 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1bf6449)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1422 T1924 C185 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 1423 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 4
[junit4:junit4]   2> ASYNC  NEW_CORE C186 name=collection1 org.apache.solr.core.SolrCore@1e34d73
[junit4:junit4]   2> 1427 T1933 C186 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 1428 T1933 C186 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data
[junit4:junit4]   2> 1429 T1933 C186 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1394978 lockFactory=org.apache.lucene.store.NativeFSLockFactory@10c28fd)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1430 T1933 C186 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 1430 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 3
[junit4:junit4]   2> 1432 T1921 C185 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1433 T1921 C185 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1288e67 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1bf6449)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1288e67 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1bf6449)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 1433 T1921 C185 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4]   2> 1434 T1921 C185 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data
[junit4:junit4]   2> 1434 T1921 C185 oass.SolrIndexSearcher.<init> Opening Searcher@1ffb1e2 main
[junit4:junit4]   2> 1435 T1921 C185 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1436 T1926 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1ffb1e2 main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 1437 T1926 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index
[junit4:junit4]   2> 1437 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={softCommit=false&version=2&commit=true&wt=javabin&waitSearcher=true} {commit=} 0 5
[junit4:junit4]   2> 1439 T1934 C186 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1440 T1934 C186 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1394978 lockFactory=org.apache.lucene.store.NativeFSLockFactory@10c28fd)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1394978 lockFactory=org.apache.lucene.store.NativeFSLockFactory@10c28fd)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 1440 T1934 C186 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4]   2> 1441 T1934 C186 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data
[junit4:junit4]   2> 1441 T1934 C186 oass.SolrIndexSearcher.<init> Opening Searcher@191389b main
[junit4:junit4]   2> 1441 T1934 C186 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1443 T1937 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@191389b main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 1443 T1937 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index
[junit4:junit4]   2> 1444 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={softCommit=false&version=2&commit=true&wt=javabin&waitSearcher=true} {commit=} 0 5
[junit4:junit4]   2> 1449 T1922 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&distrib=false&group=true} hits=0 status=0 QTime=3 
[junit4:junit4]   2> 1463 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836572541&wt=javabin&distrib=false} status=0 QTime=8 
[junit4:junit4]   2> 1473 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&group=true&shards=127.0.0.1:45766/_wv} status=0 QTime=20 
[junit4:junit4]   2> 1475 T1923 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&hl.fl=a_t&group=true&hl=true&version=2&group.limit=10&rows=100&wt=javabin&distrib=false} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1479 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id&group.distributed.first=true&hl.fl=a_t&group=true&hl=false&start=0&version=2&group.limit=10&rows=100&NOW=1355836572565&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 1480 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&hl.fl=a_t&group=true&hl=true&shards=127.0.0.1:45766/_wv&version=2&group.limit=10&rows=100&wt=javabin} status=0 QTime=3 
[junit4:junit4]   2> 1482 T1924 C185 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> 1482 T1924 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=true&fl=id,a_si&group=true&version=2&group.limit=10&rows=100&wt=javabin&distrib=false} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1488 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=false&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836572574&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 1503 T1932 C186 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> 1504 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=true&fl=id&group=true&start=0&version=2&group.distributed.second=true&f.a_t.facet.limit=160&group.limit=10&rows=100&NOW=1355836572574&wt=javabin&distrib=false} status=0 QTime=7 
[junit4:junit4]   2> 1509 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=true&fl=id,a_si&group=true&shards=[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&version=2&group.limit=10&rows=100&wt=javabin} status=0 QTime=23 
[junit4:junit4]   2> 1520 T1921 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&stats.field=a_si&group.field=a_si&fl=id,a_si&group=true&version=2&group.limit=10&rows=100&wt=javabin&stats=true&distrib=false} hits=0 status=0 QTime=9 
[junit4:junit4]   2> 1529 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&stats.field=a_si&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836572610&wt=javabin&stats=false&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 1533 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&stats.field=a_si&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836572610&wt=javabin&stats=true&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 1534 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&stats.field=a_si&group.field=a_si&fl=id,a_si&group=true&shards=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::213]:33332/_wv&version=2&group.limit=10&rows=100&wt=javabin&stats=true} status=0 QTime=12 
[junit4:junit4]   2> 1552 T1922 C185 REQ [collection1] webapp=/_wv path=/select params={q=kings&sort=a_si+asc,+id+asc&qt=spellCheckCompRH&group.field=a_si&fl=id,a_si&group=true&version=2&group.limit=10&rows=100&spellcheck=true&wt=javabin&spellcheck.build=true&distrib=false} hits=0 status=0 QTime=16 
[junit4:junit4]   2> 1588 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::114]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=kings&sort=a_si+asc,+id+asc&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&spellcheck.extendedResults=false&version=2&spellcheck.onlyMorePopular=false&group.limit=10&rows=100&spellcheck=false&NOW=1355836572643&wt=javabin&spellcheck.build=true&distrib=false&spellcheck.count=1} status=0 QTime=1 
[junit4:junit4]   2> 1589 T1935 C186 oashc.SpellCheckComponent.finishStage 127.0.0.1:45766/_wv|[ff01::114]:33332/_wv|[ff01::213]:33332/_wv null
[junit4:junit4]   2> 1589 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={q=kings&sort=a_si+asc,+id+asc&qt=spellCheckCompRH&group.field=a_si&fl=id,a_si&group=true&shards=127.0.0.1:45766/_wv|[ff01::114]:33332/_wv|[ff01::213]:33332/_wv&version=2&group.limit=10&rows=100&spellcheck=true&wt=javabin&spellcheck.build=true} status=0 QTime=34 
[junit4:junit4]   2> 1591 T1923 C185 REQ [collection1] webapp=/_wv path=/select params={fq=a_s:a&q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=true&fl=id,a_si&group.truncate=true&group=true&version=2&group.limit=10&rows=100&wt=javabin&distrib=false} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1599 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={fq=a_s:a&shard.url=[ff01::114]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=false&fl=id&group.truncate=true&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836572681&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 1601 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={fq=a_s:a&shard.url=[ff01::114]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=true&fl=id&group.truncate=true&group=true&start=0&version=2&group.distributed.second=true&f.a_t.facet.limit=160&group.limit=10&rows=100&NOW=1355836572681&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 1602 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={fq=a_s:a&q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=true&fl=id,a_si&group.truncate=true&group=true&shards=[ff01::114]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&version=2&group.limit=10&rows=100&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 1606 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[1]} 0 2
[junit4:junit4]   2> 1610 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[1]} 0 2
[junit4:junit4]   2> 1613 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[2]} 0 1
[junit4:junit4]   2> 1616 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[2]} 0 1
[junit4:junit4]   2> 1619 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[3]} 0 1
[junit4:junit4]   2> 1622 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[3]} 0 1
[junit4:junit4]   2> 1625 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[4]} 0 2
[junit4:junit4]   2> 1628 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[4]} 0 1
[junit4:junit4]   2> 1631 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[5]} 0 1
[junit4:junit4]   2> 1634 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[5]} 0 0
[junit4:junit4]   2> 1637 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[6]} 0 1
[junit4:junit4]   2> 1640 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[6]} 0 1
[junit4:junit4]   2> 1643 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[7]} 0 1
[junit4:junit4]   2> 1646 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[7]} 0 1
[junit4:junit4]   2> 1650 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[8]} 0 2
[junit4:junit4]   2> 1654 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[8]} 0 1
[junit4:junit4]   2> 1657 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[9]} 0 0
[junit4:junit4]   2> 1660 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[9]} 0 1
[junit4:junit4]   2> 1666 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[10]} 0 3
[junit4:junit4]   2> 1672 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[10]} 0 5
[junit4:junit4]   2> 1676 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[11]} 0 2
[junit4:junit4]   2> 1679 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[11]} 0 1
[junit4:junit4]   2> 1682 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[12]} 0 1
[junit4:junit4]   2> 1685 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[12]} 0 1
[junit4:junit4]   2> 1688 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[14]} 0 1
[junit4:junit4]   2> 1691 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[14]} 0 1
[junit4:junit4]   2> 1694 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[15]} 0 1
[junit4:junit4]   2> 1697 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[15]} 0 1
[junit4:junit4]   2> 1699 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[16]} 0 0
[junit4:junit4]   2> 1702 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[16]} 0 1
[junit4:junit4]   2> 1706 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[17]} 0 2
[junit4:junit4]   2> 1710 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[17]} 0 2
[junit4:junit4]   2> 1714 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[18]} 0 1
[junit4:junit4]   2> 1718 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[18]} 0 1
[junit4:junit4]   2> 1721 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[19]} 0 1
[junit4:junit4]   2> 1724 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[19]} 0 1
[junit4:junit4]   2> 1726 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[20]} 0 0
[junit4:junit4]   2> 1729 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[20]} 0 1
[junit4:junit4]   2> 1735 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[21]} 0 4
[junit4:junit4]   2> 1740 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[21]} 0 3
[junit4:junit4]   2> 1744 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[22]} 0 1
[junit4:junit4]   2> 1747 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[22]} 0 1
[junit4:junit4]   2> 1749 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[23]} 0 0
[junit4:junit4]   2> 1752 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[23]} 0 1
[junit4:junit4]   2> 1754 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[100]} 0 0
[junit4:junit4]   2> 1757 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[100]} 0 1
[junit4:junit4]   2> 1759 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[101]} 0 1
[junit4:junit4]   2> 1762 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[101]} 0 1
[junit4:junit4]   2> 1764 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[102]} 0 1
[junit4:junit4]   2> 1766 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[102]} 0 0
[junit4:junit4]   2> 1769 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[103]} 0 1
[junit4:junit4]   2> 1771 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[103]} 0 1
[junit4:junit4]   2> 1773 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[104]} 0 0
[junit4:junit4]   2> 1776 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[104]} 0 1
[junit4:junit4]   2> 1778 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[105]} 0 0
[junit4:junit4]   2> 1781 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[105]} 0 1
[junit4:junit4]   2> 1783 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[106]} 0 0
[junit4:junit4]   2> 1785 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[106]} 0 0
[junit4:junit4]   2> 1790 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[107]} 0 3
[junit4:junit4]   2> 1794 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[107]} 0 2
[junit4:junit4]   2> 1798 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[108]} 0 1
[junit4:junit4]   2> 1800 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[108]} 0 1
[junit4:junit4]   2> 1804 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[109]} 0 1
[junit4:junit4]   2> 1806 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[109]} 0 0
[junit4:junit4]   2> 1809 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[110]} 0 1
[junit4:junit4]   2> 1812 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[110]} 0 1
[junit4:junit4]   2> 1814 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[111]} 0 0
[junit4:junit4]   2> 1817 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[111]} 0 1
[junit4:junit4]   2> 1819 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[112]} 0 0
[junit4:junit4]   2> 1822 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[112]} 0 1
[junit4:junit4]   2> 1824 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[113]} 0 0
[junit4:junit4]   2> 1827 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[113]} 0 1
[junit4:junit4]   2> 1829 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[114]} 0 1
[junit4:junit4]   2> 1832 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[114]} 0 1
[junit4:junit4]   2> 1834 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[115]} 0 1
[junit4:junit4]   2> 1836 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[115]} 0 0
[junit4:junit4]   2> 1839 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[116]} 0 1
[junit4:junit4]   2> 1841 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[116]} 0 0
[junit4:junit4]   2> 1845 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[117]} 0 2
[junit4:junit4]   2> 1849 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[117]} 0 2
[junit4:junit4]   2> 1852 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[118]} 0 1
[junit4:junit4]   2> 1855 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[118]} 0 1
[junit4:junit4]   2> 1857 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[119]} 0 0
[junit4:junit4]   2> 1860 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[119]} 0 1
[junit4:junit4]   2> 1862 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[120]} 0 0
[junit4:junit4]   2> 1865 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[120]} 0 1
[junit4:junit4]   2> 1867 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[121]} 0 0
[junit4:junit4]   2> 1870 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[121]} 0 1
[junit4:junit4]   2> 1873 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[122]} 0 1
[junit4:junit4]   2> 1875 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[122]} 0 0
[junit4:junit4]   2> 1878 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[123]} 0 1
[junit4:junit4]   2> 1881 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[123]} 0 1
[junit4:junit4]   2> 1884 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[124]} 0 1
[junit4:junit4]   2> 1886 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[124]} 0 0
[junit4:junit4]   2> 1889 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[125]} 0 1
[junit4:junit4]   2> 1891 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[125]} 0 0
[junit4:junit4]   2> 1894 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[126]} 0 1
[junit4:junit4]   2> 1896 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[126]} 0 0
[junit4:junit4]   2> 1900 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[127]} 0 2
[junit4:junit4]   2> 1905 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[127]} 0 3
[junit4:junit4]   2> 1908 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[128]} 0 1
[junit4:junit4]   2> 1910 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[128]} 0 1
[junit4:junit4]   2> 1913 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[129]} 0 1
[junit4:junit4]   2> 1915 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[129]} 0 0
[junit4:junit4]   2> 1918 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[130]} 0 1
[junit4:junit4]   2> 1920 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[130]} 0 1
[junit4:junit4]   2> 1923 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[131]} 0 1
[junit4:junit4]   2> 1925 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[131]} 0 1
[junit4:junit4]   2> 1927 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[132]} 0 0
[junit4:junit4]   2> 1930 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[132]} 0 1
[junit4:junit4]   2> 1932 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[133]} 0 0
[junit4:junit4]   2> 1935 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[133]} 0 1
[junit4:junit4]   2> 1937 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[134]} 0 1
[junit4:junit4]   2> 1940 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[134]} 0 1
[junit4:junit4]   2> 1942 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[135]} 0 0
[junit4:junit4]   2> 1945 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[135]} 0 1
[junit4:junit4]   2> 1948 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[136]} 0 1
[junit4:junit4]   2> 1951 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[136]} 0 1
[junit4:junit4]   2> 1956 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[137]} 0 3
[junit4:junit4]   2> 1960 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[137]} 0 2
[junit4:junit4]   2> 1963 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[138]} 0 1
[junit4:junit4]   2> 1966 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[138]} 0 1
[junit4:junit4]   2> 1968 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[139]} 0 0
[junit4:junit4]   2> 1970 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[139]} 0 0
[junit4:junit4]   2> 1973 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[140]} 0 1
[junit4:junit4]   2> 1975 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[140]} 0 0
[junit4:junit4]   2> 1978 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[141]} 0 1
[junit4:junit4]   2> 1980 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[141]} 0 1
[junit4:junit4]   2> 1982 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[142]} 0 0
[junit4:junit4]   2> 1987 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[142]} 0 1
[junit4:junit4]   2> 1989 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[143]} 0 0
[junit4:junit4]   2> 1992 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[143]} 0 1
[junit4:junit4]   2> 1994 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[144]} 0 0
[junit4:junit4]   2> 1997 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[144]} 0 1
[junit4:junit4]   2> 1999 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[145]} 0 0
[junit4:junit4]   2> 2001 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[145]} 0 0
[junit4:junit4]   2> 2004 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[146]} 0 1
[junit4:junit4]   2> 2006 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[146]} 0 0
[junit4:junit4]   2> 2011 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[147]} 0 3
[junit4:junit4]   2> 2015 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[147]} 0 2
[junit4:junit4]   2> 2018 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[148]} 0 1
[junit4:junit4]   2> 2021 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[148]} 0 1
[junit4:junit4]   2> 2024 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[149]} 0 1
[junit4:junit4]   2> 2027 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[149]} 0 1
[junit4:junit4]   2> 2029 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[500]} 0 0
[junit4:junit4]   2> 2031 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[500]} 0 0
[junit4:junit4]   2> 2033 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[501]} 0 0
[junit4:junit4]   2> 2035 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[501]} 0 0
[junit4:junit4]   2> 2037 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[502]} 0 0
[junit4:junit4]   2> 2040 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[502]} 0 1
[junit4:junit4]   2> 2042 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[503]} 0 1
[junit4:junit4]   2> 2044 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[503]} 0 0
[junit4:junit4]   2> 2046 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[504]} 0 0
[junit4:junit4]   2> 2048 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[504]} 0 0
[junit4:junit4]   2> 2050 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[505]} 0 0
[junit4:junit4]   2> 2052 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[505]} 0 0
[junit4:junit4]   2> 2054 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[506]} 0 0
[junit4:junit4]   2> 2056 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[506]} 0 0
[junit4:junit4]   2> 2060 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[507]} 0 2
[junit4:junit4]   2> 2063 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[507]} 0 2
[junit4:junit4]   2> 2066 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[508]} 0 1
[junit4:junit4]   2> 2069 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[508]} 0 1
[junit4:junit4]   2> 2071 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[509]} 0 0
[junit4:junit4]   2> 2073 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[509]} 0 0
[junit4:junit4]   2> 2076 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[510]} 0 0
[junit4:junit4]   2> 2078 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[510]} 0 0
[junit4:junit4]   2> 2081 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[511]} 0 1
[junit4:junit4]   2> 2083 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[511]} 0 0
[junit4:junit4]   2> 2085 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[512]} 0 0
[junit4:junit4]   2> 2088 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[512]} 0 1
[junit4:junit4]   2> 2090 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[513]} 0 0
[junit4:junit4]   2> 2093 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[513]} 0 1
[junit4:junit4]   2> 2095 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[514]} 0 0
[junit4:junit4]   2> 2098 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[514]} 0 1
[junit4:junit4]   2> 2100 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[515]} 0 1
[junit4:junit4]   2> 2102 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[515]} 0 0
[junit4:junit4]   2> 2104 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[516]} 0 0
[junit4:junit4]   2> 2106 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[516]} 0 0
[junit4:junit4]   2> 2109 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[517]} 0 1
[junit4:junit4]   2> 2112 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[517]} 0 1
[junit4:junit4]   2> 2115 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[518]} 0 1
[junit4:junit4]   2> 2117 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[518]} 0 0
[junit4:junit4]   2> 2119 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[519]} 0 0
[junit4:junit4]   2> 2121 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[519]} 0 0
[junit4:junit4]   2> 2124 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[520]} 0 1
[junit4:junit4]   2> 2126 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[520]} 0 1
[junit4:junit4]   2> 2128 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[521]} 0 1
[junit4:junit4]   2> 2130 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[521]} 0 0
[junit4:junit4]   2> 2132 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[522]} 0 0
[junit4:junit4]   2> 2134 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[522]} 0 0
[junit4:junit4]   2> 2136 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[523]} 0 0
[junit4:junit4]   2> 2138 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[523]} 0 0
[junit4:junit4]   2> 2140 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[524]} 0 0
[junit4:junit4]   2> 2143 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[524]} 0 1
[junit4:junit4]   2> 2145 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[525]} 0 1
[junit4:junit4]   2> 2147 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[525]} 0 1
[junit4:junit4]   2> 2149 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[526]} 0 1
[junit4:junit4]   2> 2151 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[526]} 0 0
[junit4:junit4]   2> 2154 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[527]} 0 1
[junit4:junit4]   2> 2157 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[527]} 0 1
[junit4:junit4]   2> 2160 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[528]} 0 1
[junit4:junit4]   2> 2163 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[528]} 0 1
[junit4:junit4]   2> 2165 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[529]} 0 0
[junit4:junit4]   2> 2168 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[529]} 0 1
[junit4:junit4]   2> 2170 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[530]} 0 0
[junit4:junit4]   2> 2172 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[530]} 0 0
[junit4:junit4]   2> 2174 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[531]} 0 0
[junit4:junit4]   2> 2176 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[531]} 0 0
[junit4:junit4]   2> 2178 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[532]} 0 0
[junit4:junit4]   2> 2180 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[532]} 0 0
[junit4:junit4]   2> 2182 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[533]} 0 0
[junit4:junit4]   2> 2185 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[533]} 0 1
[junit4:junit4]   2> 2187 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[534]} 0 0
[junit4:junit4]   2> 2189 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[534]} 0 0
[junit4:junit4]   2> 2192 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[535]} 0 1
[junit4:junit4]   2> 2194 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[535]} 0 1
[junit4:junit4]   2> 2196 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[536]} 0 1
[junit4:junit4]   2> 2198 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[536]} 0 0
[junit4:junit4]   2> 2201 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[537]} 0 1
[junit4:junit4]   2> 2205 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[537]} 0 2
[junit4:junit4]   2> 2208 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[538]} 0 1
[junit4:junit4]   2> 2210 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[538]} 0 1
[junit4:junit4]   2> 2212 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[539]} 0 0
[junit4:junit4]   2> 2214 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[539]} 0 0
[junit4:junit4]   2> 2216 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[540]} 0 0
[junit4:junit4]   2> 2219 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[540]} 0 1
[junit4:junit4]   2> 2221 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[541]} 0 0
[junit4:junit4]   2> 2223 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[541]} 0 0
[junit4:junit4]   2> 2226 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[542]} 0 1
[junit4:junit4]   2> 2228 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[542]} 0 0
[junit4:junit4]   2> 2231 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[543]} 0 1
[junit4:junit4]   2> 2233 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[543]} 0 0
[junit4:junit4]   2> 2235 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[544]} 0 0
[junit4:junit4]   2> 2238 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[544]} 0 0
[junit4:junit4]   2> 2240 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[545]} 0 0
[junit4:junit4]   2> 2243 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[545]} 0 1
[junit4:junit4]   2> 2245 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[546]} 0 0
[junit4:junit4]   2> 2247 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[546]} 0 0
[junit4:junit4]   2> 2251 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[547]} 0 2
[junit4:junit4]   2> 2254 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[547]} 0 2
[junit4:junit4]   2> 2256 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[548]} 0 0
[junit4:junit4]   2> 2259 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[548]} 0 1
[junit4:junit4]   2> 2261 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[549]} 0 1
[junit4:junit4]   2> 2263 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[549]} 0 1
[junit4:junit4]   2> 2265 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[550]} 0 1
[junit4:junit4]   2> 2267 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[550]} 0 1
[junit4:junit4]   2> 2269 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[551]} 0 0
[junit4:junit4]   2> 2271 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[551]} 0 1
[junit4:junit4]   2> 2273 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[552]} 0 1
[junit4:junit4]   2> 2275 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[552]} 0 0
[junit4:junit4]   2> 2277 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[553]} 0 0
[junit4:junit4]   2> 2279 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[553]} 0 0
[junit4:junit4]   2> 2281 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[554]} 0 0
[junit4:junit4]   2> 2283 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[554]} 0 0
[junit4:junit4]   2> 2285 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[555]} 0 0
[junit4:junit4]   2> 2287 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[555]} 0 0
[junit4:junit4]   2> 2289 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[556]} 0 0
[junit4:junit4]   2> 2291 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[556]} 0 0
[junit4:junit4]   2> 2294 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[557]} 0 1
[junit4:junit4]   2> 2297 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[557]} 0 1
[junit4:junit4]   2> 2299 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[558]} 0 0
[junit4:junit4]   2> 2302 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[558]} 0 1
[junit4:junit4]   2> 2304 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[559]} 0 1
[junit4:junit4]   2> 2306 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[559]} 0 0
[junit4:junit4]   2> 2308 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[560]} 0 1
[junit4:junit4]   2> 2310 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[560]} 0 1
[junit4:junit4]   2> 2312 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[561]} 0 0
[junit4:junit4]   2> 2314 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[561]} 0 0
[junit4:junit4]   2> 2316 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[562]} 0 0
[junit4:junit4]   2> 2319 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[562]} 0 0
[junit4:junit4]   2> 2321 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[563]} 0 1
[junit4:junit4]   2> 2323 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[563]} 0 0
[junit4:junit4]   2> 2325 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[564]} 0 0
[junit4:junit4]   2> 2327 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[564]} 0 0
[junit4:junit4]   2> 2329 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[565]} 0 0
[junit4:junit4]   2> 2331 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[565]} 0 0
[junit4:junit4]   2> 2333 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[566]} 0 0
[junit4:junit4]   2> 2335 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[566]} 0 0
[junit4:junit4]   2> 2339 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[567]} 0 2
[junit4:junit4]   2> 2342 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[567]} 0 2
[junit4:junit4]   2> 2344 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[568]} 0 1
[junit4:junit4]   2> 2346 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[568]} 0 0
[junit4:junit4]   2> 2348 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[569]} 0 0
[junit4:junit4]   2> 2350 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[569]} 0 0
[junit4:junit4]   2> 2352 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[570]} 0 0
[junit4:junit4]   2> 2354 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[570]} 0 0
[junit4:junit4]   2> 2357 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[571]} 0 1
[junit4:junit4]   2> 2359 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[571]} 0 1
[junit4:junit4]   2> 2361 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[572]} 0 1
[junit4:junit4]   2> 2363 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[572]} 0 0
[junit4:junit4]   2> 2365 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[573]} 0 0
[junit4:junit4]   2> 2367 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[573]} 0 0
[junit4:junit4]   2> 2369 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[574]} 0 0
[junit4:junit4]   2> 2371 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[574]} 0 0
[junit4:junit4]   2> 2373 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[575]} 0 0
[junit4:junit4]   2> 2375 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[575]} 0 0
[junit4:junit4]   2> 2377 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[576]} 0 0
[junit4:junit4]   2> 2379 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[576]} 0 0
[junit4:junit4]   2> 2383 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[577]} 0 2
[junit4:junit4]   2> 2386 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[577]} 0 2
[junit4:junit4]   2> 2388 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[578]} 0 0
[junit4:junit4]   2> 2390 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[578]} 0 0
[junit4:junit4]   2> 2392 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[579]} 0 0
[junit4:junit4]   2> 2395 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[579]} 0 1
[junit4:junit4]   2> 2397 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[580]} 0 1
[junit4:junit4]   2> 2399 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[580]} 0 0
[junit4:junit4]   2> 2401 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[581]} 0 0
[junit4:junit4]   2> 2404 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[581]} 0 0
[junit4:junit4]   2> 2406 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[582]} 0 1
[junit4:junit4]   2> 2408 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[582]} 0 1
[junit4:junit4]   2> 2410 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[583]} 0 1
[junit4:junit4]   2> 2412 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[583]} 0 1
[junit4:junit4]   2> 2414 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[584]} 0 0
[junit4:junit4]   2> 2416 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[584]} 0 0
[junit4:junit4]   2> 2419 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[585]} 0 1
[junit4:junit4]   2> 2422 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[585]} 0 1
[junit4:junit4]   2> 2424 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[586]} 0 1
[junit4:junit4]   2> 2426 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[586]} 0 0
[junit4:junit4]   2> 2437 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[587]} 0 9
[junit4:junit4]   2> 2442 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[587]} 0 2
[junit4:junit4]   2> 2445 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[588]} 0 1
[junit4:junit4]   2> 2448 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[588]} 0 1
[junit4:junit4]   2> 2451 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[589]} 0 1
[junit4:junit4]   2> 2453 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[589]} 0 0
[junit4:junit4]   2> 2455 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[590]} 0 0
[junit4:junit4]   2> 2458 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[590]} 0 1
[junit4:junit4]   2> 2460 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[591]} 0 0
[junit4:junit4]   2> 2463 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[591]} 0 1
[junit4:junit4]   2> 2465 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[592]} 0 0
[junit4:junit4]   2> 2468 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[592]} 0 1
[junit4:junit4]   2> 2470 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[593]} 0 1
[junit4:junit4]   2> 2472 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[593]} 0 0
[junit4:junit4]   2> 2474 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[594]} 0 0
[junit4:junit4]   2> 2476 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[594]} 0 0
[junit4:junit4]   2> 2479 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[595]} 0 1
[junit4:junit4]   2> 2481 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[595]} 0 0
[junit4:junit4]   2> 2483 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[596]} 0 0
[junit4:junit4]   2> 2485 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[596]} 0 0
[junit4:junit4]   2> 2488 T1921 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[597]} 0 1
[junit4:junit4]   2> 2491 T1935 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[597]} 0 1
[junit4:junit4]   2> 2493 T1923 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[598]} 0 0
[junit4:junit4]   2> 2496 T1933 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[598]} 0 1
[junit4:junit4]   2> 2498 T1922 C185 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[599]} 0 1
[junit4:junit4]   2> 2500 T1932 C186 UPDATE [collection1] webapp=/_wv path=/update params={version=2&wt=javabin} {add=[599]} 0 1
[junit4:junit4]   2> 2502 T1924 C185 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 2506 T1924 C185 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1288e67 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1bf6449)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1288e67 lockFactory=org.apache.lucene.store.NativeFSLockFactory@1bf6449)),segFN=segments_3,generation=3,filenames=[_g.fdt, _g.fdx, _j_Lucene41_0.pos, _j.si, _h_nrm.cfe, _j_nrm.cfs, _i_Lucene41_0.tip, _h.fdx, _g_Lucene41_0.pos, _i_nrm.cfs, _g_Lucene41_0.doc, _g_Lucene41_0.tip, _j_Lucene41_0.doc, _g_Lucene41_0.tim, _i_Lucene41_0.doc, _i_Lucene41_0.tim, _h.si, _j.fdt, _j_nrm.cfe, _j.fdx, _i.fdt, _j.fnm, _h.fdt, _g_nrm.cfs, _j_Lucene41_0.tim, _h.fnm, _i_Lucene41_0.pos, _i.fdx, _h_nrm.cfs, _h_Lucene41_0.pos, _j_Lucene41_0.tip, _g.fnm, _i.si, _i_nrm.cfe, segments_3, _i.fnm, _g_nrm.cfe, _g.si, _h_Lucene41_0.doc, _h_Lucene41_0.tip, _h_Lucene41_0.tim]
[junit4:junit4]   2> 2506 T1924 C185 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_g.fdt, _g.fdx, _j_Lucene41_0.pos, _j.si, _h_nrm.cfe, _j_nrm.cfs, _i_Lucene41_0.tip, _h.fdx, _g_Lucene41_0.pos, _i_nrm.cfs, _g_Lucene41_0.doc, _g_Lucene41_0.tip, _j_Lucene41_0.doc, _g_Lucene41_0.tim, _i_Lucene41_0.doc, _i_Lucene41_0.tim, _h.si, _j.fdt, _j_nrm.cfe, _j.fdx, _i.fdt, _j.fnm, _h.fdt, _g_nrm.cfs, _j_Lucene41_0.tim, _h.fnm, _i_Lucene41_0.pos, _i.fdx, _h_nrm.cfs, _h_Lucene41_0.pos, _j_Lucene41_0.tip, _g.fnm, _i.si, _i_nrm.cfe, segments_3, _i.fnm, _g_nrm.cfe, _g.si, _h_Lucene41_0.doc, _h_Lucene41_0.tip, _h_Lucene41_0.tim]
[junit4:junit4]   2> 2507 T1924 C185 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data
[junit4:junit4]   2> 2510 T1924 C185 oass.SolrIndexSearcher.<init> Opening Searcher@1b99e5d main
[junit4:junit4]   2> 2511 T1924 C185 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 2512 T1926 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b99e5d main{StandardDirectoryReader(segments_3:42 _h(4.1):C150 _g(4.1):C10 _i(4.1):C10 _j(4.1):C2)}
[junit4:junit4]   2> 2513 T1926 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index
[junit4:junit4]   2> 2513 T1924 C185 UPDATE [collection1] webapp=/_wv path=/update params={softCommit=false&version=2&commit=true&wt=javabin&waitSearcher=true} {commit=} 0 11
[junit4:junit4]   2> 2515 T1934 C186 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 2518 T1934 C186 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1394978 lockFactory=org.apache.lucene.store.NativeFSLockFactory@10c28fd)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@1394978 lockFactory=org.apache.lucene.store.NativeFSLockFactory@10c28fd)),segFN=segments_3,generation=3,filenames=[_g.fdt, _g.fdx, _j_Lucene41_0.pos, _j.si, _h_nrm.cfe, _j_nrm.cfs, _i_Lucene41_0.tip, _h.fdx, _g_Lucene41_0.pos, _i_nrm.cfs, _g_Lucene41_0.doc, _g_Lucene41_0.tip, _j_Lucene41_0.doc, _g_Lucene41_0.tim, _i_Lucene41_0.doc, _i_Lucene41_0.tim, _h.si, _j.fdt, _j_nrm.cfe, _j.fdx, _i.fdt, _j.fnm, _h.fdt, _g_nrm.cfs, _j_Lucene41_0.tim, _h.fnm, _i_Lucene41_0.pos, _i.fdx, _h_nrm.cfs, _h_Lucene41_0.pos, _j_Lucene41_0.tip, _g.fnm, _i.si, _i_nrm.cfe, segments_3, _i.fnm, _g_nrm.cfe, _g.si, _h_Lucene41_0.doc, _h_Lucene41_0.tip, _h_Lucene41_0.tim]
[junit4:junit4]   2> 2519 T1934 C186 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_g.fdt, _g.fdx, _j_Lucene41_0.pos, _j.si, _h_nrm.cfe, _j_nrm.cfs, _i_Lucene41_0.tip, _h.fdx, _g_Lucene41_0.pos, _i_nrm.cfs, _g_Lucene41_0.doc, _g_Lucene41_0.tip, _j_Lucene41_0.doc, _g_Lucene41_0.tim, _i_Lucene41_0.doc, _i_Lucene41_0.tim, _h.si, _j.fdt, _j_nrm.cfe, _j.fdx, _i.fdt, _j.fnm, _h.fdt, _g_nrm.cfs, _j_Lucene41_0.tim, _h.fnm, _i_Lucene41_0.pos, _i.fdx, _h_nrm.cfs, _h_Lucene41_0.pos, _j_Lucene41_0.tip, _g.fnm, _i.si, _i_nrm.cfe, segments_3, _i.fnm, _g_nrm.cfe, _g.si, _h_Lucene41_0.doc, _h_Lucene41_0.tip, _h_Lucene41_0.tim]
[junit4:junit4]   2> 2519 T1934 C186 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data
[junit4:junit4]   2> 2523 T1934 C186 oass.SolrIndexSearcher.<init> Opening Searcher@3ece3a main
[junit4:junit4]   2> 2523 T1934 C186 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 2524 T1937 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3ece3a main{StandardDirectoryReader(segments_3:42 _h(4.1):C150 _g(4.1):C10 _i(4.1):C10 _j(4.1):C2)}
[junit4:junit4]   2> 2525 T1937 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index
[junit4:junit4]   2> 2525 T1934 C186 UPDATE [collection1] webapp=/_wv path=/update params={softCommit=false&version=2&commit=true&wt=javabin&waitSearcher=true} {commit=} 0 10
[junit4:junit4]   2> 2528 T1921 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&distrib=false&group=true} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2534 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836573620&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2541 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573620&wt=javabin&distrib=false} status=0 QTime=2 
[junit4:junit4]   2> 2547 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&group.field=a_si&fl=id,a_si,id&version=2&ids=12,11,14,16,15,18,17,19,100,101,102,103,104,105,20,21,500,502,501,23,22,508,507,509,504,503,506,505,8,9,4,5,6,7,1,10,2,3&group.limit=10&rows=100&NOW=1355836573620&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2550 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&group=true&shards=[ff01::114]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv} status=0 QTime=18 
[junit4:junit4]   2> 2553 T1923 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=id+asc,+_docid_+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&distrib=false&group=true} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2558 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=id+asc,+_docid_+asc&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836573644&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2562 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=id+asc,+_docid_+asc&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573644&wt=javabin&distrib=false} status=0 QTime=2 
[junit4:junit4]   2> 2566 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&group.field=a_si&fl=id,a_si,id&version=2&ids=8,9,2,3,10,1,6,7,4,5,23,22,502,501,500,506,505,504,503,509,508,507,105,103,104,101,102,100,20,21,18,17,16,15,14,12,11,19&group.limit=10&rows=100&NOW=1355836573644&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2567 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=id+asc,+_docid_+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&group=true&shards=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv} status=0 QTime=11 
[junit4:junit4]   2> 2570 T1922 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort={!func}add(a_si,5)+asc,+id+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&distrib=false&group=true} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2575 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort={!func}add(a_si,5)+asc,+id+asc&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836573660&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2578 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort={!func}add(a_si,5)+asc,+id+asc&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573660&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2582 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&group.field=a_si&fl=id,a_si,id&version=2&ids=4,5,6,7,10,1,2,3,8,9,508,507,509,504,503,506,505,500,502,501,23,22,20,21,100,101,102,103,104,105,19,12,11,14,16,15,18,17&group.limit=10&rows=100&NOW=1355836573660&wt=javabin&distrib=false} status=0 QTime=2 
[junit4:junit4]   2> 2582 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort={!func}add(a_si,5)+asc,+id+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&group=true&shards=[ff01::213]:33332/_wv|127.0.0.1:45766/_wv} status=0 QTime=10 
[junit4:junit4]   2> 2586 T1924 C185 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> 2586 T1924 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=true&fl=id,a_si&group=true&version=2&group.limit=10&rows=100&wt=javabin&distrib=false} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2591 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=false&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836573678&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2595 T1933 C186 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> 2596 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&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&facet.field=a_t&group.field=a_si&facet=true&fl=id&group=true&start=0&version=2&group.distributed.second=true&f.a_t.facet.limit=160&group.limit=10&rows=100&NOW=1355836573678&wt=javabin&distrib=false} status=0 QTime=2 
[junit4:junit4]   2> 2599 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&facet.field=a_t&group.field=a_si&facet=false&fl=id,a_si,id&version=2&ids=105,103,104,101,102,100,20,21,18,17,16,15,14,12,11,19,8,9,2,3,1,10,6,7,4,5,23,22,502,501,500,506,505,504,503,509,508,507&group.limit=10&rows=100&NOW=1355836573678&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2600 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&facet.field=a_t&group.field=a_si&facet=true&fl=id,a_si&group=true&shards=127.0.0.1:45766/_wv&version=2&group.limit=10&rows=100&wt=javabin} status=0 QTime=10 
[junit4:junit4]   2> 2604 T1921 C185 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=other_tl1,memSize=5027,tindexSize=51,time=1,phase1=1,nTerms=18,bigTerms=0,termInstances=18,uses=0}
[junit4:junit4]   2> 2606 T1921 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&stats.field=other_tl1&group.field=a_si&fl=id,a_si&group=true&version=2&group.limit=10&rows=100&wt=javabin&stats=true&distrib=false} hits=172 status=0 QTime=2 
[junit4:junit4]   2> 2611 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::114]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&stats.field=other_tl1&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836573697&wt=javabin&stats=false&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2615 T1934 C186 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> 2615 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::114]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&stats.field=other_tl1&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573697&wt=javabin&stats=true&distrib=false} status=0 QTime=2 
[junit4:junit4]   2> 2619 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::114]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&stats.field=other_tl1&group.field=a_si&fl=id,a_si,id&version=2&ids=23,22,500,502,501,504,503,506,505,508,507,509,8,9,1,10,2,3,4,5,6,7,16,15,18,17,12,11,14,19,103,104,105,100,101,102,20,21&group.limit=10&rows=100&NOW=1355836573697&wt=javabin&stats=false&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2620 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&stats.field=other_tl1&group.field=a_si&fl=id,a_si&group=true&shards=127.0.0.1:45766/_wv|[ff01::114]:33332/_wv|[ff01::213]:33332/_wv&version=2&group.limit=10&rows=100&wt=javabin&stats=true} status=0 QTime=11 
[junit4:junit4]   2> 2643 T1923 C185 REQ [collection1] webapp=/_wv path=/select params={q=kings&sort=a_si+asc,+id+asc&qt=spellCheckCompRH&group.field=a_si&fl=id,a_si&group=true&version=2&group.limit=10&rows=100&spellcheck=true&wt=javabin&spellcheck.build=true&distrib=false} hits=1 status=0 QTime=20 
[junit4:junit4]   2> 2664 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=kings&sort=a_si+asc,+id+asc&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&spellcheck.extendedResults=false&version=2&spellcheck.onlyMorePopular=false&group.limit=10&rows=100&spellcheck=false&NOW=1355836573733&wt=javabin&spellcheck.build=true&distrib=false&spellcheck.count=1} status=0 QTime=1 
[junit4:junit4]   2> 2666 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=kings&sort=a_si+asc,+id+asc&group.topgroups.a_si=876&group.field=a_si&fl=id&group=true&start=0&spellcheck.extendedResults=false&version=2&group.distributed.second=true&spellcheck.onlyMorePopular=false&group.limit=10&rows=100&spellcheck=true&NOW=1355836573733&wt=javabin&spellcheck.build=true&distrib=false&spellcheck.count=5} status=0 QTime=0 
[junit4:junit4]   2> 2668 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=kings&group.field=a_si&fl=id,a_si,id&spellcheck.extendedResults=false&version=2&ids=8&spellcheck.onlyMorePopular=false&group.limit=10&rows=100&spellcheck=false&NOW=1355836573733&wt=javabin&spellcheck.build=true&distrib=false&spellcheck.count=1} status=0 QTime=0 
[junit4:junit4]   2> 2669 T1933 C186 oashc.SpellCheckComponent.finishStage 127.0.0.1:45766/_wv null
[junit4:junit4]   2> 2669 T1933 C186 oashc.SpellCheckComponent.finishStage 127.0.0.1:45766/_wv null
[junit4:junit4]   2> 2670 T1933 C186 oashc.SpellCheckComponent.finishStage 127.0.0.1:45766/_wv null
[junit4:junit4]   2> 2670 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={q=kings&sort=a_si+asc,+id+asc&qt=spellCheckCompRH&group.field=a_si&fl=id,a_si&group=true&shards=127.0.0.1:45766/_wv&version=2&group.limit=10&rows=100&spellcheck=true&wt=javabin&spellcheck.build=true} status=0 QTime=25 
[junit4:junit4]   2> 2678 T1924 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&facet=true&fl=id,a_si&hl.fl=a_t&group=true&hl=true&version=2&group.limit=10&rows=100&wt=javabin&distrib=false} hits=172 status=0 QTime=6 
[junit4:junit4]   2> 2682 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&facet=false&fl=id&group.distributed.first=true&hl.fl=a_t&group=true&hl=false&start=0&version=2&group.limit=10&rows=100&NOW=1355836573768&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2685 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&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&group.field=a_si&facet=true&fl=id&hl.fl=a_t&group=true&hl=false&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573768&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2693 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&group.field=a_si&facet=false&fl=id,a_si,id&hl.fl=a_t&hl=true&version=2&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&group.limit=10&rows=100&NOW=1355836573768&wt=javabin&distrib=false} status=0 QTime=5 
[junit4:junit4]   2> 2695 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&facet=true&fl=id,a_si&hl.fl=a_t&group=true&hl=true&shards=127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&version=2&group.limit=10&rows=100&wt=javabin} status=0 QTime=15 
[junit4:junit4]   2> 2698 T1921 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&distrib=false&group=true&group.sort=id+desc} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2702 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836573788&wt=javabin&distrib=false&group.sort=id+desc} status=0 QTime=0 
[junit4:junit4]   2> 2705 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573788&wt=javabin&distrib=false&group.sort=id+desc} status=0 QTime=1 
[junit4:junit4]   2> 2709 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&group.field=a_si&fl=id,a_si,id&version=2&ids=145,597,146,596,143,595,144,594,149,147,599,148,598,22,23,1,10,3,2,5,4,7,6,9,8,142,592,141,593,140,590,591,19,18,11,12,21,20&group.limit=10&rows=100&NOW=1355836573788&wt=javabin&distrib=false&group.sort=id+desc} status=0 QTime=1 
[junit4:junit4]   2> 2711 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&group=true&group.sort=id+desc&shards=127.0.0.1:45766/_wv} status=0 QTime=11 
[junit4:junit4]   2> 2714 T1922 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id,a_si&group.limit=5&rows=100&wt=javabin&distrib=false&group=true} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2718 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv|[ff01::213]:33332/_wv|[ff01::114]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=5&rows=100&NOW=1355836573804&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2722 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv|[ff01::213]:33332/_wv|[ff01::114]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.offset=5&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=5&rows=100&NOW=1355836573804&wt=javabin&distrib=false} status=0 QTime=2 
[junit4:junit4]   2> 2725 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv|[ff01::213]:33332/_wv|[ff01::114]:33332/_wv&isShard=true&q=*:*&group.offset=5&group.field=a_si&fl=id,a_si,id&version=2&ids=507,508,509,505,506,102,101,104,103,105&group.limit=5&rows=100&NOW=1355836573804&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2726 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id,a_si&group.limit=5&rows=100&wt=javabin&group=true&shards=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv|[ff01::213]:33332/_wv|[ff01::114]:33332/_wv} status=0 QTime=10 
[junit4:junit4]   2> 2729 T1923 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id,a_si&group=true&version=2&group.limit=5&rows=100&rows=5&offset=5&wt=javabin&distrib=false} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2733 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::083]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=5&rows=100&offset=5&NOW=1355836573819&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2736 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::083]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.offset=5&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=5&rows=100&offset=5&NOW=1355836573819&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2739 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::083]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&group.offset=5&group.field=a_si&fl=id,a_si,id&version=2&ids=505,506,509,507,508,105,104,103,102,101&group.limit=5&rows=100&rows=5&offset=5&NOW=1355836573819&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2740 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id,a_si&group=true&shards=127.0.0.1:45766/_wv|[ff01::083]:33332/_wv|[ff01::213]:33332/_wv&version=2&group.limit=5&rows=100&rows=5&offset=5&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 2742 T1924 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&rows=100&rows=5&offset=5&group.format=simple&wt=javabin&distrib=false&group=true} hits=172 status=0 QTime=0 
[junit4:junit4]   2> 2746 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&rows=100&offset=5&group.format=simple&NOW=1355836573833&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2749 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&rows=100&offset=5&group.format=simple&NOW=1355836573833&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2753 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&group.field=a_si&fl=id,a_si,id&version=2&ids=11,500,12,14,18,23,5,4,7,6,10,1,3,2,9,8&rows=100&rows=5&offset=5&group.format=simple&NOW=1355836573833&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2754 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&rows=100&rows=5&offset=5&group.format=simple&wt=javabin&group=true&shards=[ff01::083]:33332/_wv|[ff01::213]:33332/_wv|127.0.0.1:45766/_wv} status=0 QTime=9 
[junit4:junit4]   2> 2756 T1921 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&rows=100&rows=5&offset=5&wt=javabin&group.main=true&distrib=false&group=true} hits=172 status=0 QTime=0 
[junit4:junit4]   2> 2760 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id&group.main=true&group.distributed.first=true&group=true&start=0&version=2&rows=100&offset=5&NOW=1355836573846&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2763 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&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&group.field=a_si&fl=id&group.main=true&group=true&start=0&version=2&group.distributed.second=true&rows=100&offset=5&NOW=1355836573846&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2766 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&group.field=a_si&fl=id,a_si,id&group.main=true&version=2&ids=7,6,5,4,3,2,10,1,9,8,14,11,500,12,18,23&rows=100&rows=5&offset=5&NOW=1355836573846&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2767 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.field=a_si&fl=id,a_si&rows=100&rows=5&offset=5&wt=javabin&group.main=true&group=true&shards=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv} status=0 QTime=9 
[junit4:junit4]   2> 2769 T1922 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id,a_si&group=true&version=2&group.limit=5&rows=100&rows=5&offset=5&group.format=simple&wt=javabin&distrib=false} hits=172 status=0 QTime=0 
[junit4:junit4]   2> 2773 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=5&rows=100&offset=5&group.format=simple&NOW=1355836573859&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2776 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=5&rows=100&offset=5&group.format=simple&NOW=1355836573859&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2779 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv&isShard=true&q=*:*&group.offset=5&group.field=a_si&fl=id,a_si,id&version=2&ids=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,100&group.limit=5&rows=100&rows=5&offset=5&group.format=simple&NOW=1355836573859&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2780 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id,a_si&group=true&shards=127.0.0.1:45766/_wv&version=2&group.limit=5&rows=100&rows=5&offset=5&group.format=simple&wt=javabin} status=0 QTime=9 
[junit4:junit4]   2> 2783 T1923 C185 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id,a_si&group.main=true&group=true&version=2&group.limit=5&rows=100&rows=5&offset=5&wt=javabin&distrib=false} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2787 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id&group.main=true&group.distributed.first=true&group=true&start=0&version=2&group.limit=5&rows=100&offset=5&NOW=1355836573873&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2790 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&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&group.field=a_si&fl=id&group.main=true&group=true&start=0&version=2&group.distributed.second=true&group.limit=5&rows=100&offset=5&NOW=1355836573873&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2793 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv|[ff01::213]:33332/_wv&isShard=true&q=*:*&group.offset=5&group.field=a_si&fl=id,a_si,id&group.main=true&version=2&ids=17,18,15,16,14,11,12,19,100,21,20,22,23,501,502,500,503,504,9,8,3,2,1,10,7,6,5,4&group.limit=5&rows=100&rows=5&offset=5&NOW=1355836573873&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2793 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={q=*:*&sort=a_si+asc,+id+asc&group.offset=5&group.field=a_si&fl=id,a_si&group.main=true&group=true&shards=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv|[ff01::213]:33332/_wv&version=2&group.limit=5&rows=100&rows=5&offset=5&wt=javabin} status=0 QTime=8 
[junit4:junit4]   2> 2796 T1924 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&fl=id,a_si&group.limit=10&rows=100&wt=javabin&distrib=false&group=true} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2804 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::213]:33332/_wv|[ff01::114]:33332/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573886&wt=javabin&distrib=false} status=0 QTime=4 
[junit4:junit4]   2> 2807 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=127.0.0.1:45766/_wv|[ff01::213]:33332/_wv|[ff01::114]:33332/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&group.query=a_t:kings+OR+a_t:eggs&fl=id,a_si,id&version=2&ids=20,21,19,8,23,18,22&group.limit=10&rows=100&NOW=1355836573886&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2807 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&fl=id,a_si&group.limit=10&rows=100&wt=javabin&group=true&shards=127.0.0.1:45766/_wv|[ff01::213]:33332/_wv|[ff01::114]:33332/_wv|[ff01::083]:33332/_wv} status=0 QTime=9 
[junit4:junit4]   2> 2810 T1921 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&distrib=false&group=true} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2814 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&group.field=a_si&fl=id&group.distributed.first=true&group=true&start=0&version=2&group.limit=10&rows=100&NOW=1355836573901&wt=javabin&distrib=false} status=0 QTime=0 
[junit4:junit4]   2> 2818 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&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&group.field=a_si&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573901&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2822 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv&isShard=true&q=*:*&group.query=a_t:kings+OR+a_t:eggs&group.field=a_si&fl=id,a_si,id&version=2&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&group.limit=10&rows=100&NOW=1355836573901&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2823 T1934 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&group.field=a_si&fl=id,a_si&group.limit=10&rows=100&wt=javabin&group=true&shards=[ff01::114]:33332/_wv|127.0.0.1:45766/_wv|[ff01::083]:33332/_wv} status=0 QTime=10 
[junit4:junit4]   2> 2826 T1923 C185 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&fl=id,a_si&group.limit=10&rows=100&wt=javabin&distrib=false&group=true} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 2830 T1933 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&fl=id&group=true&start=0&version=2&group.distributed.second=true&group.limit=10&rows=100&NOW=1355836573916&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2833 T1932 C186 REQ [collection1] webapp=/_wv path=/select params={shard.url=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv&isShard=true&q=*:*&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&fl=id,a_si,id&version=2&ids=23,18,22,8,19,5,20,21&group.limit=10&rows=100&NOW=1355836573916&wt=javabin&distrib=false} status=0 QTime=1 
[junit4:junit4]   2> 2834 T1935 C186 REQ [collection1] webapp=/_wv path=/select params={version=2&q=*:*&sort=a_si+asc,+id+asc&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&fl=id,a_si&group.limit=10&rows=100&wt=javabin&group=true&shards=[ff01::083]:33332/_wv|127.0.0.1:45766/_wv} status=0 QTime=6 
[junit4:junit4]   2> 2834 T1915 oas.BaseDistributedSearchTestCase.compareResponses SEVERE Mismatched responses:
[junit4:junit4]   2> 	{responseHeader={status=0,QTime=6},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=1},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> 2856 T1915 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=5841273
[junit4:junit4]   2> 2857 T1915 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@ff199e
[junit4:junit4]   2> 2865 T1915 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> 2865 T1915 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 2866 T1915 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 2866 T1915 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 2868 T1915 C185 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index
[junit4:junit4]   2> 2868 T1915 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 2869 T1915 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index
[junit4:junit4]   2> 2869 T1915 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data/index
[junit4:junit4]   2> 2870 T1915 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/control/data
[junit4:junit4]   2> 2870 T1915 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/_wv,null}
[junit4:junit4]   2> 2943 T1915 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=16157560
[junit4:junit4]   2> 2944 T1915 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1e34d73
[junit4:junit4]   2> 2956 T1915 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> 2958 T1915 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 2959 T1915 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 2960 T1915 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 2961 T1915 C186 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index
[junit4:junit4]   2> 2962 T1915 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 2962 T1915 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index
[junit4:junit4]   2> 2963 T1915 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data/index
[junit4:junit4]   2> 2963 T1915 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J0/./org.apache.solr.TestDistributedGrouping-1355836571093/shard0/data
[junit4:junit4]   2> 2964 T1915 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/_wv,null}
[junit4:junit4]   2> 3021 T1915 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedGrouping -Dtests.method=testDistribSearch -Dtests.seed=5FE7096DADF4B9C9 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_SA -Dtests.timezone=US/Alaska -Dtests.file.encoding=UTF-8
[junit4:junit4] FAILURE 3.03s J0 | 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([5FE7096DADF4B9C9:DE018775DAABD9F5]: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> 3034 T1915 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=396)), sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=ar_SA, timezone=US/Alaska
[junit4:junit4]   2> NOTE: Linux 3.2.0-35-generic i386/Oracle Corporation 1.8.0-ea (32-bit)/cpus=8,threads=1,free=87888416,total=515899392
[junit4:junit4]   2> NOTE: All tests run in this JVM: [DateFieldTest, AlternateDirectoryTest, TestReload, SampleTest, TestIBSimilarityFactory, TestFastLRUCache, UpdateRequestProcessorFactoryTest, TestLazyCores, TestSolrQueryParser, LoggingHandlerTest, TestGroupingSearch, UniqFieldsUpdateProcessorFactoryTest, PreAnalyzedFieldTest, SuggesterFSTTest, JsonLoaderTest, DistributedSpellCheckComponentTest, TestCollationField, TermsComponentTest, TestWordDelimiterFilterFactory, TestBadConfig, FieldAnalysisRequestHandlerTest, CollectionsAPIDistributedZkTest, CoreAdminHandlerTest, SolrCoreCheckLockOnStartupTest, StatelessScriptUpdateProcessorFactoryTest, CircularListTest, SpellCheckCollatorTest, TestNumberUtils, ZkCLITest, DistributedTermsComponentTest, TestRandomFaceting, MBeansHandlerTest, MinimalSchemaTest, SortByFunctionTest, TestConfig, TestSearchPerf, TestRangeQuery, CopyFieldTest, TestCoreContainer, TestFaceting, TestQueryTypes, TestJmxMonitoredMap, TestExtendedDismaxParser, TestSuggestSpellingConverter, RequestHandlersTest, TestPHPSerializedResponseWriter, TestCharFilters, ResourceLoaderTest, AutoCommitTest, TestLMJelinekMercerSimilarityFactory, SpellPossibilityIteratorTest, TestSolrJ, NumericFieldsTest, SuggesterWFSTTest, ResponseLogComponentTest, TestLFUCache, CSVRequestHandlerTest, TestSystemIdResolver, TestDefaultSimilarityFactory, ScriptEngineTest, SpellCheckComponentTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, LeaderElectionIntegrationTest, LeaderElectionTest, ZkControllerTest, TestDistributedGrouping]
[junit4:junit4] Completed on J0 in 3.06s, 1 test, 1 failure <<< FAILURES!

[...truncated 356 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: 31 minutes 1 second
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 32bit/jdk1.8.0-ea-b65 -client -XX:+UseG1GC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message