You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@sd-datasolutions.de> on 2012/12/19 04:52:45 UTC
[JENKINS] Lucene-Solr-trunk-Linux (32bit/jdk1.8.0-ea-b65) - Build #
3295 - Failure!
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Linux/3295/
Java: 32bit/jdk1.8.0-ea-b65 -server -XX:+UseG1GC
1 tests failed.
REGRESSION: org.apache.solr.TestDistributedGrouping.testDistribSearch
Error Message:
.grouped.id:5!=a_t:kings OR a_t:eggs (unordered or missing)
Stack Trace:
junit.framework.AssertionFailedError: .grouped.id:5!=a_t:kings OR a_t:eggs (unordered or missing)
at __randomizedtesting.SeedInfo.seed([9C6C4FBA7A298174:1D8AC1A20D76E148]: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 9067 lines...]
[junit4:junit4] Suite: org.apache.solr.TestDistributedGrouping
[junit4:junit4] 2> 0 T2615 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /zxo/o
[junit4:junit4] 2> 2 T2615 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4] 2> 4 T2615 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4] 2> 10 T2615 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:56277
[junit4:junit4] 2> 12 T2615 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 12 T2615 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4] 2> 13 T2615 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4] 2> 28 T2615 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 29 T2615 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 30 T2615 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4] 2> 30 T2615 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4] 2> 30 T2615 oasc.CoreContainer.<init> New CoreContainer 22564721
[junit4:junit4] 2> 31 T2615 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4] 2> 31 T2615 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4] 2> 42 T2615 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4] 2> 42 T2615 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 43 T2615 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 43 T2615 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 44 T2615 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 44 T2615 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 44 T2615 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 45 T2615 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 45 T2615 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 46 T2615 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4] 2> 51 T2615 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4] 2> 64 T2625 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4] 2> 65 T2625 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4] 2> 65 T2625 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4] 2> 66 T2625 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 90 T2625 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 144 T2625 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 144 T2625 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 148 T2625 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4] 2> 519 T2625 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 524 T2625 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 527 T2625 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 530 T2625 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 532 T2625 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 534 T2625 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 534 T2625 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 535 T2625 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/
[junit4:junit4] 2> 535 T2625 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@16d7bba
[junit4:junit4] 2> 535 T2625 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 536 T2625 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data forceNew:false
[junit4:junit4] 2> 536 T2625 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data
[junit4:junit4] 2> 536 T2625 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index/
[junit4:junit4] 2> 536 T2625 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index' doesn't exist. Creating new index...
[junit4:junit4] 2> 537 T2625 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index forceNew:false
[junit4:junit4] 2> 542 T2625 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049046tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1aecab9)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 543 T2625 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 543 T2625 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index
[junit4:junit4] 2> 543 T2625 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4] 2> 544 T2625 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 544 T2625 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4] 2> 545 T2625 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 545 T2625 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4] 2> 545 T2625 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 546 T2625 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 546 T2625 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 546 T2625 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 547 T2625 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 547 T2625 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4] 2> 548 T2625 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4] 2> 548 T2625 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 549 T2625 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4] 2> 549 T2625 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4] 2> 549 T2625 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4] 2> 550 T2625 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 550 T2625 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 551 T2625 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 551 T2625 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 552 T2625 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 552 T2625 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 553 T2625 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 554 T2625 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 555 T2625 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 556 T2625 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4] 2> 556 T2625 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 562 T2625 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 565 T2625 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4] 2> 567 T2625 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [TRIVIAL.UPDATEPROCESSOR0.JS, SOLRCONFIG-TERMINDEX.XML, BAD_SOLRCONFIG.XML, SOLRCONFIG-XINCLUDE.XML, SOLRCONFIG-TRANSFORMERS.XML, SCHEMA-STOP-KEEP.XML, SOLRCONFIG-NATIVELOCK.XML, SOLRCONFIG-MASTER2.XML, SCHEMA-EFF.XML, SOLRCONFIG-SLAVE1.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SCHEMA12.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-ELEVATE.XML, SCHEMA-SPATIAL.XML, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA.XML, SCHEMA-PHRASESUGGEST.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, STOPTYPES-1.TXT, STOP-SNOWBALL.TXT, HUNSPELL-TEST.DIC, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SOLRCONFIG-SIMPLELOCK.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA-MINIMAL.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, KEEP-1.TXT, SCHEMA-NUMERIC.XML, SCHEMA-COPYFIELD-TEST.XML, SCHEMA-TFIDF.XML, PHRASESUGGEST.TXT, SCHEMA-SPELLCHECKER.XML, SCHEMA-TRIE.XML, SOLRCONFIG-SLAVE.XML, FUZZYSUGGEST.TXT, SOLRCONFIG-SOLCOREPROPERTIES.XML, TRIVIAL.UPDATEPROCESSOR1.JS, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, BAD-SCHEMA-DUP-FIELDTYPE.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SCHEMA-XINCLUDE.XML, BAD-MP-SOLRCONFIG.XML, HUNSPELL-TEST.AFF, SCHEMA-SNIPPET-FIELD.XML, SCHEMASURROUND.XML, OPEN-EXCHANGE-RATES.JSON, SOLRCONFIG-ALTDIRECTORY.XML, SOLRCONFIG-PHRASESUGGEST.XML, SCHEMA-BM25.XML, SCHEMA-SIM.XML, KEEP-2.TXT, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-IB.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-LAZYWRITER.XML, STOPWORDSWRONGENCODING.TXT, SOLRCONFIG_CODEC.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, XSLT, CONDITIONAL.UPDATEPROCESSOR.JS, SOLRCONFIG-REQHANDLER.INCL, SYNONYMS.TXT, STOPTYPES-2.TXT, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SCHEMA-LMJELINEKMERCER.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA-LUCENEMATCHVERSION.XML, CURRENCY.XML, SOLRCONFIG-MASTER3.XML, WDFTYPES.TXT, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, SCHEMA-DFR.XML, DA_COMPOUNDDICTIONARY.TXT, COMPOUNDDICTIONARY.TXT, SOLRCONFIG-CACHING.XML, SOLRCONFIG-DELPOLICY1.XML, SOLRCONFIG-NOCACHE.XML, SOLRCONFIG-REPEATER.XML, STOP-1.TXT, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-SNIPPET-TYPE.XML, SCHEMA-REQUIRED-FIELDS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SOLRCONFIG-ENABLEPLUGIN.XML, PROTWORDS.TXT, SOLRCONFIG-MASTER.XML, DA_UTF8.XML, SOLRCONFIG-PROPINJECT.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-BEHAVIOR.XML, MAPPING-ISOLATIN1ACCENT.TXT, SOLRCONFIG_PERF.XML, SOLRCONFIG-HIGHLIGHT.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-BINARYFIELD.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, OLD_SYNONYMS.TXT, SOLRCONFIG-MERGEPOLICY.XML, SCHEMA15.XML, STEMDICT.TXT, SCHEMA11.XML, SCHEMA-REPLICATION1.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SCHEMA-FOLDING.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-INDEXCONFIG.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, JASUGGEST.TXT, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, STOP-2.TXT, STOPWORDS.TXT, ELEVATE.XML, FRENCHARTICLES.TXT, SOLRCONFIG-MASTER1.XML, STOPWITHBOM.TXT, SOLRCONFIG-DELPOLICY2.XML, SCHEMA_CODEC.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-TLOG.XML, SCHEMA-COLLATE.XML, SCHEMA-REPLICATION2.XML, SCHEMA-CHARFILTERS.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, SOLRCONFIG-QUERYSENDER.XML, HYPHENATION.DTD, SCHEMA-REVERSED.XML]
[junit4:junit4] 2> 570 T2625 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data
[junit4:junit4] 2> 571 T2625 oass.SolrIndexSearcher.<init> Opening Searcher@17175 main
[junit4:junit4] 2> 571 T2625 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 572 T2625 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 572 T2625 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 594 T2625 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4] 2> 621 T2626 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@17175 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 623 T2625 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 623 T2615 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4] 2> 623 T2615 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 624 T2615 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 627 T2615 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4] 2> 629 T2615 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:40052
[junit4:junit4] 2> 637 T2615 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 638 T2615 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4] 2> 638 T2615 oasc.SolrResourceLoader.<init> new SolrResourceLoader for deduced Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4] 2> 654 T2615 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 655 T2615 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 655 T2615 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4] 2> 656 T2615 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4] 2> 656 T2615 oasc.CoreContainer.<init> New CoreContainer 11860612
[junit4:junit4] 2> 657 T2615 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4] 2> 657 T2615 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4] 2> 670 T2615 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4] 2> 671 T2615 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 671 T2615 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 672 T2615 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 672 T2615 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 673 T2615 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 673 T2615 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 674 T2615 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 674 T2615 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 674 T2615 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4] 2> 679 T2615 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4] 2> 691 T2636 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4] 2> 692 T2636 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4] 2> 693 T2636 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4] 2> 693 T2636 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 730 T2636 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 771 T2636 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 772 T2636 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 775 T2636 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4] 2> 1107 T2636 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 1112 T2636 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 1115 T2636 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1118 T2636 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1121 T2636 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1122 T2636 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1123 T2636 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1123 T2636 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/
[junit4:junit4] 2> 1123 T2636 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@16d7bba
[junit4:junit4] 2> 1124 T2636 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1124 T2636 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data forceNew:false
[junit4:junit4] 2> 1124 T2636 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data
[junit4:junit4] 2> 1125 T2636 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index/
[junit4:junit4] 2> 1125 T2636 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index' doesn't exist. Creating new index...
[junit4:junit4] 2> 1126 T2636 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index forceNew:false
[junit4:junit4] 2> 1131 T2636 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049047tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c43b0a)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 1132 T2636 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 1132 T2636 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index
[junit4:junit4] 2> 1133 T2636 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4] 2> 1134 T2636 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 1135 T2636 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4] 2> 1135 T2636 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 1135 T2636 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4] 2> 1136 T2636 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 1136 T2636 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 1136 T2636 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 1137 T2636 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 1138 T2636 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 1139 T2636 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4] 2> 1139 T2636 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4] 2> 1140 T2636 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 1140 T2636 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4] 2> 1141 T2636 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4] 2> 1141 T2636 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4] 2> 1142 T2636 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 1142 T2636 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1143 T2636 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1144 T2636 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1145 T2636 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1145 T2636 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1146 T2636 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1147 T2636 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1148 T2636 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 1148 T2636 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4] 2> 1149 T2636 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 1153 T2636 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1155 T2636 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4] 2> 1157 T2636 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [TRIVIAL.UPDATEPROCESSOR0.JS, SOLRCONFIG-TERMINDEX.XML, BAD_SOLRCONFIG.XML, SOLRCONFIG-XINCLUDE.XML, SOLRCONFIG-TRANSFORMERS.XML, SCHEMA-STOP-KEEP.XML, SOLRCONFIG-NATIVELOCK.XML, SOLRCONFIG-MASTER2.XML, SCHEMA-EFF.XML, SOLRCONFIG-SLAVE1.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SCHEMA12.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-ELEVATE.XML, SCHEMA-SPATIAL.XML, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-SPELLCHECKER.XML, SCHEMA.XML, SCHEMA-PHRASESUGGEST.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, STOPTYPES-1.TXT, STOP-SNOWBALL.TXT, HUNSPELL-TEST.DIC, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SOLRCONFIG-SIMPLELOCK.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA-MINIMAL.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, KEEP-1.TXT, SCHEMA-NUMERIC.XML, SCHEMA-COPYFIELD-TEST.XML, SCHEMA-TFIDF.XML, PHRASESUGGEST.TXT, SCHEMA-SPELLCHECKER.XML, SCHEMA-TRIE.XML, SOLRCONFIG-SLAVE.XML, FUZZYSUGGEST.TXT, SOLRCONFIG-SOLCOREPROPERTIES.XML, TRIVIAL.UPDATEPROCESSOR1.JS, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, BAD-SCHEMA-DUP-FIELDTYPE.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SCHEMA-XINCLUDE.XML, BAD-MP-SOLRCONFIG.XML, HUNSPELL-TEST.AFF, SCHEMA-SNIPPET-FIELD.XML, SCHEMASURROUND.XML, OPEN-EXCHANGE-RATES.JSON, SOLRCONFIG-ALTDIRECTORY.XML, SOLRCONFIG-PHRASESUGGEST.XML, SCHEMA-BM25.XML, SCHEMA-SIM.XML, KEEP-2.TXT, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-IB.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SOLRCONFIG-LAZYWRITER.XML, STOPWORDSWRONGENCODING.TXT, SOLRCONFIG_CODEC.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, XSLT, CONDITIONAL.UPDATEPROCESSOR.JS, SOLRCONFIG-REQHANDLER.INCL, SYNONYMS.TXT, STOPTYPES-2.TXT, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SCHEMA-LMJELINEKMERCER.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA-LUCENEMATCHVERSION.XML, CURRENCY.XML, SOLRCONFIG-MASTER3.XML, WDFTYPES.TXT, SOLRCONFIG-BASIC.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, SCHEMA-DFR.XML, DA_COMPOUNDDICTIONARY.TXT, COMPOUNDDICTIONARY.TXT, SOLRCONFIG-CACHING.XML, SOLRCONFIG-DELPOLICY1.XML, SOLRCONFIG-NOCACHE.XML, SOLRCONFIG-REPEATER.XML, STOP-1.TXT, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-SNIPPET-TYPE.XML, SCHEMA-REQUIRED-FIELDS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SOLRCONFIG-ENABLEPLUGIN.XML, PROTWORDS.TXT, SOLRCONFIG-MASTER.XML, DA_UTF8.XML, SOLRCONFIG-PROPINJECT.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-BEHAVIOR.XML, MAPPING-ISOLATIN1ACCENT.TXT, SOLRCONFIG_PERF.XML, SOLRCONFIG-HIGHLIGHT.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-BINARYFIELD.XML, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, OLD_SYNONYMS.TXT, SOLRCONFIG-MERGEPOLICY.XML, SCHEMA15.XML, STEMDICT.TXT, SCHEMA11.XML, SCHEMA-REPLICATION1.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, SCHEMA-FOLDING.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-INDEXCONFIG.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, JASUGGEST.TXT, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, STOP-2.TXT, STOPWORDS.TXT, ELEVATE.XML, FRENCHARTICLES.TXT, SOLRCONFIG-MASTER1.XML, STOPWITHBOM.TXT, SOLRCONFIG-DELPOLICY2.XML, SCHEMA_CODEC.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-TLOG.XML, SCHEMA-COLLATE.XML, SCHEMA-REPLICATION2.XML, SCHEMA-CHARFILTERS.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, SOLRCONFIG-QUERYSENDER.XML, HYPHENATION.DTD, SCHEMA-REVERSED.XML]
[junit4:junit4] 2> 1159 T2636 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data
[junit4:junit4] 2> 1160 T2636 oass.SolrIndexSearcher.<init> Opening Searcher@1be0944 main
[junit4:junit4] 2> 1161 T2636 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 1161 T2636 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 1162 T2636 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 1174 T2636 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4] 2> 1226 T2637 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1be0944 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1229 T2636 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 1229 T2615 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4] 2> 1229 T2615 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 1230 T2615 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> ASYNC NEW_CORE C129 name=collection1 org.apache.solr.core.SolrCore@cf2770
[junit4:junit4] 2> 1239 T2624 C129 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4] 2> 1240 T2624 C129 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data
[junit4:junit4] 2> 1241 T2624 C129 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049046tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1aecab9)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 1242 T2624 C129 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 1242 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 4
[junit4:junit4] 2> ASYNC NEW_CORE C130 name=collection1 org.apache.solr.core.SolrCore@16ac2ae
[junit4:junit4] 2> 1247 T2633 C130 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4] 2> 1248 T2633 C130 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data
[junit4:junit4] 2> 1250 T2633 C130 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049047tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c43b0a)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 1250 T2633 C130 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 1251 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {deleteByQuery=*:*} 0 4
[junit4:junit4] 2> 1253 T2621 C129 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 1280 T2621 C129 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049046tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1aecab9)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049046tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1aecab9)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4] 2> 1280 T2621 C129 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4] 2> 1281 T2621 C129 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data
[junit4:junit4] 2> 1282 T2621 C129 oass.SolrIndexSearcher.<init> Opening Searcher@112cc09 main
[junit4:junit4] 2> 1282 T2621 C129 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 1283 T2626 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@112cc09 main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4] 2> 1283 T2626 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index
[junit4:junit4] 2> 1284 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={softCommit=false&waitSearcher=true&wt=javabin&version=2&commit=true} {commit=} 0 31
[junit4:junit4] 2> 1286 T2634 C130 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 1320 T2634 C130 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049047tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c43b0a)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049047tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c43b0a)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4] 2> 1321 T2634 C130 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4] 2> 1325 T2634 C130 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data
[junit4:junit4] 2> 1327 T2634 C130 oass.SolrIndexSearcher.<init> Opening Searcher@1b269fb main
[junit4:junit4] 2> 1327 T2634 C130 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 1328 T2637 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b269fb main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4] 2> 1329 T2637 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index
[junit4:junit4] 2> 1329 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={softCommit=false&waitSearcher=true&wt=javabin&version=2&commit=true} {commit=} 0 43
[junit4:junit4] 2> 1336 T2622 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&distrib=false&group.limit=10&version=2&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=0 status=0 QTime=5
[junit4:junit4] 2> 1385 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shard.url=[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&isShard=true&fl=id&NOW=1355888874917&wt=javabin&rows=100&distrib=false&group.distributed.first=true&start=0&group.limit=10&version=2&sort=a_si+asc,+id+asc&group.field=a_si&q=*:*} status=0 QTime=12
[junit4:junit4] 2> 1402 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.limit=10&version=2&shards=[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=61
[junit4:junit4] 2> 1405 T2623 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&hl.fl=a_t&hl=true&fl=id,a_si&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=0 status=0 QTime=1
[junit4:junit4] 2> 1409 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&hl.fl=a_t&hl=false&shard.url=[ff01::083]:33332/zxo/o|[ff01::114]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id&isShard=true&NOW=1355888874983&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 1409 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&hl.fl=a_t&hl=true&shards=[ff01::083]:33332/zxo/o|[ff01::114]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id,a_si&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 1411 T2624 C129 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> 1412 T2624 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=true&facet.field=a_t&fl=id,a_si&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=0 status=0 QTime=1
[junit4:junit4] 2> 1416 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=false&facet.field=a_t&shard.url=127.0.0.1:40052/zxo/o&fl=id&isShard=true&NOW=1355888874990&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 1424 T2632 C130 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> 1424 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=true&facet.field=a_t&shard.url=127.0.0.1:40052/zxo/o&fl=id&isShard=true&NOW=1355888874990&wt=javabin&rows=100&f.a_t.facet.limit=160&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=5
[junit4:junit4] 2> 1427 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=true&facet.field=a_t&shards=127.0.0.1:40052/zxo/o&fl=id,a_si&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=13
[junit4:junit4] 2> 1429 T2621 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&stats.field=a_si&fl=id,a_si&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&stats=true&q=*:*&group.field=a_si} hits=0 status=0 QTime=0
[junit4:junit4] 2> 1433 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&stats.field=a_si&shard.url=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888875007&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&stats=false&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 1435 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&stats.field=a_si&shard.url=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888875007&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&stats=true&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 1435 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&stats.field=a_si&shards=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&stats=true&q=*:*&group.field=a_si} status=0 QTime=4
[junit4:junit4] 2> 1474 T2622 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&spellcheck.build=true&fl=id,a_si&qt=spellCheckCompRH&spellcheck=true&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&group.field=a_si&q=kings} hits=0 status=0 QTime=37
[junit4:junit4] 2> 1515 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&spellcheck.build=true&shard.url=127.0.0.1:40052/zxo/o&fl=id&isShard=true&NOW=1355888875053&spellcheck=false&spellcheck.extendedResults=false&wt=javabin&rows=100&spellcheck.onlyMorePopular=false&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&spellcheck.count=1&group.field=a_si&q=kings} status=0 QTime=1
[junit4:junit4] 2> 1516 T2633 C130 oashc.SpellCheckComponent.finishStage 127.0.0.1:40052/zxo/o null
[junit4:junit4] 2> 1516 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&spellcheck.build=true&shards=127.0.0.1:40052/zxo/o&fl=id,a_si&qt=spellCheckCompRH&spellcheck=true&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&group.field=a_si&q=kings} status=0 QTime=39
[junit4:junit4] 2> 1525 T2623 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=true&facet.field=a_t&group.truncate=true&fl=id,a_si&fq=a_s:a&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=0 status=0 QTime=7
[junit4:junit4] 2> 1530 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=false&facet.field=a_t&shard.url=127.0.0.1:40052/zxo/o&group.truncate=true&fl=id&isShard=true&NOW=1355888875103&fq=a_s:a&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 1544 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=true&facet.field=a_t&shard.url=127.0.0.1:40052/zxo/o&group.truncate=true&fl=id&isShard=true&NOW=1355888875103&fq=a_s:a&wt=javabin&rows=100&f.a_t.facet.limit=160&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=12
[junit4:junit4] 2> 1545 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=true&facet.field=a_t&group.truncate=true&shards=127.0.0.1:40052/zxo/o&fl=id,a_si&fq=a_s:a&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=18
[junit4:junit4] 2> 1548 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4:junit4] 2> 1551 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[1]} 0 1
[junit4:junit4] 2> 1554 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[2]} 0 1
[junit4:junit4] 2> 1557 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[2]} 0 1
[junit4:junit4] 2> 1560 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[3]} 0 1
[junit4:junit4] 2> 1563 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[3]} 0 1
[junit4:junit4] 2> 1568 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[4]} 0 2
[junit4:junit4] 2> 1571 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[4]} 0 1
[junit4:junit4] 2> 1578 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[5]} 0 5
[junit4:junit4] 2> 1581 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[5]} 0 1
[junit4:junit4] 2> 1583 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4:junit4] 2> 1585 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[6]} 0 0
[junit4:junit4] 2> 1588 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[7]} 0 1
[junit4:junit4] 2> 1590 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[7]} 0 0
[junit4:junit4] 2> 1593 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[8]} 0 1
[junit4:junit4] 2> 1596 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[8]} 0 1
[junit4:junit4] 2> 1598 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[9]} 0 0
[junit4:junit4] 2> 1601 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[9]} 0 1
[junit4:junit4] 2> 1607 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[10]} 0 4
[junit4:junit4] 2> 1615 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[10]} 0 5
[junit4:junit4] 2> 1620 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[11]} 0 3
[junit4:junit4] 2> 1623 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[11]} 0 1
[junit4:junit4] 2> 1626 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[12]} 0 1
[junit4:junit4] 2> 1629 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[12]} 0 1
[junit4:junit4] 2> 1631 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[14]} 0 0
[junit4:junit4] 2> 1634 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[14]} 0 1
[junit4:junit4] 2> 1637 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[15]} 0 1
[junit4:junit4] 2> 1639 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[15]} 0 0
[junit4:junit4] 2> 1641 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4:junit4] 2> 1644 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[16]} 0 0
[junit4:junit4] 2> 1647 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[17]} 0 1
[junit4:junit4] 2> 1654 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[17]} 0 2
[junit4:junit4] 2> 1657 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[18]} 0 1
[junit4:junit4] 2> 1660 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[18]} 0 1
[junit4:junit4] 2> 1663 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[19]} 0 0
[junit4:junit4] 2> 1666 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[19]} 0 1
[junit4:junit4] 2> 1668 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4:junit4] 2> 1670 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[20]} 0 0
[junit4:junit4] 2> 1676 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[21]} 0 4
[junit4:junit4] 2> 1682 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[21]} 0 4
[junit4:junit4] 2> 1685 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[22]} 0 1
[junit4:junit4] 2> 1688 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[22]} 0 1
[junit4:junit4] 2> 1691 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[23]} 0 1
[junit4:junit4] 2> 1693 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[23]} 0 0
[junit4:junit4] 2> 1697 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[100]} 0 1
[junit4:junit4] 2> 1699 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[100]} 0 0
[junit4:junit4] 2> 1703 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[101]} 0 1
[junit4:junit4] 2> 1705 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[101]} 0 0
[junit4:junit4] 2> 1710 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[102]} 0 1
[junit4:junit4] 2> 1713 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[102]} 0 1
[junit4:junit4] 2> 1716 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[103]} 0 1
[junit4:junit4] 2> 1719 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[103]} 0 1
[junit4:junit4] 2> 1721 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[104]} 0 0
[junit4:junit4] 2> 1724 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[104]} 0 1
[junit4:junit4] 2> 1727 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[105]} 0 1
[junit4:junit4] 2> 1729 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[105]} 0 1
[junit4:junit4] 2> 1731 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[106]} 0 0
[junit4:junit4] 2> 1733 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[106]} 0 0
[junit4:junit4] 2> 1740 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[107]} 0 5
[junit4:junit4] 2> 1745 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[107]} 0 3
[junit4:junit4] 2> 1749 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[108]} 0 1
[junit4:junit4] 2> 1751 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[108]} 0 1
[junit4:junit4] 2> 1753 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[109]} 0 0
[junit4:junit4] 2> 1755 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[109]} 0 0
[junit4:junit4] 2> 1757 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[110]} 0 0
[junit4:junit4] 2> 1759 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[110]} 0 0
[junit4:junit4] 2> 1761 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[111]} 0 0
[junit4:junit4] 2> 1764 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[111]} 0 1
[junit4:junit4] 2> 1766 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[112]} 0 1
[junit4:junit4] 2> 1768 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[112]} 0 1
[junit4:junit4] 2> 1770 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[113]} 0 1
[junit4:junit4] 2> 1771 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[113]} 0 0
[junit4:junit4] 2> 1774 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[114]} 0 1
[junit4:junit4] 2> 1776 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[114]} 0 1
[junit4:junit4] 2> 1778 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[115]} 0 0
[junit4:junit4] 2> 1781 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[115]} 0 1
[junit4:junit4] 2> 1783 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4:junit4] 2> 1785 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[116]} 0 0
[junit4:junit4] 2> 1791 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[117]} 0 4
[junit4:junit4] 2> 1796 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[117]} 0 3
[junit4:junit4] 2> 1800 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[118]} 0 1
[junit4:junit4] 2> 1803 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[118]} 0 1
[junit4:junit4] 2> 1805 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[119]} 0 0
[junit4:junit4] 2> 1808 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[119]} 0 1
[junit4:junit4] 2> 1810 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[120]} 0 1
[junit4:junit4] 2> 1812 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[120]} 0 1
[junit4:junit4] 2> 1814 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[121]} 0 0
[junit4:junit4] 2> 1816 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[121]} 0 0
[junit4:junit4] 2> 1818 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[122]} 0 0
[junit4:junit4] 2> 1821 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[122]} 0 1
[junit4:junit4] 2> 1824 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[123]} 0 0
[junit4:junit4] 2> 1827 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[123]} 0 1
[junit4:junit4] 2> 1830 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[124]} 0 1
[junit4:junit4] 2> 1832 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[124]} 0 1
[junit4:junit4] 2> 1835 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[125]} 0 1
[junit4:junit4] 2> 1837 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[125]} 0 0
[junit4:junit4] 2> 1840 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[126]} 0 1
[junit4:junit4] 2> 1842 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[126]} 0 1
[junit4:junit4] 2> 1848 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[127]} 0 5
[junit4:junit4] 2> 1854 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[127]} 0 4
[junit4:junit4] 2> 1857 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[128]} 0 1
[junit4:junit4] 2> 1860 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[128]} 0 1
[junit4:junit4] 2> 1863 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[129]} 0 1
[junit4:junit4] 2> 1866 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[129]} 0 1
[junit4:junit4] 2> 1869 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[130]} 0 1
[junit4:junit4] 2> 1872 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[130]} 0 1
[junit4:junit4] 2> 1875 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[131]} 0 1
[junit4:junit4] 2> 1877 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[131]} 0 0
[junit4:junit4] 2> 1887 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[132]} 0 1
[junit4:junit4] 2> 1889 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[132]} 0 0
[junit4:junit4] 2> 1891 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[133]} 0 0
[junit4:junit4] 2> 1893 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[133]} 0 0
[junit4:junit4] 2> 1895 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[134]} 0 0
[junit4:junit4] 2> 1897 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[134]} 0 0
[junit4:junit4] 2> 1899 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[135]} 0 0
[junit4:junit4] 2> 1901 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[135]} 0 0
[junit4:junit4] 2> 1903 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[136]} 0 0
[junit4:junit4] 2> 1906 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[136]} 0 1
[junit4:junit4] 2> 1915 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[137]} 0 7
[junit4:junit4] 2> 1921 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[137]} 0 4
[junit4:junit4] 2> 1925 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[138]} 0 1
[junit4:junit4] 2> 1929 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[138]} 0 2
[junit4:junit4] 2> 1931 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[139]} 0 0
[junit4:junit4] 2> 1933 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[139]} 0 0
[junit4:junit4] 2> 1935 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[140]} 0 0
[junit4:junit4] 2> 1938 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[140]} 0 1
[junit4:junit4] 2> 1940 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[141]} 0 1
[junit4:junit4] 2> 1942 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[141]} 0 0
[junit4:junit4] 2> 1945 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[142]} 0 1
[junit4:junit4] 2> 1947 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[142]} 0 1
[junit4:junit4] 2> 1949 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[143]} 0 0
[junit4:junit4] 2> 1951 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[143]} 0 0
[junit4:junit4] 2> 1953 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[144]} 0 0
[junit4:junit4] 2> 1955 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[144]} 0 1
[junit4:junit4] 2> 1957 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[145]} 0 0
[junit4:junit4] 2> 1959 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[145]} 0 0
[junit4:junit4] 2> 1962 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[146]} 0 1
[junit4:junit4] 2> 1963 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[146]} 0 0
[junit4:junit4] 2> 1969 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[147]} 0 4
[junit4:junit4] 2> 1976 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[147]} 0 5
[junit4:junit4] 2> 1979 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[148]} 0 1
[junit4:junit4] 2> 1982 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[148]} 0 1
[junit4:junit4] 2> 1984 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[149]} 0 0
[junit4:junit4] 2> 1986 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[149]} 0 0
[junit4:junit4] 2> 1988 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[500]} 0 0
[junit4:junit4] 2> 1990 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[500]} 0 0
[junit4:junit4] 2> 1992 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[501]} 0 0
[junit4:junit4] 2> 1994 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[501]} 0 0
[junit4:junit4] 2> 1996 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[502]} 0 0
[junit4:junit4] 2> 1998 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[502]} 0 1
[junit4:junit4] 2> 2000 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[503]} 0 1
[junit4:junit4] 2> 2002 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[503]} 0 0
[junit4:junit4] 2> 2004 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[504]} 0 0
[junit4:junit4] 2> 2006 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[504]} 0 1
[junit4:junit4] 2> 2007 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[505]} 0 0
[junit4:junit4] 2> 2009 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[505]} 0 0
[junit4:junit4] 2> 2011 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[506]} 0 0
[junit4:junit4] 2> 2013 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[506]} 0 0
[junit4:junit4] 2> 2019 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[507]} 0 4
[junit4:junit4] 2> 2025 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[507]} 0 4
[junit4:junit4] 2> 2028 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[508]} 0 1
[junit4:junit4] 2> 2031 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[508]} 0 1
[junit4:junit4] 2> 2034 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[509]} 0 0
[junit4:junit4] 2> 2037 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[509]} 0 0
[junit4:junit4] 2> 2039 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[510]} 0 0
[junit4:junit4] 2> 2044 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[510]} 0 1
[junit4:junit4] 2> 2046 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[511]} 0 0
[junit4:junit4] 2> 2048 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[511]} 0 0
[junit4:junit4] 2> 2050 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[512]} 0 0
[junit4:junit4] 2> 2052 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[512]} 0 0
[junit4:junit4] 2> 2054 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[513]} 0 0
[junit4:junit4] 2> 2057 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[513]} 0 1
[junit4:junit4] 2> 2058 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[514]} 0 0
[junit4:junit4] 2> 2062 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[514]} 0 0
[junit4:junit4] 2> 2065 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[515]} 0 1
[junit4:junit4] 2> 2066 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[515]} 0 0
[junit4:junit4] 2> 2068 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[516]} 0 0
[junit4:junit4] 2> 2071 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[516]} 0 1
[junit4:junit4] 2> 2075 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[517]} 0 3
[junit4:junit4] 2> 2081 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[517]} 0 4
[junit4:junit4] 2> 2084 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[518]} 0 1
[junit4:junit4] 2> 2086 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[518]} 0 0
[junit4:junit4] 2> 2088 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[519]} 0 0
[junit4:junit4] 2> 2090 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[519]} 0 0
[junit4:junit4] 2> 2092 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[520]} 0 0
[junit4:junit4] 2> 2094 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[520]} 0 0
[junit4:junit4] 2> 2096 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[521]} 0 1
[junit4:junit4] 2> 2098 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[521]} 0 1
[junit4:junit4] 2> 2100 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[522]} 0 1
[junit4:junit4] 2> 2102 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[522]} 0 0
[junit4:junit4] 2> 2104 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[523]} 0 0
[junit4:junit4] 2> 2106 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[523]} 0 0
[junit4:junit4] 2> 2108 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[524]} 0 0
[junit4:junit4] 2> 2110 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[524]} 0 0
[junit4:junit4] 2> 2113 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[525]} 0 0
[junit4:junit4] 2> 2115 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[525]} 0 0
[junit4:junit4] 2> 2117 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[526]} 0 0
[junit4:junit4] 2> 2119 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[526]} 0 0
[junit4:junit4] 2> 2124 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[527]} 0 3
[junit4:junit4] 2> 2129 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[527]} 0 3
[junit4:junit4] 2> 2132 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[528]} 0 1
[junit4:junit4] 2> 2135 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[528]} 0 1
[junit4:junit4] 2> 2137 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[529]} 0 0
[junit4:junit4] 2> 2139 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[529]} 0 0
[junit4:junit4] 2> 2144 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[530]} 0 2
[junit4:junit4] 2> 2146 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[530]} 0 0
[junit4:junit4] 2> 2148 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[531]} 0 0
[junit4:junit4] 2> 2150 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[531]} 0 0
[junit4:junit4] 2> 2152 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[532]} 0 0
[junit4:junit4] 2> 2154 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[532]} 0 0
[junit4:junit4] 2> 2156 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[533]} 0 0
[junit4:junit4] 2> 2158 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[533]} 0 0
[junit4:junit4] 2> 2161 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[534]} 0 1
[junit4:junit4] 2> 2163 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[534]} 0 0
[junit4:junit4] 2> 2169 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[535]} 0 0
[junit4:junit4] 2> 2172 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[535]} 0 1
[junit4:junit4] 2> 2174 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[536]} 0 0
[junit4:junit4] 2> 2176 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[536]} 0 0
[junit4:junit4] 2> 2181 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[537]} 0 3
[junit4:junit4] 2> 2186 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[537]} 0 3
[junit4:junit4] 2> 2189 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[538]} 0 1
[junit4:junit4] 2> 2192 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[538]} 0 1
[junit4:junit4] 2> 2195 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[539]} 0 1
[junit4:junit4] 2> 2197 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[539]} 0 0
[junit4:junit4] 2> 2199 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[540]} 0 0
[junit4:junit4] 2> 2201 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[540]} 0 0
[junit4:junit4] 2> 2203 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[541]} 0 0
[junit4:junit4] 2> 2205 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[541]} 0 0
[junit4:junit4] 2> 2207 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[542]} 0 0
[junit4:junit4] 2> 2209 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[542]} 0 0
[junit4:junit4] 2> 2212 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[543]} 0 1
[junit4:junit4] 2> 2214 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[543]} 0 0
[junit4:junit4] 2> 2216 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[544]} 0 0
[junit4:junit4] 2> 2219 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[544]} 0 1
[junit4:junit4] 2> 2221 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[545]} 0 0
[junit4:junit4] 2> 2223 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[545]} 0 0
[junit4:junit4] 2> 2225 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[546]} 0 0
[junit4:junit4] 2> 2227 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[546]} 0 0
[junit4:junit4] 2> 2233 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[547]} 0 4
[junit4:junit4] 2> 2238 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[547]} 0 3
[junit4:junit4] 2> 2241 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[548]} 0 1
[junit4:junit4] 2> 2244 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[548]} 0 1
[junit4:junit4] 2> 2247 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[549]} 0 0
[junit4:junit4] 2> 2249 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[549]} 0 0
[junit4:junit4] 2> 2251 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[550]} 0 0
[junit4:junit4] 2> 2254 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[550]} 0 0
[junit4:junit4] 2> 2256 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[551]} 0 1
[junit4:junit4] 2> 2258 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[551]} 0 1
[junit4:junit4] 2> 2260 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[552]} 0 1
[junit4:junit4] 2> 2262 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[552]} 0 1
[junit4:junit4] 2> 2264 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[553]} 0 0
[junit4:junit4] 2> 2266 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[553]} 0 0
[junit4:junit4] 2> 2268 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[554]} 0 0
[junit4:junit4] 2> 2270 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[554]} 0 0
[junit4:junit4] 2> 2272 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[555]} 0 0
[junit4:junit4] 2> 2274 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[555]} 0 0
[junit4:junit4] 2> 2276 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[556]} 0 0
[junit4:junit4] 2> 2278 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[556]} 0 0
[junit4:junit4] 2> 2283 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[557]} 0 3
[junit4:junit4] 2> 2289 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[557]} 0 3
[junit4:junit4] 2> 2292 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[558]} 0 1
[junit4:junit4] 2> 2294 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[558]} 0 0
[junit4:junit4] 2> 2297 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[559]} 0 1
[junit4:junit4] 2> 2299 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[559]} 0 1
[junit4:junit4] 2> 2301 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[560]} 0 1
[junit4:junit4] 2> 2303 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[560]} 0 0
[junit4:junit4] 2> 2305 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[561]} 0 0
[junit4:junit4] 2> 2307 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[561]} 0 0
[junit4:junit4] 2> 2309 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[562]} 0 0
[junit4:junit4] 2> 2311 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[562]} 0 0
[junit4:junit4] 2> 2313 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[563]} 0 0
[junit4:junit4] 2> 2315 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[563]} 0 0
[junit4:junit4] 2> 2318 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[564]} 0 1
[junit4:junit4] 2> 2320 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[564]} 0 1
[junit4:junit4] 2> 2322 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[565]} 0 0
[junit4:junit4] 2> 2324 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[565]} 0 1
[junit4:junit4] 2> 2326 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[566]} 0 1
[junit4:junit4] 2> 2328 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[566]} 0 1
[junit4:junit4] 2> 2332 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[567]} 0 3
[junit4:junit4] 2> 2337 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[567]} 0 3
[junit4:junit4] 2> 2340 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[568]} 0 1
[junit4:junit4] 2> 2343 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[568]} 0 1
[junit4:junit4] 2> 2345 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[569]} 0 0
[junit4:junit4] 2> 2347 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[569]} 0 0
[junit4:junit4] 2> 2350 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[570]} 0 1
[junit4:junit4] 2> 2352 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[570]} 0 0
[junit4:junit4] 2> 2354 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[571]} 0 0
[junit4:junit4] 2> 2356 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[571]} 0 0
[junit4:junit4] 2> 2358 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[572]} 0 0
[junit4:junit4] 2> 2360 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[572]} 0 0
[junit4:junit4] 2> 2362 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[573]} 0 0
[junit4:junit4] 2> 2364 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[573]} 0 0
[junit4:junit4] 2> 2366 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[574]} 0 0
[junit4:junit4] 2> 2368 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[574]} 0 1
[junit4:junit4] 2> 2369 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[575]} 0 0
[junit4:junit4] 2> 2371 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[575]} 0 0
[junit4:junit4] 2> 2373 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[576]} 0 0
[junit4:junit4] 2> 2375 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[576]} 0 0
[junit4:junit4] 2> 2380 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[577]} 0 3
[junit4:junit4] 2> 2385 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[577]} 0 3
[junit4:junit4] 2> 2388 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[578]} 0 1
[junit4:junit4] 2> 2391 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[578]} 0 1
[junit4:junit4] 2> 2394 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[579]} 0 0
[junit4:junit4] 2> 2396 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[579]} 0 0
[junit4:junit4] 2> 2398 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[580]} 0 0
[junit4:junit4] 2> 2401 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[580]} 0 1
[junit4:junit4] 2> 2403 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[581]} 0 0
[junit4:junit4] 2> 2405 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[581]} 0 0
[junit4:junit4] 2> 2407 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[582]} 0 0
[junit4:junit4] 2> 2410 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[582]} 0 1
[junit4:junit4] 2> 2412 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[583]} 0 0
[junit4:junit4] 2> 2414 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[583]} 0 1
[junit4:junit4] 2> 2416 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[584]} 0 1
[junit4:junit4] 2> 2418 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[584]} 0 0
[junit4:junit4] 2> 2420 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[585]} 0 0
[junit4:junit4] 2> 2422 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[585]} 0 1
[junit4:junit4] 2> 2423 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[586]} 0 0
[junit4:junit4] 2> 2425 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[586]} 0 0
[junit4:junit4] 2> 2429 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[587]} 0 2
[junit4:junit4] 2> 2433 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[587]} 0 2
[junit4:junit4] 2> 2435 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[588]} 0 0
[junit4:junit4] 2> 2438 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[588]} 0 1
[junit4:junit4] 2> 2439 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[589]} 0 0
[junit4:junit4] 2> 2441 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[589]} 0 0
[junit4:junit4] 2> 2443 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[590]} 0 0
[junit4:junit4] 2> 2445 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[590]} 0 0
[junit4:junit4] 2> 2447 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[591]} 0 0
[junit4:junit4] 2> 2449 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[591]} 0 0
[junit4:junit4] 2> 2451 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[592]} 0 0
[junit4:junit4] 2> 2453 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[592]} 0 0
[junit4:junit4] 2> 2455 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[593]} 0 0
[junit4:junit4] 2> 2457 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[593]} 0 0
[junit4:junit4] 2> 2459 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[594]} 0 0
[junit4:junit4] 2> 2462 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[594]} 0 0
[junit4:junit4] 2> 2464 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[595]} 0 0
[junit4:junit4] 2> 2466 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[595]} 0 0
[junit4:junit4] 2> 2468 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[596]} 0 0
[junit4:junit4] 2> 2470 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[596]} 0 0
[junit4:junit4] 2> 2501 T2621 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[597]} 0 29
[junit4:junit4] 2> 2506 T2635 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[597]} 0 3
[junit4:junit4] 2> 2509 T2622 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[598]} 0 1
[junit4:junit4] 2> 2512 T2632 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[598]} 0 2
[junit4:junit4] 2> 2514 T2624 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[599]} 0 0
[junit4:junit4] 2> 2517 T2634 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={wt=javabin&version=2} {add=[599]} 0 1
[junit4:junit4] 2> 2518 T2623 C129 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 3660 T2623 C129 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049046tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1aecab9)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049046tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1aecab9)),segFN=segments_3,generation=3,filenames=[_g.fdt, _j_Lucene41_0.tip, _j_nrm.cfs, _j.si, _g_Lucene41_0.tip, _j.fnm, _h.fnm, _g_Lucene41_0.pos, _h_Lucene41_0.pos, _i_Lucene41_0.pos, _i.fnm, _h_Lucene41_0.tim, _j.fdt, _i.si, _h_Lucene41_0.doc, _i_Lucene41_0.doc, _g_Lucene41_0.doc, _i_Lucene41_0.tip, _j_Lucene41_0.doc, _h_nrm.cfs, _j_nrm.cfe, _g.si, _h.fdx, _j_Lucene41_0.pos, _h.si, _j_Lucene41_0.tim, _h_Lucene41_0.tip, _g.fnm, _i_nrm.cfs, _j.fdx, _h.fdt, _i_Lucene41_0.tim, _i.fdx, _i_nrm.cfe, _g.fdx, _g_nrm.cfe, _h_nrm.cfe, _g_Lucene41_0.tim, _g_nrm.cfs, _i.fdt, segments_3]
[junit4:junit4] 2> 3661 T2623 C129 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_g.fdt, _j_Lucene41_0.tip, _j_nrm.cfs, _j.si, _g_Lucene41_0.tip, _j.fnm, _h.fnm, _g_Lucene41_0.pos, _h_Lucene41_0.pos, _i_Lucene41_0.pos, _i.fnm, _h_Lucene41_0.tim, _j.fdt, _i.si, _h_Lucene41_0.doc, _i_Lucene41_0.doc, _g_Lucene41_0.doc, _i_Lucene41_0.tip, _j_Lucene41_0.doc, _h_nrm.cfs, _j_nrm.cfe, _g.si, _h.fdx, _j_Lucene41_0.pos, _h.si, _j_Lucene41_0.tim, _h_Lucene41_0.tip, _g.fnm, _i_nrm.cfs, _j.fdx, _h.fdt, _i_Lucene41_0.tim, _i.fdx, _i_nrm.cfe, _g.fdx, _g_nrm.cfe, _h_nrm.cfe, _g_Lucene41_0.tim, _g_nrm.cfs, _i.fdt, segments_3]
[junit4:junit4] 2> 3663 T2623 C129 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data
[junit4:junit4] 2> 3673 T2623 C129 oass.SolrIndexSearcher.<init> Opening Searcher@d40397 main
[junit4:junit4] 2> 3673 T2623 C129 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 3683 T2626 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d40397 main{StandardDirectoryReader(segments_3:42 _g(5.0):C150 _h(5.0):C10 _i(5.0):C10 _j(5.0):C2)}
[junit4:junit4] 2> 3683 T2626 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index
[junit4:junit4] 2> 3683 T2623 C129 UPDATE [collection1] webapp=/zxo/o path=/update params={waitSearcher=true&wt=javabin&softCommit=false&version=2&commit=true} {commit=} 0 1165
[junit4:junit4] 2> 3685 T2633 C130 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 3760 T2633 C130 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049047tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c43b0a)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.SimpleFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/index4902049047tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c43b0a)),segFN=segments_3,generation=3,filenames=[_g.fdt, _j_Lucene41_0.tip, _j_nrm.cfs, _j.si, _g_Lucene41_0.tip, _j.fnm, _h.fnm, _g_Lucene41_0.pos, _h_Lucene41_0.pos, _i_Lucene41_0.pos, _i.fnm, _h_Lucene41_0.tim, _j.fdt, _i.si, _h_Lucene41_0.doc, _i_Lucene41_0.doc, _g_Lucene41_0.doc, _i_Lucene41_0.tip, _j_Lucene41_0.doc, _h_nrm.cfs, _j_nrm.cfe, _g.si, _h.fdx, _j_Lucene41_0.pos, _h.si, _j_Lucene41_0.tim, _h_Lucene41_0.tip, _g.fnm, _i_nrm.cfs, _j.fdx, _h.fdt, _i_Lucene41_0.tim, _i.fdx, _i_nrm.cfe, _g.fdx, _g_nrm.cfe, _h_nrm.cfe, _g_Lucene41_0.tim, _g_nrm.cfs, _i.fdt, segments_3]
[junit4:junit4] 2> 3761 T2633 C130 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_g.fdt, _j_Lucene41_0.tip, _j_nrm.cfs, _j.si, _g_Lucene41_0.tip, _j.fnm, _h.fnm, _g_Lucene41_0.pos, _h_Lucene41_0.pos, _i_Lucene41_0.pos, _i.fnm, _h_Lucene41_0.tim, _j.fdt, _i.si, _h_Lucene41_0.doc, _i_Lucene41_0.doc, _g_Lucene41_0.doc, _i_Lucene41_0.tip, _j_Lucene41_0.doc, _h_nrm.cfs, _j_nrm.cfe, _g.si, _h.fdx, _j_Lucene41_0.pos, _h.si, _j_Lucene41_0.tim, _h_Lucene41_0.tip, _g.fnm, _i_nrm.cfs, _j.fdx, _h.fdt, _i_Lucene41_0.tim, _i.fdx, _i_nrm.cfe, _g.fdx, _g_nrm.cfe, _h_nrm.cfe, _g_Lucene41_0.tim, _g_nrm.cfs, _i.fdt, segments_3]
[junit4:junit4] 2> 3761 T2633 C130 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data
[junit4:junit4] 2> 3777 T2633 C130 oass.SolrIndexSearcher.<init> Opening Searcher@58ed01 main
[junit4:junit4] 2> 3777 T2633 C130 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 3782 T2637 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@58ed01 main{StandardDirectoryReader(segments_3:42 _g(5.0):C150 _h(5.0):C10 _i(5.0):C10 _j(5.0):C2)}
[junit4:junit4] 2> 3783 T2637 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index
[junit4:junit4] 2> 3783 T2633 C130 UPDATE [collection1] webapp=/zxo/o path=/update params={waitSearcher=true&wt=javabin&softCommit=false&version=2&commit=true} {commit=} 0 98
[junit4:junit4] 2> 3802 T2622 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&distrib=false&group.limit=10&version=2&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=17
[junit4:junit4] 2> 3817 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877386&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=5
[junit4:junit4] 2> 3827 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877386&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=5
[junit4:junit4] 2> 3835 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si,id&ids=501,502,500,22,23,509,507,508,505,506,503,504,9,8,7,6,5,4,3,2,1,10,14,11,12,17,18,15,16,19,102,101,100,105,104,103,21,20&isShard=true&NOW=1355888877386&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 3839 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.limit=10&version=2&shards=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=29
[junit4:junit4] 2> 3844 T2624 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&distrib=false&group.limit=10&version=2&fl=id,a_si&sort=id+asc,+_docid_+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3849 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::083]:33332/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877423&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=id+asc,+_docid_+asc&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 3854 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=100&group.topgroups.a_si=50&group.topgroups.a_si=2&group.topgroups.a_si=-100&group.topgroups.a_si=500&group.topgroups.a_si=-600&group.topgroups.a_si=123&group.topgroups.a_si=876&group.topgroups.a_si=7&group.topgroups.a_si=4321&group.topgroups.a_si=-987&group.topgroups.a_si=379&group.topgroups.a_si=%01&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=9999&group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::083]:33332/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877423&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=id+asc,+_docid_+asc&q=*:*&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 3861 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={shard.url=127.0.0.1:40052/zxo/o|[ff01::083]:33332/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si,id&ids=9,8,10,1,3,2,5,4,7,6,22,23,500,501,502,503,504,505,506,507,508,509,104,103,105,100,102,101,21,20,15,16,17,18,11,12,14,19&isShard=true&NOW=1355888877423&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 3863 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.limit=10&version=2&shards=127.0.0.1:40052/zxo/o|[ff01::083]:33332/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si&sort=id+asc,+_docid_+asc&q=*:*&group.field=a_si} status=0 QTime=16
[junit4:junit4] 2> 3870 T2623 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&distrib=false&group.limit=10&version=2&fl=id,a_si&sort={!func}add(a_si,5)+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=5
[junit4:junit4] 2> 3875 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shard.url=[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877449&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort={!func}add(a_si,5)+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 3879 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=%01&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group=true&shard.url=[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877449&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort={!func}add(a_si,5)+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 3883 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={shard.url=[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id,a_si,id&ids=19,11,12,14,15,16,17,18,21,20,100,102,101,104,103,105,507,508,509,503,504,505,506,500,501,502,22,23,5,4,7,6,10,1,3,2,9,8&isShard=true&NOW=1355888877449&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 3884 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.limit=10&version=2&shards=[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id,a_si&sort={!func}add(a_si,5)+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=11
[junit4:junit4] 2> 3889 T2621 C129 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=5158,tindexSize=41,time=1,phase1=1,nTerms=55,bigTerms=1,termInstances=77,uses=0}
[junit4:junit4] 2> 3890 T2621 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=true&facet.field=a_t&fl=id,a_si&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=4
[junit4:junit4] 2> 3896 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=false&facet.field=a_t&shard.url=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877469&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 3900 T2634 C130 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> 3901 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&facet=true&facet.field=a_t&shard.url=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877469&wt=javabin&rows=100&f.a_t.facet.limit=160&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=3
[junit4:junit4] 2> 3905 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={facet=false&facet.field=a_t&shard.url=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si,id&ids=8,9,2,3,1,10,6,7,4,5,23,22,502,501,500,506,505,504,503,509,508,507,105,103,104,101,102,100,20,21,18,17,16,15,14,12,11,19&isShard=true&NOW=1355888877469&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 3906 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&facet=true&facet.field=a_t&shards=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=13
[junit4:junit4] 2> 3910 T2622 C129 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> 3911 T2622 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&stats.field=other_tl1&fl=id,a_si&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&stats=true&q=*:*&group.field=a_si} hits=172 status=0 QTime=3
[junit4:junit4] 2> 3916 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&stats.field=other_tl1&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877489&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&stats=false&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 3921 T2633 C130 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> 3921 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&stats.field=other_tl1&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id&isShard=true&NOW=1355888877489&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&stats=true&q=*:*&group.field=a_si} status=0 QTime=3
[junit4:junit4] 2> 3925 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={stats.field=other_tl1&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si,id&ids=105,103,104,101,102,100,20,21,18,17,16,15,14,12,11,19,8,9,2,3,1,10,6,7,4,5,23,22,502,501,500,506,505,504,503,509,508,507&isShard=true&NOW=1355888877489&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&stats=false&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 3926 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&stats.field=other_tl1&shards=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&stats=true&q=*:*&group.field=a_si} status=0 QTime=13
[junit4:junit4] 2> 5036 T2624 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&spellcheck.build=true&fl=id,a_si&qt=spellCheckCompRH&spellcheck=true&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=kings&group.field=a_si} hits=1 status=0 QTime=1107
[junit4:junit4] 2> 5064 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&spellcheck.build=true&shard.url=[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878615&spellcheck=false&spellcheck.extendedResults=false&wt=javabin&rows=100&spellcheck.onlyMorePopular=false&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&spellcheck.count=1&q=kings&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5068 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=876&group=true&spellcheck.build=true&shard.url=[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878615&spellcheck=true&spellcheck.extendedResults=false&wt=javabin&rows=100&spellcheck.onlyMorePopular=false&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&spellcheck.count=5&q=kings&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 5070 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={spellcheck.build=true&shard.url=[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si,id&ids=8&isShard=true&NOW=1355888878615&spellcheck=false&spellcheck.extendedResults=false&wt=javabin&rows=100&spellcheck.onlyMorePopular=false&distrib=false&group.limit=10&version=2&spellcheck.count=1&q=kings&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5071 T2632 C130 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o null
[junit4:junit4] 2> 5071 T2632 C130 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o null
[junit4:junit4] 2> 5071 T2632 C130 oashc.SpellCheckComponent.finishStage [ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o null
[junit4:junit4] 2> 5072 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&spellcheck.build=true&shards=[ff01::083]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si&qt=spellCheckCompRH&spellcheck=true&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=kings&group.field=a_si} status=0 QTime=33
[junit4:junit4] 2> 5080 T2623 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&hl.fl=a_t&hl=true&facet=true&fl=id,a_si&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=7
[junit4:junit4] 2> 5084 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&hl.fl=a_t&hl=false&facet=false&shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878658&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5088 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&hl.fl=a_t&hl=false&facet=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878658&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 5096 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={hl.fl=a_t&hl=true&facet=false&shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si,id&ids=508,507,509,504,503,506,505,500,502,501,23,22,4,5,6,7,1,10,2,3,8,9,19,12,11,14,16,15,18,17,20,21,100,101,102,103,104,105&isShard=true&NOW=1355888878658&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*&group.field=a_si} status=0 QTime=5
[junit4:junit4] 2> 5098 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&hl.fl=a_t&hl=true&facet=true&shards=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o|[ff01::213]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si&wt=javabin&rows=100&group.limit=10&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=16
[junit4:junit4] 2> 5101 T2621 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.sort=id+desc&distrib=false&group.limit=10&version=2&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=1
[junit4:junit4] 2> 5104 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&group.sort=id+desc&shard.url=127.0.0.1:40052/zxo/o&fl=id&isShard=true&NOW=1355888878679&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5107 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&group.sort=id+desc&shard.url=127.0.0.1:40052/zxo/o&fl=id&isShard=true&NOW=1355888878679&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5111 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.sort=id+desc&shard.url=127.0.0.1:40052/zxo/o&fl=id,a_si,id&ids=141,593,142,592,591,140,590,8,9,4,5,6,7,1,10,2,3,23,22,149,148,598,147,599,146,596,145,597,144,594,143,595,20,21,12,11,18,19&isShard=true&NOW=1355888878679&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5113 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.sort=id+desc&group.limit=10&version=2&shards=127.0.0.1:40052/zxo/o&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=10
[junit4:junit4] 2> 5117 T2624 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&distrib=false&group.offset=5&group.limit=5&version=2&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=1
[junit4:junit4] 2> 5121 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878695&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.offset=5&group.limit=5&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5124 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878695&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.offset=5&group.limit=5&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5126 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si,id&ids=101,102,105,103,104,509,508,507,506,505&isShard=true&NOW=1355888878695&wt=javabin&rows=100&distrib=false&group.offset=5&group.limit=5&version=2&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5127 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.offset=5&group.limit=5&version=2&shards=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=8
[junit4:junit4] 2> 5130 T2622 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&fl=id,a_si&offset=5&wt=javabin&rows=100&rows=5&distrib=false&group.offset=5&group.limit=5&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=1
[junit4:junit4] 2> 5135 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shard.url=[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878708&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.offset=5&group.limit=5&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5138 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&shard.url=[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878708&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.offset=5&group.limit=5&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5141 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={shard.url=[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si,id&offset=5&ids=102,101,104,103,105,507,508,509,505,506&isShard=true&NOW=1355888878708&wt=javabin&rows=100&rows=5&distrib=false&group.offset=5&group.limit=5&version=2&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5142 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shards=[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o&fl=id,a_si&offset=5&wt=javabin&rows=100&rows=5&group.offset=5&group.limit=5&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=10
[junit4:junit4] 2> 5146 T2623 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group.format=simple&group=true&rows=100&rows=5&distrib=false&version=2&fl=id,a_si&offset=5&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=3
[junit4:junit4] 2> 5151 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.format=simple&group=true&shard.url=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878724&wt=javabin&rows=100&distrib=false&group.distributed.first=true&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5156 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group.format=simple&group=true&shard.url=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878724&wt=javabin&rows=100&distrib=false&group.distributed.second=true&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=3
[junit4:junit4] 2> 5160 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.format=simple&shard.url=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o&fl=id,a_si,id&offset=5&ids=9,8,3,2,10,1,7,6,5,4,18,23,14,11,500,12&isShard=true&NOW=1355888878724&wt=javabin&rows=100&rows=5&distrib=false&version=2&q=*:*&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 5160 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group.format=simple&group=true&rows=100&rows=5&version=2&shards=[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o&fl=id,a_si&offset=5&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=12
[junit4:junit4] 2> 5167 T2621 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&rows=5&distrib=false&group.main=true&version=2&fl=id,a_si&offset=5&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=5
[junit4:junit4] 2> 5170 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878744&wt=javabin&rows=100&distrib=false&group.main=true&group.distributed.first=true&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5173 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878744&wt=javabin&rows=100&distrib=false&group.main=true&group.distributed.second=true&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5176 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id,a_si,id&offset=5&ids=9,8,5,4,7,6,10,1,3,2,11,500,12,14,18,23&isShard=true&NOW=1355888878744&wt=javabin&rows=100&rows=5&distrib=false&group.main=true&version=2&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5177 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&rows=5&group.main=true&version=2&shards=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o&fl=id,a_si&offset=5&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=9
[junit4:junit4] 2> 5179 T2624 C129 REQ [collection1] webapp=/zxo/o path=/select params={group.format=simple&group=true&fl=id,a_si&offset=5&wt=javabin&rows=100&rows=5&distrib=false&group.offset=5&group.limit=5&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=1
[junit4:junit4] 2> 5183 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.format=simple&group=true&shard.url=127.0.0.1:40052/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878757&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.offset=5&group.limit=5&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5185 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group.format=simple&group=true&shard.url=127.0.0.1:40052/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878757&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=5&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5188 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.format=simple&shard.url=127.0.0.1:40052/zxo/o&fl=id,a_si,id&offset=5&ids=22,23,500,501,502,503,504,9,8,1,10,3,2,5,4,7,6,15,16,17,18,11,12,14,19,100,21,20&isShard=true&NOW=1355888878757&wt=javabin&rows=100&rows=5&distrib=false&group.offset=5&group.limit=5&version=2&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5189 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.format=simple&group=true&shards=127.0.0.1:40052/zxo/o&fl=id,a_si&offset=5&wt=javabin&rows=100&rows=5&group.offset=5&group.limit=5&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=8
[junit4:junit4] 2> 5191 T2622 C129 REQ [collection1] webapp=/zxo/o path=/select params={group=true&fl=id,a_si&offset=5&wt=javabin&rows=100&rows=5&distrib=false&group.main=true&group.offset=5&group.limit=5&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=0
[junit4:junit4] 2> 5195 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::083]:33332/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878769&wt=javabin&rows=100&distrib=false&group.main=true&group.distributed.first=true&group.offset=5&group.limit=5&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5199 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&shard.url=127.0.0.1:40052/zxo/o|[ff01::083]:33332/zxo/o&fl=id&offset=5&isShard=true&NOW=1355888878769&wt=javabin&rows=100&distrib=false&group.main=true&group.distributed.second=true&group.limit=5&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 5202 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={shard.url=127.0.0.1:40052/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si,id&offset=5&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&isShard=true&NOW=1355888878769&wt=javabin&rows=100&rows=5&distrib=false&group.main=true&group.offset=5&group.limit=5&version=2&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5203 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&shards=127.0.0.1:40052/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si&offset=5&wt=javabin&rows=100&rows=5&group.main=true&group.offset=5&group.limit=5&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=10
[junit4:junit4] 2> 5207 T2623 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&distrib=false&group.limit=10&version=2&group.query=a_t:kings+OR+a_t:eggs&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} hits=172 status=0 QTime=2
[junit4:junit4] 2> 5218 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&group.query=a_t:kings+OR+a_t:eggs&shard.url=[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o&fl=id&isShard=true&NOW=1355888878785&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=7
[junit4:junit4] 2> 5221 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.query=a_t:kings+OR+a_t:eggs&shard.url=[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o&fl=id,a_si,id&ids=19,20,21,23,18,22,8&isShard=true&NOW=1355888878785&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*} status=0 QTime=0
[junit4:junit4] 2> 5221 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.limit=10&version=2&group.query=a_t:kings+OR+a_t:eggs&shards=[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o|127.0.0.1:40052/zxo/o&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=12
[junit4:junit4] 2> 5224 T2624 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&distrib=false&group.limit=10&version=2&group.query=a_t:kings+OR+a_t:eggs&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} hits=172 status=0 QTime=1
[junit4:junit4] 2> 5228 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&group.query=a_t:kings+OR+a_t:eggs&shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878802&wt=javabin&rows=100&distrib=false&group.distributed.first=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=0
[junit4:junit4] 2> 5232 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&group=true&group.query=a_t:kings+OR+a_t:eggs&shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878802&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=2
[junit4:junit4] 2> 5235 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.query=a_t:kings+OR+a_t:eggs&shard.url=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o&fl=id,a_si,id&ids=16,15,18,17,12,11,14,19,103,104,105,100,101,102,20,21,23,22,500,502,501,504,503,506,505,508,507,509,8,9,1,10,2,3,4,5,6,7&isShard=true&NOW=1355888878802&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*&group.field=a_si} status=0 QTime=1
[junit4:junit4] 2> 5236 T2632 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.limit=10&version=2&group.query=a_t:kings+OR+a_t:eggs&shards=127.0.0.1:40052/zxo/o|[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o|[ff01::213]:33332/zxo/o&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.field=a_si} status=0 QTime=10
[junit4:junit4] 2> 5239 T2622 C129 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&distrib=false&group.limit=10&version=2&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} hits=172 status=0 QTime=1
[junit4:junit4] 2> 5243 T2634 C130 REQ [collection1] webapp=/zxo/o path=/select params={group=true&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id&isShard=true&NOW=1355888878817&wt=javabin&rows=100&distrib=false&group.distributed.second=true&group.limit=10&start=0&version=2&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=0
[junit4:junit4] 2> 5246 T2635 C130 REQ [collection1] webapp=/zxo/o path=/select params={group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&shard.url=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si,id&ids=21,20,19,5,8,22,23,18&isShard=true&NOW=1355888878817&wt=javabin&rows=100&distrib=false&group.limit=10&version=2&q=*:*} status=0 QTime=1
[junit4:junit4] 2> 5246 T2633 C130 REQ [collection1] webapp=/zxo/o path=/select params={wt=javabin&group=true&rows=100&group.limit=10&version=2&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&shards=127.0.0.1:40052/zxo/o|[ff01::213]:33332/zxo/o|[ff01::114]:33332/zxo/o|[ff01::083]:33332/zxo/o&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=5
[junit4:junit4] 2> 5248 T2615 oas.BaseDistributedSearchTestCase.compareResponses SEVERE Mismatched responses:
[junit4:junit4] 2> {responseHeader={status=0,QTime=5},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> 5270 T2615 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=22564721
[junit4:junit4] 2> 5271 T2615 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@cf2770
[junit4:junit4] 2> 5275 T2615 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> 5276 T2615 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4] 2> 5277 T2615 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4] 2> 5277 T2615 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4] 2> 5278 T2615 C129 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index
[junit4:junit4] 2> 5279 T2615 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4] 2> 5279 T2615 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index
[junit4:junit4] 2> 5279 T2615 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index
[junit4:junit4] 2> 5280 T2615 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data/index
[junit4:junit4] 2> 5309 T2615 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data
[junit4:junit4] 2> 5310 T2615 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/control/data
[junit4:junit4] 2> 5311 T2615 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/zxo/o,null}
[junit4:junit4] 2> 5384 T2615 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=11860612
[junit4:junit4] 2> 5385 T2615 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@16ac2ae
[junit4:junit4] 2> 5394 T2615 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> 5395 T2615 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4] 2> 5396 T2615 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4] 2> 5397 T2615 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4] 2> 5399 T2615 C130 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index
[junit4:junit4] 2> 5400 T2615 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4] 2> 5400 T2615 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index
[junit4:junit4] 2> 5401 T2615 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data
[junit4:junit4] 2> 5401 T2615 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data
[junit4:junit4] 2> 5402 T2615 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index
[junit4:junit4] 2> 5402 T2615 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355888873579/shard0/data/index
[junit4:junit4] 2> 5430 T2615 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/zxo/o,null}
[junit4:junit4] 2> 5487 T2615 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDistributedGrouping -Dtests.method=testDistribSearch -Dtests.seed=9C6C4FBA7A298174 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es_US -Dtests.timezone=SystemV/HST10 -Dtests.file.encoding=UTF-8
[junit4:junit4] FAILURE 5.53s 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([9C6C4FBA7A298174:1D8AC1A20D76E148]: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> 5532 T2615 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 2> NOTE: test params are: codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST, chunkSize=421)), sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=es_US, timezone=SystemV/HST10
[junit4:junit4] 2> NOTE: Linux 3.2.0-35-generic i386/Oracle Corporation 1.8.0-ea (32-bit)/cpus=8,threads=1,free=348994504,total=536870912
[junit4:junit4] 2> NOTE: All tests run in this JVM: [ZkNodePropsTest, TestUpdate, CollectionsAPIDistributedZkTest, TestLRUCache, SuggesterTest, TestSolrXMLSerializer, LeaderElectionTest, TestUtils, TestQuerySenderListener, MultiTermTest, TermVectorComponentTest, BasicDistributedZk2Test, UUIDFieldTest, OpenExchangeRatesOrgProviderTest, TestStressLucene, TestCodecSupport, TestArbitraryIndexDir, DOMUtilTest, TestSolrJ, TestFoldingMultitermQuery, TestReplicationHandler, TestSolrDeletionPolicy1, FileUtilsTest, TestMergePolicyConfig, StatsComponentTest, TestPluginEnable, ShardRoutingTest, StandardRequestHandlerTest, TestBinaryField, UpdateParamsTest, RAMDirectoryFactoryTest, PingRequestHandlerTest, TestSurroundQueryParser, ShardRoutingCustomTest, BasicZkTest, DisMaxRequestHandlerTest, SolrInfoMBeanTest, URLClassifyProcessorTest, TestWriterPerf, TestSolrDeletionPolicy2, PrimitiveFieldTypeTest, IndexReaderFactoryTest, DocumentAnalysisRequestHandlerTest, OverseerTest, IndexSchemaTest, TestDocumentBuilder, SolrIndexConfigTest, SyncSliceTest, DirectSolrSpellCheckerTest, SignatureUpdateProcessorFactoryTest, TestPhraseSuggestions, DebugComponentTest, DirectUpdateHandlerTest, PeerSyncTest, LegacyHTMLStripCharFilterTest, ResponseLogComponentTest, TestCSVLoader, TestTrie, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestRealTimeGet, TestDistributedGrouping]
[junit4:junit4] Completed on J1 in 5.55s, 1 test, 1 failure <<< FAILURES!
[...truncated 368 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:353: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:178: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:438: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1175: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:840: There were test failures: 243 suites, 1008 tests, 1 failure, 7 ignored (2 assumptions)
Total time: 28 minutes 39 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 32bit/jdk1.8.0-ea-b65 -server -XX:+UseG1GC
Email was triggered for: Failure
Sending email for trigger: Failure