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 (64bit/jdk1.8.0-ea-b65) - Build # 3263 - Failure!
Date Mon, 17 Dec 2012 09:25:57 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/3263/
Java: 64bit/jdk1.8.0-ea-b65 -XX:+UseConcMarkSweepGC

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([ACE867A1416E6BC7:2D0EE9B936310BFB]: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 8732 lines...]
[junit4:junit4] Suite: org.apache.solr.TestDistributedGrouping
[junit4:junit4]   2> 0 T457 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4:junit4]   2> 3 T457 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4]   2> 5 T457 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 10 T457 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:39699
[junit4:junit4]   2> 11 T457 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 12 T457 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> 12 T457 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> 30 T457 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 30 T457 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 31 T457 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> 31 T457 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> 31 T457 oasc.CoreContainer.<init> New CoreContainer 508936546
[junit4:junit4]   2> 32 T457 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> 32 T457 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> 49 T457 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4]   2> 50 T457 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 50 T457 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 51 T457 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 51 T457 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 52 T457 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 52 T457 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 52 T457 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 53 T457 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 53 T457 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4]   2> 62 T457 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 79 T467 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> 79 T467 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 T467 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> 80 T467 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> 118 T467 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 183 T467 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 183 T467 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 188 T467 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 503 T467 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 508 T467 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 510 T467 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 513 T467 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 516 T467 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 518 T467 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 519 T467 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 520 T467 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-1355735738671/control/data/
[junit4:junit4]   2> 520 T467 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c260051
[junit4:junit4]   2> 520 T467 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 521 T467 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data forceNew:false
[junit4:junit4]   2> 521 T467 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data
[junit4:junit4]   2> 521 T467 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index/
[junit4:junit4]   2> 521 T467 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 522 T467 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index forceNew:false
[junit4:junit4]   2> 523 T467 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@210b4858 lockFactory=org.apache.lucene.store.NativeFSLockFactory@27ebc1f7)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 523 T467 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 523 T467 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index
[junit4:junit4]   2> 524 T467 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 526 T467 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 526 T467 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 527 T467 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 527 T467 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 528 T467 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 528 T467 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 528 T467 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 529 T467 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 530 T467 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 530 T467 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 531 T467 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 532 T467 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 532 T467 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 533 T467 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 533 T467 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 533 T467 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 534 T467 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 534 T467 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 535 T467 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 535 T467 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 536 T467 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 537 T467 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 537 T467 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 538 T467 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 539 T467 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 539 T467 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 541 T467 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 543 T467 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 544 T467 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA-REQUIRED-FIELDS.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, FUZZYSUGGEST.TXT, SCHEMA-SPATIAL.XML, SCHEMA-REPLICATION1.XML, SOLRCONFIG-NATIVELOCK.XML, STOPWITHBOM.TXT, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, BAD_SOLRCONFIG.XML, SCHEMA-COLLATE.XML, SCHEMA-REPLICATION2.XML, SCHEMA-MINIMAL.XML, BAD-MP-SOLRCONFIG.XML, XSLT, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SOLRCONFIG-DELPOLICY1.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-SIMPLELOCK.XML, PROTWORDS.TXT, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SOLRCONFIG-LAZYWRITER.XML, STOPTYPES-1.TXT, ELEVATE.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SCHEMA-BINARYFIELD.XML, SCHEMA-NUMERIC.XML, SOLRCONFIG-ENABLEPLUGIN.XML, SCHEMA.XML, SOLRCONFIG-NOCACHE.XML, FRENCHARTICLES.TXT, STOPWORDS.TXT, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, STOPTYPES-2.TXT, HUNSPELL-TEST.AFF, SCHEMA-COPYFIELD-TEST.XML, SCHEMA-IB.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SCHEMA11.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SCHEMA_CODEC.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SYNONYMS.TXT, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-SOLR-749.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-SLAVE1.XML, HUNSPELL-TEST.DIC, SCHEMA-LMJELINEKMERCER.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, DA_UTF8.XML, OPEN-EXCHANGE-RATES.JSON, OLD_SYNONYMS.TXT, SCHEMA-SNIPPET-FIELD.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SCHEMA-TFIDF.XML, SCHEMA-EFF.XML, SOLRCONFIG-MASTER3.XML, SOLRCONFIG-MERGEPOLICY.XML, SOLRCONFIG-INDEXCONFIG.XML, SOLRCONFIG-TRANSFORMERS.XML, SCHEMA15.XML, SCHEMA-STOP-KEEP.XML, SCHEMA-FOLDING.XML, SCHEMA-SIM.XML, JASUGGEST.TXT, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, STEMDICT.TXT, SOLRCONFIG-SNIPPET-PROCESSOR.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-CHARFILTERS.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SOLRCONFIG-DELPOLICY2.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, MAPPING-ISOLATIN1ACCENT.TXT, SCHEMA-XINCLUDE.XML, STOPWORDSWRONGENCODING.TXT, CURRENCY.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-QUERYSENDER.XML, SCHEMASURROUND.XML, KEEP-1.TXT, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, STOP-1.TXT, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, SOLRCONFIG-ELEVATE.XML, KEEP-2.TXT, SOLRCONFIG-ALTDIRECTORY.XML, COMPOUNDDICTIONARY.TXT, STOP-2.TXT, WDFTYPES.TXT, SOLRCONFIG-SLAVE.XML, SOLRCONFIG_PERF.XML, SOLRCONFIG-MASTER1.XML, STOP-SNOWBALL.TXT, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA-DFR.XML, HYPHENATION.DTD, SOLRCONFIG-MASTER.XML, SOLRCONFIG-MASTER2.XML, SCHEMA-BM25.XML, SOLRCONFIG-BASIC.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SCHEMA-TRIE.XML, SOLRCONFIG-XINCLUDE.XML, PHRASESUGGEST.TXT, SCHEMA12.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-PHRASESUGGEST.XML, CONDITIONAL.UPDATEPROCESSOR.JS, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG_CODEC.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, SCHEMA-SNIPPET-TYPE.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA-REVERSED.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-PROPINJECT.XML, DA_COMPOUNDDICTIONARY.TXT, SOLRCONFIG-TERMINDEX.XML, SCHEMA-LUCENEMATCHVERSION.XML, SOLRCONFIG-CACHING.XML, TRIVIAL.UPDATEPROCESSOR0.JS]
[junit4:junit4]   2> 545 T467 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data
[junit4:junit4]   2> 546 T467 oass.SolrIndexSearcher.<init> Opening Searcher@2d1e946f main
[junit4:junit4]   2> 546 T467 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 546 T467 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 547 T467 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 557 T467 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 596 T468 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2d1e946f main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 598 T467 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 598 T457 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 598 T457 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 599 T457 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> 602 T457 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4]   2> 604 T457 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:41111
[junit4:junit4]   2> 605 T457 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 605 T457 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> 605 T457 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> 617 T457 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4]   2> 618 T457 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 618 T457 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> 618 T457 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> 619 T457 oasc.CoreContainer.<init> New CoreContainer 264699753
[junit4:junit4]   2> 619 T457 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> 619 T457 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> 630 T457 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4]   2> 631 T457 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 631 T457 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4]   2> 631 T457 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 632 T457 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 632 T457 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 632 T457 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 632 T457 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 633 T457 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 633 T457 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4]   2> 645 T457 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 656 T478 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> 657 T478 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> 657 T478 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> 657 T478 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> 681 T478 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4]   2> 721 T478 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 721 T478 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 724 T478 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 1079 T478 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 1084 T478 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 1086 T478 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 1089 T478 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1092 T478 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 1093 T478 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1094 T478 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 1094 T478 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-1355735738671/shard0/data/
[junit4:junit4]   2> 1094 T478 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6c260051
[junit4:junit4]   2> 1095 T478 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 1095 T478 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data forceNew:false
[junit4:junit4]   2> 1096 T478 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data
[junit4:junit4]   2> 1096 T478 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index/
[junit4:junit4]   2> 1096 T478 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 1096 T478 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index forceNew:false
[junit4:junit4]   2> 1098 T478 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@10b0df53 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2aaf1672)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1098 T478 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 1098 T478 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index
[junit4:junit4]   2> 1098 T478 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 1099 T478 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 1100 T478 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 1100 T478 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 1100 T478 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 1100 T478 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 1101 T478 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 1101 T478 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 1101 T478 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 1102 T478 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 1102 T478 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 1103 T478 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 1103 T478 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 1104 T478 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 1104 T478 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 1104 T478 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 1105 T478 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 1106 T478 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1106 T478 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1107 T478 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1108 T478 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1108 T478 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1109 T478 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1110 T478 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1110 T478 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 1111 T478 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 1112 T478 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 1115 T478 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 1117 T478 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 1118 T478 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA-REQUIRED-FIELDS.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, FUZZYSUGGEST.TXT, SCHEMA-SPATIAL.XML, SCHEMA-REPLICATION1.XML, SOLRCONFIG-NATIVELOCK.XML, STOPWITHBOM.TXT, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, BAD_SOLRCONFIG.XML, SCHEMA-COLLATE.XML, SCHEMA-REPLICATION2.XML, SCHEMA-MINIMAL.XML, BAD-MP-SOLRCONFIG.XML, XSLT, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SOLRCONFIG-DELPOLICY1.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, SOLRCONFIG-SIMPLELOCK.XML, PROTWORDS.TXT, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SOLRCONFIG-LAZYWRITER.XML, STOPTYPES-1.TXT, ELEVATE.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SCHEMA-BINARYFIELD.XML, SCHEMA-NUMERIC.XML, SOLRCONFIG-ENABLEPLUGIN.XML, SCHEMA.XML, SOLRCONFIG-NOCACHE.XML, FRENCHARTICLES.TXT, STOPWORDS.TXT, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, STOPTYPES-2.TXT, HUNSPELL-TEST.AFF, SCHEMA-COPYFIELD-TEST.XML, SCHEMA-IB.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SCHEMA11.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SCHEMA_CODEC.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SYNONYMS.TXT, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SOLRCONFIG-SOLR-749.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-SLAVE1.XML, HUNSPELL-TEST.DIC, SCHEMA-LMJELINEKMERCER.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, DA_UTF8.XML, OPEN-EXCHANGE-RATES.JSON, OLD_SYNONYMS.TXT, SCHEMA-SNIPPET-FIELD.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SCHEMA-TFIDF.XML, SCHEMA-EFF.XML, SOLRCONFIG-MASTER3.XML, SOLRCONFIG-MERGEPOLICY.XML, SOLRCONFIG-INDEXCONFIG.XML, SOLRCONFIG-TRANSFORMERS.XML, SCHEMA15.XML, SCHEMA-STOP-KEEP.XML, SCHEMA-FOLDING.XML, SCHEMA-SIM.XML, JASUGGEST.TXT, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, STEMDICT.TXT, SOLRCONFIG-SNIPPET-PROCESSOR.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-CHARFILTERS.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SOLRCONFIG-DELPOLICY2.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, MAPPING-ISOLATIN1ACCENT.TXT, SCHEMA-XINCLUDE.XML, STOPWORDSWRONGENCODING.TXT, CURRENCY.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-QUERYSENDER.XML, SCHEMASURROUND.XML, KEEP-1.TXT, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, STOP-1.TXT, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, SOLRCONFIG-ELEVATE.XML, KEEP-2.TXT, SOLRCONFIG-ALTDIRECTORY.XML, COMPOUNDDICTIONARY.TXT, STOP-2.TXT, WDFTYPES.TXT, SOLRCONFIG-SLAVE.XML, SOLRCONFIG_PERF.XML, SOLRCONFIG-MASTER1.XML, STOP-SNOWBALL.TXT, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA-DFR.XML, HYPHENATION.DTD, SOLRCONFIG-MASTER.XML, SOLRCONFIG-MASTER2.XML, SCHEMA-BM25.XML, SOLRCONFIG-BASIC.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SCHEMA-TRIE.XML, SOLRCONFIG-XINCLUDE.XML, PHRASESUGGEST.TXT, SCHEMA12.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-PHRASESUGGEST.XML, CONDITIONAL.UPDATEPROCESSOR.JS, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG_CODEC.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, SCHEMA-SNIPPET-TYPE.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SCHEMA-REVERSED.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-PROPINJECT.XML, DA_COMPOUNDDICTIONARY.TXT, SOLRCONFIG-TERMINDEX.XML, SCHEMA-LUCENEMATCHVERSION.XML, SOLRCONFIG-CACHING.XML, TRIVIAL.UPDATEPROCESSOR0.JS]
[junit4:junit4]   2> 1120 T478 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data
[junit4:junit4]   2> 1120 T478 oass.SolrIndexSearcher.<init> Opening Searcher@4fd98fd8 main
[junit4:junit4]   2> 1121 T478 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 1121 T478 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 1121 T478 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 1137 T478 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 1159 T479 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4fd98fd8 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 1162 T478 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 1163 T457 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4]   2> 1163 T457 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4]   2> 1164 T457 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   2> ASYNC  NEW_CORE C38 name=collection1 org.apache.solr.core.SolrCore@3ada96a2
[junit4:junit4]   2> 1175 T463 C38 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 1176 T463 C38 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data
[junit4:junit4]   2> 1178 T463 C38 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@210b4858 lockFactory=org.apache.lucene.store.NativeFSLockFactory@27ebc1f7)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1178 T463 C38 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 1179 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 4
[junit4:junit4]   2> ASYNC  NEW_CORE C39 name=collection1 org.apache.solr.core.SolrCore@175e137b
[junit4:junit4]   2> 1185 T476 C39 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4]   2> 1185 T476 C39 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data
[junit4:junit4]   2> 1187 T476 C39 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@10b0df53 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2aaf1672)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 1187 T476 C39 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 1188 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 3
[junit4:junit4]   2> 1192 T464 C38 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1193 T464 C38 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@210b4858 lockFactory=org.apache.lucene.store.NativeFSLockFactory@27ebc1f7)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@210b4858 lockFactory=org.apache.lucene.store.NativeFSLockFactory@27ebc1f7)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 1193 T464 C38 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4]   2> 1194 T464 C38 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data
[junit4:junit4]   2> 1194 T464 C38 oass.SolrIndexSearcher.<init> Opening Searcher@319edff2 main
[junit4:junit4]   2> 1195 T464 C38 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1196 T468 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@319edff2 main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 1196 T468 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index
[junit4:junit4]   2> 1196 T464 C38 UPDATE [collection1] webapp= path=/update params={commit=true&softCommit=false&waitSearcher=true&wt=javabin&version=2} {commit=} 0 4
[junit4:junit4]   2> 1201 T477 C39 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 1202 T477 C39 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@10b0df53 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2aaf1672)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@10b0df53 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2aaf1672)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 1202 T477 C39 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4]   2> 1202 T477 C39 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data
[junit4:junit4]   2> 1203 T477 C39 oass.SolrIndexSearcher.<init> Opening Searcher@2d3b281f main
[junit4:junit4]   2> 1203 T477 C39 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 1203 T479 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2d3b281f main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4]   2> 1204 T479 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index
[junit4:junit4]   2> 1204 T477 C39 UPDATE [collection1] webapp= path=/update params={commit=true&softCommit=false&waitSearcher=true&wt=javabin&version=2} {commit=} 0 3
[junit4:junit4]   2> 1232 T465 C38 REQ [collection1] webapp= path=/select params={group.limit=10&distrib=false&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=24 
[junit4:junit4]   2> 1256 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735739906&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=12 
[junit4:junit4]   2> 1275 T475 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=37 
[junit4:junit4]   2> 1280 T463 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&hl.fl=a_t&distrib=false&group=true&hl=true&q=*:*&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1306 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735739953&fl=id&wt=javabin&hl.fl=a_t&distrib=false&start=0&group=true&hl=false&q=*:*&shard.url=127.0.0.1:41111/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 1307 T476 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::213]:33332/&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&hl.fl=a_t&group=true&hl=true&q=*:*&version=2} status=0 QTime=22 
[junit4:junit4]   2> 1310 T464 C38 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> 1311 T464 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&facet.field=a_t&wt=javabin&facet=true&distrib=false&group=true&q=*:*&version=2} hits=0 status=0 QTime=1 
[junit4:junit4]   2> 1318 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735739983&fl=id&facet.field=a_t&wt=javabin&facet=false&distrib=false&start=0&group=true&q=*:*&shard.url=[ff01::114]:33332/|127.0.0.1:41111/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=0 
[junit4:junit4]   2> 1334 T477 C39 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> 1335 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&sort=a_si+asc,+id+asc&NOW=1355735739983&fl=id&facet.field=a_t&wt=javabin&f.a_t.facet.limit=160&facet=true&distrib=false&start=0&group=true&q=*:*&shard.url=[ff01::114]:33332/|127.0.0.1:41111/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=6 
[junit4:junit4]   2> 1340 T474 C39 REQ [collection1] webapp= path=/select params={shards=[ff01::114]:33332/|127.0.0.1:41111/|[ff01::083]:33332/&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&facet.field=a_t&wt=javabin&facet=true&group=true&q=*:*&version=2} status=0 QTime=25 
[junit4:junit4]   2> 1343 T466 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&stats.field=a_si&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&stats=true&distrib=false&group=true&q=*:*&version=2} hits=0 status=0 QTime=0 
[junit4:junit4]   2> 1348 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&stats.field=a_si&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735740014&fl=id&wt=javabin&stats=false&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=0 
[junit4:junit4]   2> 1353 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&stats.field=a_si&group.field=a_si&group.distributed.second=true&sort=a_si+asc,+id+asc&NOW=1355735740014&fl=id&wt=javabin&stats=true&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=0 
[junit4:junit4]   2> 1354 T476 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/&group.limit=10&rows=100&stats.field=a_si&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&stats=true&group=true&q=*:*&version=2} status=0 QTime=8 
[junit4:junit4]   2> 1387 T465 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&qt=spellCheckCompRH&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&distrib=false&spellcheck=true&group=true&spellcheck.build=true&q=kings&version=2} hits=0 status=0 QTime=30 
[junit4:junit4]   2> 1421 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&spellcheck.count=1&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735740059&fl=id&wt=javabin&spellcheck.extendedResults=false&distrib=false&spellcheck=false&start=0&spellcheck.onlyMorePopular=false&group=true&spellcheck.build=true&q=kings&shard.url=[ff01::083]:33332/|127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 1423 T474 C39 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/|127.0.0.1:41111/ null
[junit4:junit4]   2> 1424 T474 C39 REQ [collection1] webapp= path=/select params={shards=[ff01::083]:33332/|127.0.0.1:41111/&group.limit=10&rows=100&qt=spellCheckCompRH&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&spellcheck=true&group=true&spellcheck.build=true&q=kings&version=2} status=0 QTime=33 
[junit4:junit4]   2> 1433 T463 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&facet.field=a_t&fl=id,a_si&fq=a_s:a&wt=javabin&distrib=false&facet=true&group.truncate=true&group=true&q=*:*&version=2} hits=0 status=0 QTime=6 
[junit4:junit4]   2> 1453 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735740104&facet.field=a_t&fl=id&fq=a_s:a&wt=javabin&facet=false&group.truncate=true&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&version=2&isShard=true} status=0 QTime=0 
[junit4:junit4]   2> 1474 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&sort=a_si+asc,+id+asc&NOW=1355735740104&facet.field=a_t&fl=id&fq=a_s:a&wt=javabin&f.a_t.facet.limit=160&facet=true&group.truncate=true&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&version=2&isShard=true} status=0 QTime=18 
[junit4:junit4]   2> 1475 T477 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&facet.field=a_t&fl=id,a_si&fq=a_s:a&wt=javabin&facet=true&group.truncate=true&group=true&q=*:*&version=2} status=0 QTime=39 
[junit4:junit4]   2> 1481 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1]} 0 3
[junit4:junit4]   2> 1487 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[1]} 0 3
[junit4:junit4]   2> 1492 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[2]} 0 2
[junit4:junit4]   2> 1497 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[2]} 0 2
[junit4:junit4]   2> 1501 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[3]} 0 1
[junit4:junit4]   2> 1505 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[3]} 0 1
[junit4:junit4]   2> 1510 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[4]} 0 2
[junit4:junit4]   2> 1514 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[4]} 0 2
[junit4:junit4]   2> 1518 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[5]} 0 1
[junit4:junit4]   2> 1523 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[5]} 0 2
[junit4:junit4]   2> 1528 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[6]} 0 2
[junit4:junit4]   2> 1532 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[6]} 0 1
[junit4:junit4]   2> 1537 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[7]} 0 1
[junit4:junit4]   2> 1542 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[7]} 0 1
[junit4:junit4]   2> 1547 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[8]} 0 1
[junit4:junit4]   2> 1552 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[8]} 0 2
[junit4:junit4]   2> 1567 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[9]} 0 12
[junit4:junit4]   2> 1571 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[9]} 0 1
[junit4:junit4]   2> 1586 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[10]} 0 11
[junit4:junit4]   2> 1597 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[10]} 0 8
[junit4:junit4]   2> 1604 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[11]} 0 3
[junit4:junit4]   2> 1610 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[11]} 0 3
[junit4:junit4]   2> 1614 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[12]} 0 1
[junit4:junit4]   2> 1618 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[12]} 0 1
[junit4:junit4]   2> 1622 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[14]} 0 1
[junit4:junit4]   2> 1626 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[14]} 0 1
[junit4:junit4]   2> 1631 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[15]} 0 1
[junit4:junit4]   2> 1635 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[15]} 0 1
[junit4:junit4]   2> 1639 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[16]} 0 1
[junit4:junit4]   2> 1644 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[16]} 0 2
[junit4:junit4]   2> 1649 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[17]} 0 2
[junit4:junit4]   2> 1654 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[17]} 0 2
[junit4:junit4]   2> 1659 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[18]} 0 1
[junit4:junit4]   2> 1664 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[18]} 0 1
[junit4:junit4]   2> 1671 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[19]} 0 2
[junit4:junit4]   2> 1675 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[19]} 0 1
[junit4:junit4]   2> 1679 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[20]} 0 1
[junit4:junit4]   2> 1684 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[20]} 0 2
[junit4:junit4]   2> 1697 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[21]} 0 10
[junit4:junit4]   2> 1718 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[21]} 0 18
[junit4:junit4]   2> 1723 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[22]} 0 1
[junit4:junit4]   2> 1727 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[22]} 0 1
[junit4:junit4]   2> 1730 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[23]} 0 0
[junit4:junit4]   2> 1734 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[23]} 0 1
[junit4:junit4]   2> 1738 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[100]} 0 1
[junit4:junit4]   2> 1741 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[100]} 0 1
[junit4:junit4]   2> 1745 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[101]} 0 1
[junit4:junit4]   2> 1749 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[101]} 0 1
[junit4:junit4]   2> 1753 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[102]} 0 1
[junit4:junit4]   2> 1756 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[102]} 0 0
[junit4:junit4]   2> 1760 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[103]} 0 1
[junit4:junit4]   2> 1763 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[103]} 0 1
[junit4:junit4]   2> 1766 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[104]} 0 1
[junit4:junit4]   2> 1770 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[104]} 0 1
[junit4:junit4]   2> 1773 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[105]} 0 0
[junit4:junit4]   2> 1777 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[105]} 0 1
[junit4:junit4]   2> 1781 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[106]} 0 1
[junit4:junit4]   2> 1784 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[106]} 0 0
[junit4:junit4]   2> 1796 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[107]} 0 8
[junit4:junit4]   2> 1803 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[107]} 0 4
[junit4:junit4]   2> 1807 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[108]} 0 1
[junit4:junit4]   2> 1811 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[108]} 0 1
[junit4:junit4]   2> 1814 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[109]} 0 0
[junit4:junit4]   2> 1818 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[109]} 0 1
[junit4:junit4]   2> 1821 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[110]} 0 0
[junit4:junit4]   2> 1825 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[110]} 0 1
[junit4:junit4]   2> 1828 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[111]} 0 1
[junit4:junit4]   2> 1831 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[111]} 0 1
[junit4:junit4]   2> 1834 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[112]} 0 0
[junit4:junit4]   2> 1838 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[112]} 0 1
[junit4:junit4]   2> 1841 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[113]} 0 0
[junit4:junit4]   2> 1845 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[113]} 0 1
[junit4:junit4]   2> 1848 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[114]} 0 1
[junit4:junit4]   2> 1851 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[114]} 0 1
[junit4:junit4]   2> 1854 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[115]} 0 1
[junit4:junit4]   2> 1857 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[115]} 0 0
[junit4:junit4]   2> 1860 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4:junit4]   2> 1864 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[116]} 0 1
[junit4:junit4]   2> 1873 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[117]} 0 6
[junit4:junit4]   2> 1879 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[117]} 0 3
[junit4:junit4]   2> 1883 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[118]} 0 1
[junit4:junit4]   2> 1887 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[118]} 0 1
[junit4:junit4]   2> 1891 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[119]} 0 1
[junit4:junit4]   2> 1894 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[119]} 0 1
[junit4:junit4]   2> 1898 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[120]} 0 1
[junit4:junit4]   2> 1901 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[120]} 0 0
[junit4:junit4]   2> 1906 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[121]} 0 1
[junit4:junit4]   2> 1909 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[121]} 0 1
[junit4:junit4]   2> 1912 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[122]} 0 0
[junit4:junit4]   2> 1915 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[122]} 0 0
[junit4:junit4]   2> 1919 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[123]} 0 1
[junit4:junit4]   2> 1922 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[123]} 0 1
[junit4:junit4]   2> 1925 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[124]} 0 0
[junit4:junit4]   2> 1929 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[124]} 0 1
[junit4:junit4]   2> 1933 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[125]} 0 1
[junit4:junit4]   2> 1936 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[125]} 0 1
[junit4:junit4]   2> 1939 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[126]} 0 1
[junit4:junit4]   2> 1943 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[126]} 0 1
[junit4:junit4]   2> 1954 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[127]} 0 8
[junit4:junit4]   2> 1962 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[127]} 0 6
[junit4:junit4]   2> 1966 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[128]} 0 1
[junit4:junit4]   2> 1970 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[128]} 0 1
[junit4:junit4]   2> 1974 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[129]} 0 0
[junit4:junit4]   2> 1978 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[129]} 0 0
[junit4:junit4]   2> 1983 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[130]} 0 1
[junit4:junit4]   2> 1987 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[130]} 0 1
[junit4:junit4]   2> 1991 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[131]} 0 0
[junit4:junit4]   2> 1996 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[131]} 0 1
[junit4:junit4]   2> 2000 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[132]} 0 1
[junit4:junit4]   2> 2005 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[132]} 0 1
[junit4:junit4]   2> 2009 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[133]} 0 1
[junit4:junit4]   2> 2013 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[133]} 0 0
[junit4:junit4]   2> 2017 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[134]} 0 1
[junit4:junit4]   2> 2020 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[134]} 0 0
[junit4:junit4]   2> 2025 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[135]} 0 1
[junit4:junit4]   2> 2028 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[135]} 0 0
[junit4:junit4]   2> 2032 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[136]} 0 1
[junit4:junit4]   2> 2035 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[136]} 0 1
[junit4:junit4]   2> 2042 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[137]} 0 5
[junit4:junit4]   2> 2049 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[137]} 0 4
[junit4:junit4]   2> 2053 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[138]} 0 1
[junit4:junit4]   2> 2056 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[138]} 0 1
[junit4:junit4]   2> 2059 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[139]} 0 0
[junit4:junit4]   2> 2062 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[139]} 0 1
[junit4:junit4]   2> 2065 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[140]} 0 1
[junit4:junit4]   2> 2068 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[140]} 0 0
[junit4:junit4]   2> 2072 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[141]} 0 1
[junit4:junit4]   2> 2075 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[141]} 0 1
[junit4:junit4]   2> 2078 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[142]} 0 1
[junit4:junit4]   2> 2081 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[142]} 0 0
[junit4:junit4]   2> 2088 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[143]} 0 1
[junit4:junit4]   2> 2092 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[143]} 0 1
[junit4:junit4]   2> 2096 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[144]} 0 1
[junit4:junit4]   2> 2099 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[144]} 0 1
[junit4:junit4]   2> 2102 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[145]} 0 1
[junit4:junit4]   2> 2106 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[145]} 0 1
[junit4:junit4]   2> 2109 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[146]} 0 1
[junit4:junit4]   2> 2113 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[146]} 0 1
[junit4:junit4]   2> 2120 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[147]} 0 5
[junit4:junit4]   2> 2129 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[147]} 0 5
[junit4:junit4]   2> 2134 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[148]} 0 1
[junit4:junit4]   2> 2138 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[148]} 0 1
[junit4:junit4]   2> 2142 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[149]} 0 1
[junit4:junit4]   2> 2145 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[149]} 0 0
[junit4:junit4]   2> 2163 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[500]} 0 15
[junit4:junit4]   2> 2166 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[500]} 0 0
[junit4:junit4]   2> 2170 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[501]} 0 1
[junit4:junit4]   2> 2174 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[501]} 0 1
[junit4:junit4]   2> 2177 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[502]} 0 1
[junit4:junit4]   2> 2180 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[502]} 0 0
[junit4:junit4]   2> 2183 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[503]} 0 0
[junit4:junit4]   2> 2186 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[503]} 0 0
[junit4:junit4]   2> 2190 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[504]} 0 1
[junit4:junit4]   2> 2193 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[504]} 0 1
[junit4:junit4]   2> 2197 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[505]} 0 1
[junit4:junit4]   2> 2200 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[505]} 0 0
[junit4:junit4]   2> 2204 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[506]} 0 1
[junit4:junit4]   2> 2207 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[506]} 0 0
[junit4:junit4]   2> 2218 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[507]} 0 8
[junit4:junit4]   2> 2229 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[507]} 0 8
[junit4:junit4]   2> 2233 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[508]} 0 0
[junit4:junit4]   2> 2237 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[508]} 0 1
[junit4:junit4]   2> 2241 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[509]} 0 1
[junit4:junit4]   2> 2244 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[509]} 0 0
[junit4:junit4]   2> 2247 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[510]} 0 0
[junit4:junit4]   2> 2250 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[510]} 0 0
[junit4:junit4]   2> 2253 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[511]} 0 0
[junit4:junit4]   2> 2257 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[511]} 0 1
[junit4:junit4]   2> 2260 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[512]} 0 1
[junit4:junit4]   2> 2263 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[512]} 0 0
[junit4:junit4]   2> 2267 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[513]} 0 0
[junit4:junit4]   2> 2270 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[513]} 0 0
[junit4:junit4]   2> 2274 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[514]} 0 1
[junit4:junit4]   2> 2277 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[514]} 0 1
[junit4:junit4]   2> 2282 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[515]} 0 0
[junit4:junit4]   2> 2286 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[515]} 0 1
[junit4:junit4]   2> 2289 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[516]} 0 0
[junit4:junit4]   2> 2292 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[516]} 0 0
[junit4:junit4]   2> 2302 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[517]} 0 7
[junit4:junit4]   2> 2310 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[517]} 0 5
[junit4:junit4]   2> 2314 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[518]} 0 1
[junit4:junit4]   2> 2317 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[518]} 0 0
[junit4:junit4]   2> 2320 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[519]} 0 0
[junit4:junit4]   2> 2323 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[519]} 0 0
[junit4:junit4]   2> 2327 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[520]} 0 1
[junit4:junit4]   2> 2331 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[520]} 0 1
[junit4:junit4]   2> 2335 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[521]} 0 1
[junit4:junit4]   2> 2339 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[521]} 0 1
[junit4:junit4]   2> 2342 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[522]} 0 0
[junit4:junit4]   2> 2345 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[522]} 0 0
[junit4:junit4]   2> 2349 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[523]} 0 1
[junit4:junit4]   2> 2352 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[523]} 0 0
[junit4:junit4]   2> 2355 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[524]} 0 1
[junit4:junit4]   2> 2360 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[524]} 0 0
[junit4:junit4]   2> 2363 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[525]} 0 1
[junit4:junit4]   2> 2366 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[525]} 0 1
[junit4:junit4]   2> 2369 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[526]} 0 0
[junit4:junit4]   2> 2373 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[526]} 0 1
[junit4:junit4]   2> 2381 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[527]} 0 3
[junit4:junit4]   2> 2387 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[527]} 0 3
[junit4:junit4]   2> 2390 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[528]} 0 1
[junit4:junit4]   2> 2393 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[528]} 0 1
[junit4:junit4]   2> 2396 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[529]} 0 0
[junit4:junit4]   2> 2399 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[529]} 0 1
[junit4:junit4]   2> 2402 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[530]} 0 1
[junit4:junit4]   2> 2404 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[530]} 0 0
[junit4:junit4]   2> 2407 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[531]} 0 0
[junit4:junit4]   2> 2412 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[531]} 0 0
[junit4:junit4]   2> 2415 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[532]} 0 0
[junit4:junit4]   2> 2418 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[532]} 0 1
[junit4:junit4]   2> 2420 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[533]} 0 0
[junit4:junit4]   2> 2423 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[533]} 0 0
[junit4:junit4]   2> 2426 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[534]} 0 0
[junit4:junit4]   2> 2429 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[534]} 0 0
[junit4:junit4]   2> 2432 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[535]} 0 0
[junit4:junit4]   2> 2435 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[535]} 0 0
[junit4:junit4]   2> 2438 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[536]} 0 0
[junit4:junit4]   2> 2441 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[536]} 0 0
[junit4:junit4]   2> 2446 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[537]} 0 3
[junit4:junit4]   2> 2452 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[537]} 0 4
[junit4:junit4]   2> 2455 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[538]} 0 1
[junit4:junit4]   2> 2459 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[538]} 0 1
[junit4:junit4]   2> 2462 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[539]} 0 0
[junit4:junit4]   2> 2465 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[539]} 0 1
[junit4:junit4]   2> 2468 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[540]} 0 1
[junit4:junit4]   2> 2471 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[540]} 0 1
[junit4:junit4]   2> 2473 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[541]} 0 0
[junit4:junit4]   2> 2475 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[541]} 0 0
[junit4:junit4]   2> 2478 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[542]} 0 0
[junit4:junit4]   2> 2481 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[542]} 0 0
[junit4:junit4]   2> 2484 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[543]} 0 0
[junit4:junit4]   2> 2487 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[543]} 0 1
[junit4:junit4]   2> 2490 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[544]} 0 1
[junit4:junit4]   2> 2493 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[544]} 0 1
[junit4:junit4]   2> 2496 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[545]} 0 1
[junit4:junit4]   2> 2499 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[545]} 0 1
[junit4:junit4]   2> 2502 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[546]} 0 1
[junit4:junit4]   2> 2505 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[546]} 0 1
[junit4:junit4]   2> 2518 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[547]} 0 11
[junit4:junit4]   2> 2524 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[547]} 0 3
[junit4:junit4]   2> 2531 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[548]} 0 1
[junit4:junit4]   2> 2535 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[548]} 0 1
[junit4:junit4]   2> 2538 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[549]} 0 1
[junit4:junit4]   2> 2540 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[549]} 0 0
[junit4:junit4]   2> 2543 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[550]} 0 0
[junit4:junit4]   2> 2546 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[550]} 0 0
[junit4:junit4]   2> 2548 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[551]} 0 0
[junit4:junit4]   2> 2551 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[551]} 0 0
[junit4:junit4]   2> 2553 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[552]} 0 0
[junit4:junit4]   2> 2556 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[552]} 0 1
[junit4:junit4]   2> 2558 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[553]} 0 1
[junit4:junit4]   2> 2560 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[553]} 0 0
[junit4:junit4]   2> 2563 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[554]} 0 1
[junit4:junit4]   2> 2565 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[554]} 0 0
[junit4:junit4]   2> 2568 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[555]} 0 1
[junit4:junit4]   2> 2570 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[555]} 0 0
[junit4:junit4]   2> 2573 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[556]} 0 1
[junit4:junit4]   2> 2576 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[556]} 0 1
[junit4:junit4]   2> 2581 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[557]} 0 3
[junit4:junit4]   2> 2586 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[557]} 0 2
[junit4:junit4]   2> 2589 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[558]} 0 1
[junit4:junit4]   2> 2592 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[558]} 0 1
[junit4:junit4]   2> 2595 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[559]} 0 0
[junit4:junit4]   2> 2598 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[559]} 0 0
[junit4:junit4]   2> 2601 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[560]} 0 1
[junit4:junit4]   2> 2606 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[560]} 0 2
[junit4:junit4]   2> 2610 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[561]} 0 1
[junit4:junit4]   2> 2613 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[561]} 0 1
[junit4:junit4]   2> 2615 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[562]} 0 0
[junit4:junit4]   2> 2618 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[562]} 0 0
[junit4:junit4]   2> 2621 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[563]} 0 1
[junit4:junit4]   2> 2623 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[563]} 0 0
[junit4:junit4]   2> 2626 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[564]} 0 1
[junit4:junit4]   2> 2629 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[564]} 0 1
[junit4:junit4]   2> 2632 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[565]} 0 1
[junit4:junit4]   2> 2635 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[565]} 0 0
[junit4:junit4]   2> 2638 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[566]} 0 1
[junit4:junit4]   2> 2641 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[566]} 0 1
[junit4:junit4]   2> 2646 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[567]} 0 3
[junit4:junit4]   2> 2652 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[567]} 0 3
[junit4:junit4]   2> 2655 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[568]} 0 1
[junit4:junit4]   2> 2658 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[568]} 0 1
[junit4:junit4]   2> 2661 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[569]} 0 0
[junit4:junit4]   2> 2665 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[569]} 0 1
[junit4:junit4]   2> 2668 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[570]} 0 0
[junit4:junit4]   2> 2671 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[570]} 0 0
[junit4:junit4]   2> 2674 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[571]} 0 0
[junit4:junit4]   2> 2677 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[571]} 0 0
[junit4:junit4]   2> 2680 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[572]} 0 0
[junit4:junit4]   2> 2684 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[572]} 0 1
[junit4:junit4]   2> 2687 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[573]} 0 1
[junit4:junit4]   2> 2689 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[573]} 0 0
[junit4:junit4]   2> 2692 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[574]} 0 0
[junit4:junit4]   2> 2695 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[574]} 0 0
[junit4:junit4]   2> 2698 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[575]} 0 0
[junit4:junit4]   2> 2701 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[575]} 0 0
[junit4:junit4]   2> 2705 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[576]} 0 1
[junit4:junit4]   2> 2709 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[576]} 0 0
[junit4:junit4]   2> 2714 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[577]} 0 3
[junit4:junit4]   2> 2720 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[577]} 0 3
[junit4:junit4]   2> 2770 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[578]} 0 47
[junit4:junit4]   2> 2773 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[578]} 0 1
[junit4:junit4]   2> 2776 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[579]} 0 0
[junit4:junit4]   2> 2779 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[579]} 0 0
[junit4:junit4]   2> 2782 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[580]} 0 0
[junit4:junit4]   2> 2785 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[580]} 0 0
[junit4:junit4]   2> 2788 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[581]} 0 1
[junit4:junit4]   2> 2790 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[581]} 0 0
[junit4:junit4]   2> 2793 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[582]} 0 0
[junit4:junit4]   2> 2796 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[582]} 0 1
[junit4:junit4]   2> 2798 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[583]} 0 0
[junit4:junit4]   2> 2800 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[583]} 0 0
[junit4:junit4]   2> 2803 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[584]} 0 1
[junit4:junit4]   2> 2805 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[584]} 0 0
[junit4:junit4]   2> 2808 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[585]} 0 1
[junit4:junit4]   2> 2811 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[585]} 0 1
[junit4:junit4]   2> 2814 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[586]} 0 1
[junit4:junit4]   2> 2816 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[586]} 0 0
[junit4:junit4]   2> 2825 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[587]} 0 6
[junit4:junit4]   2> 2830 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[587]} 0 3
[junit4:junit4]   2> 2833 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[588]} 0 0
[junit4:junit4]   2> 2837 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[588]} 0 1
[junit4:junit4]   2> 2840 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[589]} 0 1
[junit4:junit4]   2> 2842 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[589]} 0 0
[junit4:junit4]   2> 2845 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[590]} 0 0
[junit4:junit4]   2> 2848 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[590]} 0 0
[junit4:junit4]   2> 2851 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[591]} 0 0
[junit4:junit4]   2> 2854 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[591]} 0 1
[junit4:junit4]   2> 2857 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[592]} 0 1
[junit4:junit4]   2> 2860 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[592]} 0 1
[junit4:junit4]   2> 2863 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[593]} 0 0
[junit4:junit4]   2> 2866 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[593]} 0 0
[junit4:junit4]   2> 2869 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[594]} 0 1
[junit4:junit4]   2> 2872 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[594]} 0 1
[junit4:junit4]   2> 2874 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[595]} 0 0
[junit4:junit4]   2> 2877 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[595]} 0 1
[junit4:junit4]   2> 2879 T463 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[596]} 0 0
[junit4:junit4]   2> 2882 T476 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[596]} 0 0
[junit4:junit4]   2> 2912 T465 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[597]} 0 27
[junit4:junit4]   2> 2918 T477 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[597]} 0 3
[junit4:junit4]   2> 2922 T466 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[598]} 0 1
[junit4:junit4]   2> 2925 T474 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[598]} 0 0
[junit4:junit4]   2> 2929 T464 C38 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[599]} 0 1
[junit4:junit4]   2> 2932 T475 C39 UPDATE [collection1] webapp= path=/update params={wt=javabin&version=2} {add=[599]} 0 1
[junit4:junit4]   2> 2935 T463 C38 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 2947 T463 C38 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@210b4858 lockFactory=org.apache.lucene.store.NativeFSLockFactory@27ebc1f7)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@210b4858 lockFactory=org.apache.lucene.store.NativeFSLockFactory@27ebc1f7)),segFN=segments_3,generation=3,filenames=[_j_MockFixedIntBlock_0.pos, _g_Pulsing41_0.pos, _h_Pulsing41_0.tim, _g_Pulsing41_0.doc, _j_nrm.cfs, _g_Pulsing41_0.tip, _i_MockFixedIntBlock_0.pyl, _g_MockFixedIntBlock_0.pos, _h_MockRandom_0.sd, _h_MockRandom_0.tim, _g_MockFixedIntBlock_0.skp, _i_MockRandom_0.doc, _i_MockRandom_0.tii, _g_nrm.cfs, _g_MockFixedIntBlock_0.tii, _g_MockFixedIntBlock_0.pyl, _g.fnm, _j_MockRandom_0.tip, _j_MockFixedIntBlock_0.tib, _i.fdt, _h_nrm.cfe, _j_Pulsing41_0.tip, _g_MockRandom_0.sd, _h_MockFixedIntBlock_0.tib, _g.fdx, _j.si, _i_MockRandom_0.tib, _j_MockFixedIntBlock_0.doc, _h_nrm.cfs, _j_MockFixedIntBlock_0.skp, _g_MockRandom_0.doc, _j_Pulsing41_0.pos, _i_MockRandom_0.frq, _g_MockRandom_0.tim, _h_Pulsing41_0.tip, _h_MockFixedIntBlock_0.frq, _h_MockRandom_0.pos, _j_MockRandom_0.pyl, _j.fdx, _j_Pulsing41_0.doc, _h_MockFixedIntBlock_0.doc, _i_MockFixedIntBlock_0.doc, _g_MockRandom_0.tip, _i_Pulsing41_0.tip, _h_MockRandom_0.tip, _h_Pulsing41_0.pos, _h.fdt, _j.fdt, _j_MockRandom_0.tim, _h_MockFixedIntBlock_0.pyl, _i_MockFixedIntBlock_0.tii, _g.fdt, _j_MockRandom_0.skp, _i.fnm, _j_MockRandom_0.doc, _g_MockRandom_0.pyl, _h_SimpleText_0.pst, _j_SimpleText_0.pst, _g.si, _g_Pulsing41_0.tim, _g_MockFixedIntBlock_0.tib, _h.si, _g_MockRandom_0.frq, _i_Pulsing41_0.tim, _i.fdx, _j_MockFixedIntBlock_0.pyl, _i_MockFixedIntBlock_0.tib, _h_Pulsing41_0.doc, _g_SimpleText_0.pst, _i_MockFixedIntBlock_0.skp, _i_MockFixedIntBlock_0.frq, _g_MockFixedIntBlock_0.doc, _i_SimpleText_0.pst, _j_MockRandom_0.pos, _i_Pulsing41_0.pos, _g_MockRandom_0.pos, _h.fdx, segments_3, _i_MockRandom_0.skp, _h.fnm, _i_MockRandom_0.sd, _h_MockFixedIntBlock_0.pos, _g_nrm.cfe, _i_MockRandom_0.pos, _h_MockFixedIntBlock_0.skp, _i_MockRandom_0.pyl, _j_MockFixedIntBlock_0.tii, _i_Pulsing41_0.doc, _g_MockFixedIntBlock_0.frq, _j_Pulsing41_0.tim, _j_nrm.cfe, _i.si, _j_MockFixedIntBlock_0.frq, _j_MockRandom_0.sd, _i_nrm.cfs, _h_MockFixedIntBlock_0.tii, _h_MockRandom_0.doc, _j_MockRandom_0.frq, _i_nrm.cfe, _g_MockRandom_0.skp, _j.fnm, _i_MockFixedIntBlock_0.pos]
[junit4:junit4]   2> 2948 T463 C38 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_j_MockFixedIntBlock_0.pos, _g_Pulsing41_0.pos, _h_Pulsing41_0.tim, _g_Pulsing41_0.doc, _j_nrm.cfs, _g_Pulsing41_0.tip, _i_MockFixedIntBlock_0.pyl, _g_MockFixedIntBlock_0.pos, _h_MockRandom_0.sd, _h_MockRandom_0.tim, _g_MockFixedIntBlock_0.skp, _i_MockRandom_0.doc, _i_MockRandom_0.tii, _g_nrm.cfs, _g_MockFixedIntBlock_0.tii, _g_MockFixedIntBlock_0.pyl, _g.fnm, _j_MockRandom_0.tip, _j_MockFixedIntBlock_0.tib, _i.fdt, _h_nrm.cfe, _j_Pulsing41_0.tip, _g_MockRandom_0.sd, _h_MockFixedIntBlock_0.tib, _g.fdx, _j.si, _i_MockRandom_0.tib, _j_MockFixedIntBlock_0.doc, _h_nrm.cfs, _j_MockFixedIntBlock_0.skp, _g_MockRandom_0.doc, _j_Pulsing41_0.pos, _i_MockRandom_0.frq, _g_MockRandom_0.tim, _h_Pulsing41_0.tip, _h_MockFixedIntBlock_0.frq, _h_MockRandom_0.pos, _j_MockRandom_0.pyl, _j.fdx, _j_Pulsing41_0.doc, _h_MockFixedIntBlock_0.doc, _i_MockFixedIntBlock_0.doc, _g_MockRandom_0.tip, _i_Pulsing41_0.tip, _h_MockRandom_0.tip, _h_Pulsing41_0.pos, _h.fdt, _j.fdt, _j_MockRandom_0.tim, _h_MockFixedIntBlock_0.pyl, _i_MockFixedIntBlock_0.tii, _g.fdt, _j_MockRandom_0.skp, _i.fnm, _j_MockRandom_0.doc, _g_MockRandom_0.pyl, _h_SimpleText_0.pst, _j_SimpleText_0.pst, _g.si, _g_Pulsing41_0.tim, _g_MockFixedIntBlock_0.tib, _h.si, _g_MockRandom_0.frq, _i_Pulsing41_0.tim, _i.fdx, _j_MockFixedIntBlock_0.pyl, _i_MockFixedIntBlock_0.tib, _h_Pulsing41_0.doc, _g_SimpleText_0.pst, _i_MockFixedIntBlock_0.skp, _i_MockFixedIntBlock_0.frq, _g_MockFixedIntBlock_0.doc, _i_SimpleText_0.pst, _j_MockRandom_0.pos, _i_Pulsing41_0.pos, _g_MockRandom_0.pos, _h.fdx, segments_3, _i_MockRandom_0.skp, _h.fnm, _i_MockRandom_0.sd, _h_MockFixedIntBlock_0.pos, _g_nrm.cfe, _i_MockRandom_0.pos, _h_MockFixedIntBlock_0.skp, _i_MockRandom_0.pyl, _j_MockFixedIntBlock_0.tii, _i_Pulsing41_0.doc, _g_MockFixedIntBlock_0.frq, _j_Pulsing41_0.tim, _j_nrm.cfe, _i.si, _j_MockFixedIntBlock_0.frq, _j_MockRandom_0.sd, _i_nrm.cfs, _h_MockFixedIntBlock_0.tii, _h_MockRandom_0.doc, _j_MockRandom_0.frq, _i_nrm.cfe, _g_MockRandom_0.skp, _j.fnm, _i_MockFixedIntBlock_0.pos]
[junit4:junit4]   2> 2949 T463 C38 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data
[junit4:junit4]   2> 2959 T463 C38 oass.SolrIndexSearcher.<init> Opening Searcher@23617e43 main
[junit4:junit4]   2> 2960 T463 C38 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 2967 T468 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@23617e43 main{StandardDirectoryReader(segments_3:42 _h(4.1):C150 _g(4.1):C10 _i(4.1):C10 _j(4.1):C2)}
[junit4:junit4]   2> 2967 T468 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index
[junit4:junit4]   2> 2968 T463 C38 UPDATE [collection1] webapp= path=/update params={commit=true&softCommit=false&waitSearcher=true&wt=javabin&version=2} {commit=} 0 34
[junit4:junit4]   2> 2970 T476 C39 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4]   2> 2980 T476 C39 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@10b0df53 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2aaf1672)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4]   2> 		commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@10b0df53 lockFactory=org.apache.lucene.store.NativeFSLockFactory@2aaf1672)),segFN=segments_3,generation=3,filenames=[_j_MockFixedIntBlock_0.pos, _h_MockRandom_0.pyl, _g_Pulsing41_0.pos, _h_Pulsing41_0.tim, _g_Pulsing41_0.doc, _j_nrm.cfs, _g_Pulsing41_0.tip, _i_MockFixedIntBlock_0.pyl, _g_MockFixedIntBlock_0.pos, _h_MockRandom_0.sd, _h_MockRandom_0.tim, _g_MockFixedIntBlock_0.skp, _i_MockRandom_0.doc, _g_nrm.cfs, _h_MockRandom_0.frq, _g.fnm, _g_MockFixedIntBlock_0.pyl, _g_MockFixedIntBlock_0.tii, _j_MockFixedIntBlock_0.tib, _i.fdt, _h_nrm.cfe, _j_MockRandom_0.tiv, _j_Pulsing41_0.tip, _g_MockRandom_0.sd, _g.fdx, _h_MockFixedIntBlock_0.tib, _j.si, _i_MockRandom_0.tib, _j_MockFixedIntBlock_0.doc, _h_nrm.cfs, _j_MockFixedIntBlock_0.skp, _g_MockRandom_0.doc, _j_Pulsing41_0.pos, _h_Pulsing41_0.tip, _g_MockRandom_0.tim, _h_MockFixedIntBlock_0.frq, _h_MockRandom_0.pos, _j_MockRandom_0.pyl, _j_Pulsing41_0.doc, _j.fdx, _h_MockFixedIntBlock_0.doc, _i_MockFixedIntBlock_0.doc, _g_MockRandom_0.tip, _i_Pulsing41_0.tip, _h_MockRandom_0.tip, _h.fdt, _h_Pulsing41_0.pos, _j.fdt, _h_MockFixedIntBlock_0.pyl, _i_MockFixedIntBlock_0.tii, _g.fdt, _j_MockRandom_0.skp, _i.fnm, _j_MockRandom_0.doc, _g_MockRandom_0.pyl, _h_SimpleText_0.pst, _j_SimpleText_0.pst, _g.si, _g_Pulsing41_0.tim, _j_MockRandom_0.tib, _g_MockFixedIntBlock_0.tib, _h.si, _g_MockRandom_0.frq, _i_Pulsing41_0.tim, _i.fdx, _j_MockFixedIntBlock_0.pyl, _i_MockFixedIntBlock_0.tib, _h_Pulsing41_0.doc, _h_MockRandom_0.skp, _g_SimpleText_0.pst, _i_MockFixedIntBlock_0.skp, _i_MockFixedIntBlock_0.frq, _g_MockFixedIntBlock_0.doc, _i_MockRandom_0.tiv, _i_SimpleText_0.pst, _j_MockRandom_0.pos, _i_Pulsing41_0.pos, _g_MockRandom_0.pos, _h.fdx, segments_3, _h.fnm, _i_MockRandom_0.sd, _h_MockFixedIntBlock_0.pos, _g_nrm.cfe, _i_MockRandom_0.pos, _h_MockFixedIntBlock_0.skp, _j_MockFixedIntBlock_0.tii, _i_Pulsing41_0.doc, _g_MockFixedIntBlock_0.frq, _j_nrm.cfe, _j_Pulsing41_0.tim, _i.si, _j_MockFixedIntBlock_0.frq, _j_MockRandom_0.sd, _i_nrm.cfs, _j_MockRandom_0.frq, _h_MockFixedIntBlock_0.tii, _h_MockRandom_0.doc, _i_nrm.cfe, _g_MockRandom_0.skp, _j.fnm, _i_MockFixedIntBlock_0.pos]
[junit4:junit4]   2> 2981 T476 C39 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_j_MockFixedIntBlock_0.pos, _h_MockRandom_0.pyl, _g_Pulsing41_0.pos, _h_Pulsing41_0.tim, _g_Pulsing41_0.doc, _j_nrm.cfs, _g_Pulsing41_0.tip, _i_MockFixedIntBlock_0.pyl, _g_MockFixedIntBlock_0.pos, _h_MockRandom_0.sd, _h_MockRandom_0.tim, _g_MockFixedIntBlock_0.skp, _i_MockRandom_0.doc, _g_nrm.cfs, _h_MockRandom_0.frq, _g.fnm, _g_MockFixedIntBlock_0.pyl, _g_MockFixedIntBlock_0.tii, _j_MockFixedIntBlock_0.tib, _i.fdt, _h_nrm.cfe, _j_MockRandom_0.tiv, _j_Pulsing41_0.tip, _g_MockRandom_0.sd, _g.fdx, _h_MockFixedIntBlock_0.tib, _j.si, _i_MockRandom_0.tib, _j_MockFixedIntBlock_0.doc, _h_nrm.cfs, _j_MockFixedIntBlock_0.skp, _g_MockRandom_0.doc, _j_Pulsing41_0.pos, _h_Pulsing41_0.tip, _g_MockRandom_0.tim, _h_MockFixedIntBlock_0.frq, _h_MockRandom_0.pos, _j_MockRandom_0.pyl, _j_Pulsing41_0.doc, _j.fdx, _h_MockFixedIntBlock_0.doc, _i_MockFixedIntBlock_0.doc, _g_MockRandom_0.tip, _i_Pulsing41_0.tip, _h_MockRandom_0.tip, _h.fdt, _h_Pulsing41_0.pos, _j.fdt, _h_MockFixedIntBlock_0.pyl, _i_MockFixedIntBlock_0.tii, _g.fdt, _j_MockRandom_0.skp, _i.fnm, _j_MockRandom_0.doc, _g_MockRandom_0.pyl, _h_SimpleText_0.pst, _j_SimpleText_0.pst, _g.si, _g_Pulsing41_0.tim, _j_MockRandom_0.tib, _g_MockFixedIntBlock_0.tib, _h.si, _g_MockRandom_0.frq, _i_Pulsing41_0.tim, _i.fdx, _j_MockFixedIntBlock_0.pyl, _i_MockFixedIntBlock_0.tib, _h_Pulsing41_0.doc, _h_MockRandom_0.skp, _g_SimpleText_0.pst, _i_MockFixedIntBlock_0.skp, _i_MockFixedIntBlock_0.frq, _g_MockFixedIntBlock_0.doc, _i_MockRandom_0.tiv, _i_SimpleText_0.pst, _j_MockRandom_0.pos, _i_Pulsing41_0.pos, _g_MockRandom_0.pos, _h.fdx, segments_3, _h.fnm, _i_MockRandom_0.sd, _h_MockFixedIntBlock_0.pos, _g_nrm.cfe, _i_MockRandom_0.pos, _h_MockFixedIntBlock_0.skp, _j_MockFixedIntBlock_0.tii, _i_Pulsing41_0.doc, _g_MockFixedIntBlock_0.frq, _j_nrm.cfe, _j_Pulsing41_0.tim, _i.si, _j_MockFixedIntBlock_0.frq, _j_MockRandom_0.sd, _i_nrm.cfs, _j_MockRandom_0.frq, _h_MockFixedIntBlock_0.tii, _h_MockRandom_0.doc, _i_nrm.cfe, _g_MockRandom_0.skp, _j.fnm, _i_MockFixedIntBlock_0.pos]
[junit4:junit4]   2> 2982 T476 C39 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data
[junit4:junit4]   2> 2987 T476 C39 oass.SolrIndexSearcher.<init> Opening Searcher@295a1997 main
[junit4:junit4]   2> 2987 T476 C39 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4]   2> 2989 T479 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@295a1997 main{StandardDirectoryReader(segments_3:42 _g(4.1):C150 _h(4.1):C10 _i(4.1):C10 _j(4.1):C2)}
[junit4:junit4]   2> 2989 T479 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index
[junit4:junit4]   2> 2989 T476 C39 UPDATE [collection1] webapp= path=/update params={commit=true&softCommit=false&waitSearcher=true&wt=javabin&version=2} {commit=} 0 19
[junit4:junit4]   2> 3013 T465 C38 REQ [collection1] webapp= path=/select params={distrib=false&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=21 
[junit4:junit4]   2> 3026 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735741689&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=3 
[junit4:junit4]   2> 3038 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&NOW=1355735741689&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=6 
[junit4:junit4]   2> 3049 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&ids=5,4,7,6,1,10,3,2,9,8,507,508,509,503,504,505,506,500,501,502,22,23,21,20,100,102,101,104,103,105,19,11,12,14,15,16,17,18&NOW=1355735741689&fl=id,a_si,id&wt=javabin&distrib=false&q=*:*&shard.url=127.0.0.1:41111/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=4 
[junit4:junit4]   2> 3055 T477 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::083]:33332/&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=34 
[junit4:junit4]   2> 3060 T466 C38 REQ [collection1] webapp= path=/select params={distrib=false&group.limit=10&rows=100&group.field=a_si&sort=id+asc,+_docid_+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=2 
[junit4:junit4]   2> 3066 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=id+asc,+_docid_+asc&NOW=1355735741731&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3077 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&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&sort=id+asc,+_docid_+asc&NOW=1355735741731&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=8 
[junit4:junit4]   2> 3085 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&ids=20,21,103,104,105,100,101,102,19,16,15,18,17,12,11,14,10,1,2,3,4,5,6,7,8,9,504,503,506,505,508,507,509,23,22,500,502,501&NOW=1355735741731&fl=id,a_si,id&wt=javabin&distrib=false&q=*:*&shard.url=127.0.0.1:41111/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=4 
[junit4:junit4]   2> 3086 T476 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::213]:33332/&group.limit=10&rows=100&group.field=a_si&sort=id+asc,+_docid_+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=23 
[junit4:junit4]   2> 3096 T464 C38 REQ [collection1] webapp= path=/select params={distrib=false&group.limit=10&rows=100&group.field=a_si&sort={!func}add(a_si,5)+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=7 
[junit4:junit4]   2> 3103 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort={!func}add(a_si,5)+asc,+id+asc&NOW=1355735741767&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3111 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&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&sort={!func}add(a_si,5)+asc,+id+asc&NOW=1355735741767&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/&version=2&isShard=true} status=0 QTime=5 
[junit4:junit4]   2> 3117 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&ids=504,503,506,505,508,507,509,23,22,500,502,501,10,1,2,3,4,5,6,7,8,9,19,16,15,18,17,12,11,14,20,21,103,104,105,100,101,102&NOW=1355735741767&fl=id,a_si,id&wt=javabin&distrib=false&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/&version=2&isShard=true} status=0 QTime=2 
[junit4:junit4]   2> 3118 T475 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::114]:33332/&group.limit=10&rows=100&group.field=a_si&sort={!func}add(a_si,5)+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=19 
[junit4:junit4]   2> 3130 T463 C38 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=5158,tindexSize=41,time=6,phase1=6,nTerms=55,bigTerms=1,termInstances=77,uses=0}
[junit4:junit4]   2> 3130 T463 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&facet.field=a_t&wt=javabin&facet=true&distrib=false&group=true&q=*:*&version=2} hits=172 status=0 QTime=9 
[junit4:junit4]   2> 3137 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735741802&fl=id&facet.field=a_t&wt=javabin&facet=false&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&version=2&isShard=true} status=0 QTime=0 
[junit4:junit4]   2> 3146 T476 C39 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> 3146 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&NOW=1355735741802&fl=id&facet.field=a_t&wt=javabin&f.a_t.facet.limit=160&facet=true&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&version=2&isShard=true} status=0 QTime=6 
[junit4:junit4]   2> 3154 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&ids=19,14,12,11,18,17,16,15,20,21,101,102,100,105,103,104,509,508,507,506,505,504,503,502,501,500,23,22,6,7,4,5,2,3,1,10,8,9&NOW=1355735741802&fl=id,a_si,id&facet.field=a_t&wt=javabin&facet=false&distrib=false&q=*:*&shard.url=127.0.0.1:41111/|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&version=2&isShard=true} status=0 QTime=3 
[junit4:junit4]   2> 3155 T477 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::083]:33332/|[ff01::213]:33332/|[ff01::114]:33332/&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&facet.field=a_t&wt=javabin&facet=true&group=true&q=*:*&version=2} status=0 QTime=21 
[junit4:junit4]   2> 3162 T465 C38 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> 3163 T465 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&stats.field=other_tl1&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&stats=true&distrib=false&group=true&q=*:*&version=2} hits=172 status=0 QTime=4 
[junit4:junit4]   2> 3172 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&stats.field=other_tl1&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735741837&fl=id&wt=javabin&stats=false&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3180 T475 C39 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> 3181 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&stats.field=other_tl1&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&NOW=1355735741837&fl=id&wt=javabin&stats=true&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=6 
[junit4:junit4]   2> 3188 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&stats.field=other_tl1&group.field=a_si&ids=5,4,7,6,1,10,3,2,9,8,507,508,509,503,504,505,506,500,501,502,22,23,21,20,100,102,101,104,103,105,19,11,12,14,15,16,17,18&NOW=1355735741837&fl=id,a_si,id&wt=javabin&stats=false&distrib=false&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=3 
[junit4:junit4]   2> 3190 T474 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::083]:33332/|[ff01::213]:33332/&group.limit=10&rows=100&stats.field=other_tl1&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&stats=true&group=true&q=*:*&version=2} status=0 QTime=21 
[junit4:junit4]   2> 3232 T466 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&qt=spellCheckCompRH&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&distrib=false&spellcheck=true&group=true&spellcheck.build=true&q=kings&version=2} hits=1 status=0 QTime=39 
[junit4:junit4]   2> 3256 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&spellcheck.count=1&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735741903&fl=id&wt=javabin&spellcheck.extendedResults=false&distrib=false&spellcheck=false&start=0&spellcheck.onlyMorePopular=false&group=true&spellcheck.build=true&q=kings&shard.url=[ff01::114]:33332/|127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=3 
[junit4:junit4]   2> 3260 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&spellcheck.count=5&group.field=a_si&group.distributed.second=true&group.topgroups.a_si=876&sort=a_si+asc,+id+asc&NOW=1355735741903&fl=id&wt=javabin&spellcheck.extendedResults=false&distrib=false&spellcheck=true&start=0&spellcheck.onlyMorePopular=false&group=true&spellcheck.build=true&q=kings&shard.url=[ff01::114]:33332/|127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3263 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&spellcheck.count=1&group.field=a_si&ids=8&NOW=1355735741903&fl=id,a_si,id&wt=javabin&spellcheck.extendedResults=false&distrib=false&spellcheck=false&spellcheck.onlyMorePopular=false&spellcheck.build=true&q=kings&shard.url=[ff01::114]:33332/|127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3264 T476 C39 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:41111/ null
[junit4:junit4]   2> 3264 T476 C39 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:41111/ null
[junit4:junit4]   2> 3264 T476 C39 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/|127.0.0.1:41111/ null
[junit4:junit4]   2> 3265 T476 C39 REQ [collection1] webapp= path=/select params={shards=[ff01::114]:33332/|127.0.0.1:41111/&group.limit=10&rows=100&qt=spellCheckCompRH&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&spellcheck=true&group=true&spellcheck.build=true&q=kings&version=2} status=0 QTime=30 
[junit4:junit4]   2> 3275 T463 C38 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&hl.fl=a_t&facet=true&distrib=false&group=true&hl=true&q=*:*&version=2} hits=172 status=0 QTime=8 
[junit4:junit4]   2> 3284 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735741949&fl=id&wt=javabin&hl.fl=a_t&facet=false&distrib=false&start=0&group=true&hl=false&q=*:*&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:41111/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3292 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&NOW=1355735741949&fl=id&wt=javabin&hl.fl=a_t&facet=true&distrib=false&start=0&group=true&hl=false&q=*:*&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:41111/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=5 
[junit4:junit4]   2> 3302 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&ids=20,21,103,104,105,100,101,102,19,16,15,18,17,12,11,14,1,10,2,3,4,5,6,7,8,9,504,503,506,505,508,507,509,23,22,500,502,501&NOW=1355735741949&fl=id,a_si,id&wt=javabin&hl.fl=a_t&facet=false&distrib=false&hl=true&q=*:*&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:41111/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=7 
[junit4:junit4]   2> 3303 T475 C39 REQ [collection1] webapp= path=/select params={shards=[ff01::213]:33332/|[ff01::114]:33332/|127.0.0.1:41111/|[ff01::083]:33332/&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&fl=id,a_si&wt=javabin&hl.fl=a_t&facet=true&group=true&hl=true&q=*:*&version=2} status=0 QTime=22 
[junit4:junit4]   2> 3310 T465 C38 REQ [collection1] webapp= path=/select params={distrib=false&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&group.sort=id+desc&version=2} hits=172 status=0 QTime=4 
[junit4:junit4]   2> 3317 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735741982&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&group.sort=id+desc&shard.url=127.0.0.1:41111/|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3322 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&NOW=1355735741982&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&group.sort=id+desc&shard.url=127.0.0.1:41111/|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=3 
[junit4:junit4]   2> 3329 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&ids=19,18,12,11,20,21,146,596,145,597,144,594,143,595,149,148,598,147,599,23,22,1,10,2,3,4,5,6,7,8,9,141,593,142,592,591,140,590&NOW=1355735741982&fl=id,a_si,id&wt=javabin&distrib=false&q=*:*&group.sort=id+desc&shard.url=127.0.0.1:41111/|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=3 
[junit4:junit4]   2> 3332 T477 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/&group.limit=10&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&group.sort=id+desc&version=2} status=0 QTime=18 
[junit4:junit4]   2> 3337 T464 C38 REQ [collection1] webapp= path=/select params={group.offset=5&distrib=false&group.limit=5&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=2 
[junit4:junit4]   2> 3343 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735742008&fl=id&wt=javabin&group.offset=5&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3349 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&NOW=1355735742008&fl=id&wt=javabin&group.offset=5&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=3 
[junit4:junit4]   2> 3354 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.field=a_si&ids=509,508,507,506,505,101,102,105,103,104&NOW=1355735742008&fl=id,a_si,id&wt=javabin&group.offset=5&distrib=false&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3354 T474 C39 REQ [collection1] webapp= path=/select params={group.offset=5&shards=127.0.0.1:41111/&group.limit=5&rows=100&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 3358 T466 C38 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&rows=5&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&fl=id,a_si&wt=javabin&group.offset=5&distrib=false&group=true&q=*:*&version=2} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 3364 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742029&fl=id&wt=javabin&group.offset=5&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3369 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742029&fl=id&wt=javabin&group.offset=5&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=2 
[junit4:junit4]   2> 3373 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&rows=5&group.field=a_si&ids=509,508,507,506,505,101,102,105,103,104&offset=5&NOW=1355735742029&fl=id,a_si,id&wt=javabin&group.offset=5&distrib=false&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3374 T476 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&group.limit=5&rows=100&rows=5&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&fl=id,a_si&wt=javabin&group.offset=5&group=true&q=*:*&version=2} status=0 QTime=13 
[junit4:junit4]   2> 3385 T463 C38 REQ [collection1] webapp= path=/select params={distrib=false&rows=100&rows=5&group.field=a_si&group.format=simple&sort=a_si+asc,+id+asc&group=true&offset=5&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=9 
[junit4:junit4]   2> 3391 T477 C39 REQ [collection1] webapp= path=/select params={rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742055&fl=id&wt=javabin&distrib=false&start=0&group.format=simple&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3395 T474 C39 REQ [collection1] webapp= path=/select params={rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742055&fl=id&wt=javabin&distrib=false&start=0&group.format=simple&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3399 T476 C39 REQ [collection1] webapp= path=/select params={rows=100&rows=5&group.field=a_si&ids=18,23,500,12,11,14,8,9,10,1,2,3,4,5,6,7&offset=5&NOW=1355735742055&fl=id,a_si,id&wt=javabin&distrib=false&group.format=simple&q=*:*&shard.url=127.0.0.1:41111/|[ff01::213]:33332/&version=2&isShard=true} status=0 QTime=0 
[junit4:junit4]   2> 3401 T475 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::213]:33332/&rows=100&rows=5&group.field=a_si&group.format=simple&sort=a_si+asc,+id+asc&group=true&offset=5&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=14 
[junit4:junit4]   2> 3404 T465 C38 REQ [collection1] webapp= path=/select params={distrib=false&rows=100&rows=5&group.main=true&group.field=a_si&sort=a_si+asc,+id+asc&group=true&offset=5&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 3409 T474 C39 REQ [collection1] webapp= path=/select params={rows=100&group.distributed.first=true&group.main=true&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742074&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3414 T476 C39 REQ [collection1] webapp= path=/select params={rows=100&group.main=true&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742074&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=2 
[junit4:junit4]   2> 3418 T475 C39 REQ [collection1] webapp= path=/select params={rows=100&rows=5&group.main=true&group.field=a_si&ids=18,23,14,500,12,11,2,3,10,1,6,7,4,5,8,9&offset=5&NOW=1355735742074&fl=id,a_si,id&wt=javabin&distrib=false&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3419 T477 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/&rows=100&rows=5&group.main=true&group.field=a_si&sort=a_si+asc,+id+asc&group=true&offset=5&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=13 
[junit4:junit4]   2> 3422 T464 C38 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&rows=5&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&fl=id,a_si&wt=javabin&group.offset=5&distrib=false&group.format=simple&group=true&q=*:*&version=2} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 3428 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742093&fl=id&wt=javabin&group.offset=5&distrib=false&start=0&group.format=simple&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3433 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742093&fl=id&wt=javabin&distrib=false&start=0&group.format=simple&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=2 
[junit4:junit4]   2> 3438 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&rows=5&group.field=a_si&ids=21,20,100,19,15,16,17,18,11,12,14,1,10,3,2,5,4,7,6,9,8,503,504,22,23,500,501,502&offset=5&NOW=1355735742093&fl=id,a_si,id&wt=javabin&group.offset=5&distrib=false&group.format=simple&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=2 
[junit4:junit4]   2> 3439 T474 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/&group.limit=5&rows=100&rows=5&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&fl=id,a_si&wt=javabin&group.offset=5&group.format=simple&group=true&q=*:*&version=2} status=0 QTime=14 
[junit4:junit4]   2> 3443 T466 C38 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&rows=5&group.main=true&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&fl=id,a_si&wt=javabin&group.offset=5&distrib=false&group=true&q=*:*&version=2} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 3458 T477 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.distributed.first=true&group.main=true&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742123&fl=id&wt=javabin&group.offset=5&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3463 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&group.main=true&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&offset=5&NOW=1355735742123&fl=id&wt=javabin&distrib=false&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=2 
[junit4:junit4]   2> 3467 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=5&rows=100&rows=5&group.main=true&group.field=a_si&ids=23,22,500,502,501,504,503,8,9,1,10,2,3,4,5,6,7,16,15,18,17,12,11,14,19,100,20,21&offset=5&NOW=1355735742123&fl=id,a_si,id&wt=javabin&group.offset=5&distrib=false&q=*:*&shard.url=127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3469 T476 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/&group.limit=5&rows=100&rows=5&group.main=true&group.field=a_si&sort=a_si+asc,+id+asc&offset=5&fl=id,a_si&wt=javabin&group.offset=5&group=true&q=*:*&version=2} status=0 QTime=14 
[junit4:junit4]   2> 3477 T463 C38 REQ [collection1] webapp= path=/select params={distrib=false&group.limit=10&rows=100&group.query=a_t:kings+OR+a_t:eggs&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=6 
[junit4:junit4]   2> 3489 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.second=true&sort=a_si+asc,+id+asc&NOW=1355735742147&fl=id&wt=javabin&distrib=false&group.query=a_t:kings+OR+a_t:eggs&start=0&group=true&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=7 
[junit4:junit4]   2> 3493 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&ids=20,21,19,8,23,18,22&NOW=1355735742147&fl=id,a_si,id&wt=javabin&distrib=false&group.query=a_t:kings+OR+a_t:eggs&q=*:*&shard.url=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3494 T475 C39 REQ [collection1] webapp= path=/select params={shards=127.0.0.1:41111/|[ff01::114]:33332/|[ff01::213]:33332/|[ff01::083]:33332/&group.limit=10&rows=100&group.query=a_t:kings+OR+a_t:eggs&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=15 
[junit4:junit4]   2> 3498 T465 C38 REQ [collection1] webapp= path=/select params={distrib=false&group.limit=10&rows=100&group.query=a_t:kings+OR+a_t:eggs&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=2 
[junit4:junit4]   2> 3503 T474 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.first=true&group.field=a_si&sort=a_si+asc,+id+asc&NOW=1355735742168&fl=id&wt=javabin&distrib=false&group.query=a_t:kings+OR+a_t:eggs&start=0&group=true&q=*:*&shard.url=[ff01::114]:33332/|127.0.0.1:41111/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3510 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&group.distributed.second=true&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&sort=a_si+asc,+id+asc&NOW=1355735742168&fl=id&wt=javabin&distrib=false&group.query=a_t:kings+OR+a_t:eggs&start=0&group=true&q=*:*&shard.url=[ff01::114]:33332/|127.0.0.1:41111/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=4 
[junit4:junit4]   2> 3515 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.field=a_si&ids=19,14,11,12,17,18,15,16,21,20,102,101,100,105,104,103,509,507,508,505,506,503,504,501,502,500,22,23,7,6,5,4,3,2,1,10,9,8&NOW=1355735742168&fl=id,a_si,id&wt=javabin&distrib=false&group.query=a_t:kings+OR+a_t:eggs&q=*:*&shard.url=[ff01::114]:33332/|127.0.0.1:41111/|[ff01::213]:33332/|[ff01::083]:33332/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3517 T477 C39 REQ [collection1] webapp= path=/select params={shards=[ff01::114]:33332/|127.0.0.1:41111/|[ff01::213]:33332/|[ff01::083]:33332/&group.limit=10&rows=100&group.query=a_t:kings+OR+a_t:eggs&group.field=a_si&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=17 
[junit4:junit4]   2> 3521 T464 C38 REQ [collection1] webapp= path=/select params={distrib=false&group.limit=10&rows=100&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} hits=172 status=0 QTime=1 
[junit4:junit4]   2> 3527 T476 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&group.distributed.second=true&sort=a_si+asc,+id+asc&NOW=1355735742192&fl=id&wt=javabin&distrib=false&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&start=0&group=true&q=*:*&shard.url=[ff01::083]:33332/|127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3531 T475 C39 REQ [collection1] webapp= path=/select params={group.limit=10&rows=100&ids=8,23,18,22,19,5,20,21&NOW=1355735742192&fl=id,a_si,id&wt=javabin&distrib=false&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&q=*:*&shard.url=[ff01::083]:33332/|127.0.0.1:41111/&version=2&isShard=true} status=0 QTime=1 
[junit4:junit4]   2> 3532 T474 C39 REQ [collection1] webapp= path=/select params={shards=[ff01::083]:33332/|127.0.0.1:41111/&group.limit=10&rows=100&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&sort=a_si+asc,+id+asc&group=true&fl=id,a_si&q=*:*&wt=javabin&version=2} status=0 QTime=8 
[junit4:junit4]   2> 3533 T457 oas.BaseDistributedSearchTestCase.compareResponses SEVERE Mismatched responses:
[junit4:junit4]   2> 	{responseHeader={status=0,QTime=8},grouped={id:5={matches=172,doclist={numFound=1,start=0,docs=[SolrDocument{id=5, a_si=500}]}},a_t:kings OR a_t:eggs={matches=172,doclist={numFound=7,start=0,docs=[SolrDocument{id=18, a_si=232}, SolrDocument{id=19, a_si=232}, SolrDocument{id=20, a_si=232}, SolrDocument{id=21, a_si=232}, SolrDocument{id=22, a_si=232}, SolrDocument{id=23, a_si=233}, SolrDocument{id=8, a_si=876}]}}}}
[junit4:junit4]   2> 	{responseHeader={status=0,QTime=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> 3555 T457 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=508936546
[junit4:junit4]   2> 3556 T457 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@3ada96a2
[junit4:junit4]   2> 3562 T457 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> 3563 T457 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 3563 T457 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 3564 T457 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 3565 T457 C38 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index
[junit4:junit4]   2> 3566 T457 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 3566 T457 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index
[junit4:junit4]   2> 3567 T457 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data/index
[junit4:junit4]   2> 3567 T457 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/control/data
[junit4:junit4]   2> 3568 T457 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
[junit4:junit4]   2> 3641 T457 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=264699753
[junit4:junit4]   2> 3642 T457 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@175e137b
[junit4:junit4]   2> 3650 T457 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> 3650 T457 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 3651 T457 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 3651 T457 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 3658 T457 C39 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index
[junit4:junit4]   2> 3659 T457 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 3659 T457 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index
[junit4:junit4]   2> 3660 T457 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data
[junit4:junit4]   2> 3660 T457 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355735738671/shard0/data/index
[junit4:junit4]   2> 3661 T457 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null}
[junit4:junit4]   2> 3721 T457 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestDistributedGrouping -Dtests.method=testDistribSearch -Dtests.seed=ACE867A1416E6BC7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_NI -Dtests.timezone=Africa/Libreville -Dtests.file.encoding=US-ASCII
[junit4:junit4] FAILURE 3.74s J1 | TestDistributedGrouping.testDistribSearch <<<
[junit4:junit4]    > Throwable #1: junit.framework.AssertionFailedError: .grouped.id:5!=a_t:kings OR a_t:eggs (unordered or missing)
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([ACE867A1416E6BC7:2D0EE9B936310BFB]: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> 3742 T457 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene41: {n_f1=PostingsFormat(name=MockRandom), n_l1=MockFixedIntBlock(blockSize=921), foo_b=PostingsFormat(name=SimpleText), range_facet_l=MockFixedIntBlock(blockSize=921), a_s=PostingsFormat(name=SimpleText), intDefault=PostingsFormat(name=MockRandom), text=PostingsFormat(name=SimpleText), id=Pulsing41(freqCutoff=8 minBlockSize=40 maxBlockSize=163), a_t=MockFixedIntBlock(blockSize=921), foo_f=PostingsFormat(name=SimpleText), n_d1=MockFixedIntBlock(blockSize=921), foo_d=Pulsing41(freqCutoff=8 minBlockSize=40 maxBlockSize=163), a_si=PostingsFormat(name=MockRandom), n_ti1=Pulsing41(freqCutoff=8 minBlockSize=40 maxBlockSize=163), multiDefault=MockFixedIntBlock(blockSize=921), n_tdt1=PostingsFormat(name=MockRandom), rnd_b=Pulsing41(freqCutoff=8 minBlockSize=40 maxBlockSize=163), oddField_s=Pulsing41(freqCutoff=8 minBlockSize=40 maxBlockSize=163), n_dt1=PostingsFormat(name=MockRandom), range_facet_si=MockFixedIntBlock(blockSize=921), SubjectTerms_mfacet=PostingsFormat(name=MockRandom), n_tl1=PostingsFormat(name=MockRandom), n_td1=PostingsFormat(name=MockRandom), a_n_tdt=PostingsFormat(name=SimpleText), range_facet_sl=Pulsing41(freqCutoff=8 minBlockSize=40 maxBlockSize=163), b_n_tdt=PostingsFormat(name=MockRandom), n_tf1=MockFixedIntBlock(blockSize=921), timestamp=MockFixedIntBlock(blockSize=921), other_tl1=PostingsFormat(name=MockRandom)}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=es_NI, timezone=Africa/Libreville
[junit4:junit4]   2> NOTE: Linux 3.2.0-34-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=46005168,total=126418944
[junit4:junit4]   2> NOTE: All tests run in this JVM: [StatsComponentTest, OutputWriterTest, ReturnFieldsTest, TestSolrCoreProperties, ZkCLITest, IndexSchemaTest, ZkSolrClientTest, URLClassifyProcessorTest, TestMergePolicyConfig, TestQueryUtils, PingRequestHandlerTest, DisMaxRequestHandlerTest, TestReversedWildcardFilterFactory, TestSolrJ, TestPluginEnable, HighlighterTest, TestBM25SimilarityFactory, TestRecovery, DistributedQueryElevationComponentTest, TestMultiCoreConfBootstrap, IndexReaderFactoryTest, DistributedMLTComponentTest, TestRemoteStreaming, TestCodecSupport, ScriptEngineTest, TestLRUCache, TestHashPartitioner, OpenExchangeRatesOrgProviderTest, TestSurroundQueryParser, PeerSyncTest, SignatureUpdateProcessorFactoryTest, TestDistributedGrouping]
[junit4:junit4] Completed on J1 in 3.77s, 1 test, 1 failure <<< FAILURES!

[...truncated 648 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: 242 suites, 1009 tests, 1 failure, 8 ignored (3 assumptions)

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



Mime
View raw message