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/20 00:53:15 UTC
[JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.8.0-ea-b65) - Build #
3311 - Failure!
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Linux/3311/
Java: 64bit/jdk1.8.0-ea-b65 -XX:+UseSerialGC
1 tests failed.
REGRESSION: org.apache.solr.TestDistributedGrouping.testDistribSearch
Error Message:
.grouped.id:5!=a_t:kings OR a_t:eggs (unordered or missing)
Stack Trace:
junit.framework.AssertionFailedError: .grouped.id:5!=a_t:kings OR a_t:eggs (unordered or missing)
at __randomizedtesting.SeedInfo.seed([77CFC390E60CDDC:869A7221793FADE0]: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 8930 lines...]
[junit4:junit4] Suite: org.apache.solr.TestDistributedGrouping
[junit4:junit4] 2> 0 T2345 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /zr_hwj/
[junit4:junit4] 2> 4 T2345 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4:junit4] 2> 6 T2345 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4] 2> 19 T2345 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:40236
[junit4:junit4] 2> 21 T2345 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 23 T2345 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> 24 T2345 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> 36 T2345 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 37 T2345 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 38 T2345 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> 39 T2345 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> 40 T2345 oasc.CoreContainer.<init> New CoreContainer 120452726
[junit4:junit4] 2> 41 T2345 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> 42 T2345 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> 63 T2345 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4] 2> 64 T2345 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 68 T2345 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 69 T2345 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 72 T2345 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 74 T2345 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 75 T2345 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 76 T2345 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 76 T2345 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 77 T2345 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4] 2> 85 T2345 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4] 2> 109 T2355 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> 110 T2355 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> 110 T2355 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> 111 T2355 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> 160 T2355 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 207 T2355 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 208 T2355 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 211 T2355 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4] 2> 692 T2355 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 696 T2355 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 698 T2355 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 703 T2355 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 707 T2355 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 711 T2355 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 712 T2355 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 713 T2355 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-1355960938550/control/data/
[junit4:junit4] 2> 713 T2355 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@32bd19b9
[junit4:junit4] 2> 713 T2355 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 714 T2355 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-1355960938550/control/data forceNew:false
[junit4:junit4] 2> 715 T2355 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data
[junit4:junit4] 2> 715 T2355 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355960938550/control/data/index/
[junit4:junit4] 2> 716 T2355 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355960938550/control/data/index' doesn't exist. Creating new index...
[junit4:junit4] 2> 716 T2355 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-1355960938550/control/data/index forceNew:false
[junit4:junit4] 2> 718 T2355 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@2f3190c2 lockFactory=org.apache.lucene.store.NativeFSLockFactory@50d66953)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 718 T2355 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 718 T2355 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data/index
[junit4:junit4] 2> 719 T2355 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4] 2> 720 T2355 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 720 T2355 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4] 2> 721 T2355 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 721 T2355 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4] 2> 722 T2355 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 722 T2355 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 722 T2355 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 723 T2355 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 724 T2355 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 724 T2355 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4] 2> 725 T2355 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4] 2> 725 T2355 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 726 T2355 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4] 2> 726 T2355 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4] 2> 726 T2355 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4] 2> 727 T2355 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 728 T2355 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 728 T2355 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 729 T2355 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 729 T2355 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 730 T2355 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 730 T2355 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 731 T2355 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 731 T2355 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 732 T2355 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4] 2> 733 T2355 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 737 T2355 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 739 T2355 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4] 2> 741 T2355 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-QUERYSENDER.XML, SCHEMA-MINIMAL.XML, SOLRCONFIG-NOCACHE.XML, SCHEMA11.XML, FRENCHARTICLES.TXT, SOLRCONFIG-CACHING.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, DA_COMPOUNDDICTIONARY.TXT, TRIVIAL.UPDATEPROCESSOR0.JS, CONDITIONAL.UPDATEPROCESSOR.JS, SOLRCONFIG_PERF.XML, PHRASESUGGEST.TXT, SOLRCONFIG-LAZYWRITER.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-BASIC.XML, HUNSPELL-TEST.DIC, SCHEMA-LMDIRICHLET.XML, SCHEMA-SPATIAL.XML, SOLRCONFIG-SLAVE1.XML, STOPTYPES-2.TXT, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA.XML, SCHEMA-SIM.XML, SOLRCONFIG-PROPINJECT.XML, ELEVATE.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SOLRCONFIG-DELPOLICY2.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SCHEMA-REPLICATION1.XML, KEEP-1.TXT, SOLRCONFIG-XINCLUDE.XML, SCHEMA_CODEC.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, OLD_SYNONYMS.TXT, SCHEMA-SNIPPET-TYPE.XML, SCHEMA-REQUIRED-FIELDS.XML, OPEN-EXCHANGE-RATES.JSON, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-SPELLCHECKER.XML, SYNONYMS.TXT, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-MERGEPOLICY.XML, STOP-2.TXT, SOLRCONFIG-REQHANDLER.INCL, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, PROTWORDS.TXT, ADDFIELDS.UPDATEPROCESSOR.JS, SCHEMA-FOLDING.XML, HYPHENATION.DTD, STOPWORDSWRONGENCODING.TXT, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, DA_UTF8.XML, JASUGGEST.TXT, SCHEMA-LMJELINEKMERCER.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SOLRCONFIG-DELPOLICY1.XML, SCHEMASURROUND.XML, HUNSPELL-TEST.AFF, SCHEMA-BM25.XML, BAD_SOLRCONFIG.XML, WDFTYPES.TXT, SCHEMA-EFF.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-SIMPLELOCK.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, SCHEMA-SNIPPET-FIELD.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG_CODEC.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SCHEMA-IB.XML, SOLRCONFIG-NATIVELOCK.XML, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, CURRENCY.XML, SCHEMA15.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SCHEMA-SPELLCHECKER.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-MASTER2.XML, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SCHEMA-DUP-FIELD.XML, COMPOUNDDICTIONARY.TXT, STOPTYPES-1.TXT, SCHEMA-DFR.XML, SCHEMA-REVERSED.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA-STOP-KEEP.XML, STOPWORDS.TXT, STOP-SNOWBALL.TXT, SCHEMA-REPLICATION2.XML, STOP-1.TXT, SOLRCONFIG-ELEVATE.XML, SOLRCONFIG-MASTER.XML, SCHEMA-XINCLUDE.XML, SCHEMA-NUMERIC.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-COLLATE.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-CHARFILTERS.XML, SOLRCONFIG-MASTER1.XML, SCHEMA-TRIE.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, STEMDICT.TXT, SOLRCONFIG-TRANSFORMERS.XML, SCHEMA-TFIDF.XML, XSLT, SOLRCONFIG-ALTDIRECTORY.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, KEEP-2.TXT, STOPWITHBOM.TXT, SOLRCONFIG-SNIPPET-PROCESSOR.XML, FUZZYSUGGEST.TXT, SOLRCONFIG-ENABLEPLUGIN.XML, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, BAD-MP-SOLRCONFIG.XML, SOLRCONFIG-SLAVE.XML, SCHEMA-BINARYFIELD.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SCHEMA12.XML, SOLRCONFIG-SOLR-749.XML, MAPPING-ISOLATIN1ACCENT.TXT, SOLRCONFIG-MASTER3.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SOLRCONFIG-HIGHLIGHT.XML, SOLRCONFIG-TLOG.XML]
[junit4:junit4] 2> 742 T2355 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data
[junit4:junit4] 2> 742 T2355 oass.SolrIndexSearcher.<init> Opening Searcher@6250aaba main
[junit4:junit4] 2> 743 T2355 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 743 T2355 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 743 T2355 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 820 T2355 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4] 2> 856 T2356 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6250aaba main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 859 T2355 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 859 T2345 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4] 2> 860 T2345 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 861 T2345 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 864 T2345 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4] 2> 867 T2345 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:39300
[junit4:junit4] 2> 875 T2345 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 876 T2345 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> 878 T2345 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> 901 T2345 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 903 T2345 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 905 T2345 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> 905 T2345 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> 906 T2345 oasc.CoreContainer.<init> New CoreContainer 7022812
[junit4:junit4] 2> 906 T2345 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> 907 T2345 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> 923 T2345 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 30000
[junit4:junit4] 2> 925 T2345 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 926 T2345 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4:junit4] 2> 927 T2345 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 927 T2345 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 928 T2345 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 928 T2345 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 929 T2345 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 929 T2345 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 930 T2345 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=30000&connTimeout=15000&retry=false
[junit4:junit4] 2> 936 T2345 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4] 2> 958 T2366 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> 959 T2366 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> 959 T2366 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> 960 T2366 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> 1065 T2366 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 2> 1118 T2366 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 1119 T2366 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 1123 T2366 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4] 2> 2097 T2366 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 2101 T2366 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 2103 T2366 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 2106 T2366 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 2109 T2366 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 2111 T2366 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 2112 T2366 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 2112 T2366 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-1355960938550/shard0/data/
[junit4:junit4] 2> 2112 T2366 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@32bd19b9
[junit4:junit4] 2> 2113 T2366 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 2114 T2366 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-1355960938550/shard0/data forceNew:false
[junit4:junit4] 2> 2114 T2366 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data
[junit4:junit4] 2> 2114 T2366 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data/index/
[junit4:junit4] 2> 2114 T2366 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory './org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data/index' doesn't exist. Creating new index...
[junit4:junit4] 2> 2115 T2366 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-1355960938550/shard0/data/index forceNew:false
[junit4:junit4] 2> 2116 T2366 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b65d27f lockFactory=org.apache.lucene.store.NativeFSLockFactory@20d6698f)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 2116 T2366 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 2116 T2366 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data/index
[junit4:junit4] 2> 2117 T2366 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4] 2> 2127 T2366 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 2128 T2366 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4] 2> 2128 T2366 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 2128 T2366 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4] 2> 2128 T2366 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 2128 T2366 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 2129 T2366 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 2129 T2366 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 2130 T2366 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 2130 T2366 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4] 2> 2131 T2366 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4] 2> 2131 T2366 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 2131 T2366 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4] 2> 2132 T2366 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4] 2> 2132 T2366 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4] 2> 2132 T2366 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 2133 T2366 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 2133 T2366 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 2133 T2366 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 2134 T2366 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 2134 T2366 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 2135 T2366 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 2135 T2366 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 2136 T2366 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 2136 T2366 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4] 2> 2136 T2366 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 2139 T2366 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 2140 T2366 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4] 2> 2141 T2366 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-QUERYSENDER.XML, SCHEMA-MINIMAL.XML, SOLRCONFIG-NOCACHE.XML, SCHEMA11.XML, FRENCHARTICLES.TXT, SOLRCONFIG-CACHING.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, DA_COMPOUNDDICTIONARY.TXT, TRIVIAL.UPDATEPROCESSOR0.JS, CONDITIONAL.UPDATEPROCESSOR.JS, SOLRCONFIG_PERF.XML, PHRASESUGGEST.TXT, SOLRCONFIG-LAZYWRITER.XML, SOLRCONFIG-FUNCTIONQUERY.XML, SOLRCONFIG-BASIC.XML, HUNSPELL-TEST.DIC, SCHEMA-LMDIRICHLET.XML, SCHEMA-SPATIAL.XML, SOLRCONFIG-SLAVE1.XML, STOPTYPES-2.TXT, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA.XML, SCHEMA-SIM.XML, SOLRCONFIG-PROPINJECT.XML, ELEVATE.XML, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, SOLRCONFIG-DELPOLICY2.XML, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SCHEMA-REPLICATION1.XML, KEEP-1.TXT, SOLRCONFIG-XINCLUDE.XML, SCHEMA_CODEC.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, OLD_SYNONYMS.TXT, SCHEMA-SNIPPET-TYPE.XML, SCHEMA-REQUIRED-FIELDS.XML, OPEN-EXCHANGE-RATES.JSON, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, TRIVIAL.UPDATEPROCESSOR1.JS, SOLRCONFIG-SPELLCHECKER.XML, SYNONYMS.TXT, BAD-SCHEMA-NONTEXT-ANALYZER.XML, SOLRCONFIG-MERGEPOLICY.XML, STOP-2.TXT, SOLRCONFIG-REQHANDLER.INCL, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, PROTWORDS.TXT, ADDFIELDS.UPDATEPROCESSOR.JS, SCHEMA-FOLDING.XML, HYPHENATION.DTD, STOPWORDSWRONGENCODING.TXT, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, DA_UTF8.XML, JASUGGEST.TXT, SCHEMA-LMJELINEKMERCER.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, SOLRCONFIG-DELPOLICY1.XML, SCHEMASURROUND.XML, HUNSPELL-TEST.AFF, SCHEMA-BM25.XML, BAD_SOLRCONFIG.XML, WDFTYPES.TXT, SCHEMA-EFF.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-BEHAVIOR.XML, SOLRCONFIG-SIMPLELOCK.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML, SCHEMA-SNIPPET-FIELD.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG_CODEC.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, SCHEMA-IB.XML, SOLRCONFIG-NATIVELOCK.XML, SCHEMA-PHRASESUGGEST.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, CURRENCY.XML, SCHEMA15.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SCHEMA-SPELLCHECKER.XML, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-MASTER2.XML, SOLRCONFIG-PHRASESUGGEST.XML, BAD-SCHEMA-DUP-FIELD.XML, COMPOUNDDICTIONARY.TXT, STOPTYPES-1.TXT, SCHEMA-DFR.XML, SCHEMA-REVERSED.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA-STOP-KEEP.XML, STOPWORDS.TXT, STOP-SNOWBALL.TXT, SCHEMA-REPLICATION2.XML, STOP-1.TXT, SOLRCONFIG-ELEVATE.XML, SOLRCONFIG-MASTER.XML, SCHEMA-XINCLUDE.XML, SCHEMA-NUMERIC.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SCHEMA-COLLATE.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, SCHEMA-CHARFILTERS.XML, SOLRCONFIG-MASTER1.XML, SCHEMA-TRIE.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, STEMDICT.TXT, SOLRCONFIG-TRANSFORMERS.XML, SCHEMA-TFIDF.XML, XSLT, SOLRCONFIG-ALTDIRECTORY.XML, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, KEEP-2.TXT, STOPWITHBOM.TXT, SOLRCONFIG-SNIPPET-PROCESSOR.XML, FUZZYSUGGEST.TXT, SOLRCONFIG-ENABLEPLUGIN.XML, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, BAD-MP-SOLRCONFIG.XML, SOLRCONFIG-SLAVE.XML, SCHEMA-BINARYFIELD.XML, SCHEMA-LUCENEMATCHVERSION.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SCHEMA12.XML, SOLRCONFIG-SOLR-749.XML, MAPPING-ISOLATIN1ACCENT.TXT, SOLRCONFIG-MASTER3.XML, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, SOLRCONFIG-HIGHLIGHT.XML, SOLRCONFIG-TLOG.XML]
[junit4:junit4] 2> 2142 T2366 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data
[junit4:junit4] 2> 2143 T2366 oass.SolrIndexSearcher.<init> Opening Searcher@71035af7 main
[junit4:junit4] 2> 2143 T2366 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 2143 T2366 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 2143 T2366 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 2200 T2366 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4] 2> 2227 T2367 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@71035af7 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 2231 T2366 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 2232 T2345 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1
[junit4:junit4] 2> 2233 T2345 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 2233 T2345 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> ASYNC NEW_CORE C122 name=collection1 org.apache.solr.core.SolrCore@66abce24
[junit4:junit4] 2> 2243 T2354 C122 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4] 2> 2244 T2354 C122 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data
[junit4:junit4] 2> 2245 T2354 C122 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@2f3190c2 lockFactory=org.apache.lucene.store.NativeFSLockFactory@50d66953)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 2246 T2354 C122 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 2246 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 4
[junit4:junit4] 2> ASYNC NEW_CORE C123 name=collection1 org.apache.solr.core.SolrCore@11370440
[junit4:junit4] 2> 2251 T2362 C123 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4:junit4] 2> 2252 T2362 C123 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data
[junit4:junit4] 2> 2254 T2362 C123 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b65d27f lockFactory=org.apache.lucene.store.NativeFSLockFactory@20d6698f)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 2255 T2362 C123 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 2255 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {deleteByQuery=*:*} 0 4
[junit4:junit4] 2> 2258 T2353 C122 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 2259 T2353 C122 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@2f3190c2 lockFactory=org.apache.lucene.store.NativeFSLockFactory@50d66953)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@2f3190c2 lockFactory=org.apache.lucene.store.NativeFSLockFactory@50d66953)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4] 2> 2260 T2353 C122 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4] 2> 2260 T2353 C122 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data
[junit4:junit4] 2> 2261 T2353 C122 oass.SolrIndexSearcher.<init> Opening Searcher@7dd3b3aa main
[junit4:junit4] 2> 2261 T2353 C122 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 2262 T2356 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7dd3b3aa main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4] 2> 2262 T2356 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data/index
[junit4:junit4] 2> 2263 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={commit=true&version=2&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 5
[junit4:junit4] 2> 2265 T2363 C123 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 2266 T2363 C123 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b65d27f lockFactory=org.apache.lucene.store.NativeFSLockFactory@20d6698f)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b65d27f lockFactory=org.apache.lucene.store.NativeFSLockFactory@20d6698f)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4] 2> 2266 T2363 C123 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[segments_2]
[junit4:junit4] 2> 2267 T2363 C123 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data
[junit4:junit4] 2> 2267 T2363 C123 oass.SolrIndexSearcher.<init> Opening Searcher@119c87b main
[junit4:junit4] 2> 2268 T2363 C123 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 2268 T2367 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@119c87b main{StandardDirectoryReader(segments_2:2)}
[junit4:junit4] 2> 2269 T2367 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data/index
[junit4:junit4] 2> 2269 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={commit=true&version=2&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 4
[junit4:junit4] 2> 2278 T2351 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&distrib=false&rows=100&group=true&group.limit=10&q=*:*&fl=id,a_si&sort=a_si+asc,+id+asc} hits=0 status=0 QTime=7
[junit4:junit4] 2> 2297 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&group=true&rows=100&q=*:*&version=2&shard.url=[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj&start=0&isShard=true&group.distributed.first=true&distrib=false&NOW=1355960940828&group.limit=10&sort=a_si+asc,+id+asc&fl=id} status=0 QTime=10
[junit4:junit4] 2> 2313 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&shards=[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj&rows=100&group=true&group.limit=10&q=*:*&fl=id,a_si&sort=a_si+asc,+id+asc} status=0 QTime=30
[junit4:junit4] 2> 2315 T2352 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&distrib=false&hl.fl=a_t&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&hl=true} hits=0 status=0 QTime=0
[junit4:junit4] 2> 2319 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960940862&hl.fl=a_t&group.limit=10&fl=id&sort=a_si+asc,+id+asc&hl=false} status=0 QTime=0
[junit4:junit4] 2> 2320 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&shards=127.0.0.1:39300/zr_hwj&hl.fl=a_t&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&hl=true} status=0 QTime=3
[junit4:junit4] 2> 2323 T2354 C122 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> 2324 T2354 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&facet=true&distrib=false&facet.field=a_t&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} hits=0 status=0 QTime=3
[junit4:junit4] 2> 2328 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&facet=false&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960940871&facet.field=a_t&group.limit=10&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=0
[junit4:junit4] 2> 2339 T2365 C123 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> 2339 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&f.a_t.facet.limit=160&q=*:*&version=2&start=0&shard.url=[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&facet=true&isShard=true&distrib=false&NOW=1355960940871&facet.field=a_t&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=7
[junit4:junit4] 2> 2344 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&facet=true&shards=[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&facet.field=a_t&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} status=0 QTime=18
[junit4:junit4] 2> 2348 T2353 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=true&wt=javabin&stats.field=a_si&rows=100&group=true&q=*:*&version=2&distrib=false&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} hits=0 status=0 QTime=2
[junit4:junit4] 2> 2352 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=false&wt=javabin&stats.field=a_si&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960940895&group.limit=10&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=0
[junit4:junit4] 2> 2354 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=true&wt=javabin&stats.field=a_si&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960940895&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=0
[junit4:junit4] 2> 2355 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=true&wt=javabin&stats.field=a_si&rows=100&group=true&q=*:*&version=2&shards=127.0.0.1:39300/zr_hwj&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} status=0 QTime=5
[junit4:junit4] 2> 2372 T2351 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&spellcheck.build=true&wt=javabin&rows=100&group=true&q=kings&spellcheck=true&version=2&distrib=false&qt=spellCheckCompRH&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} hits=0 status=0 QTime=15
[junit4:junit4] 2> 2392 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&spellcheck.build=true&wt=javabin&spellcheck.count=1&rows=100&group=true&q=kings&spellcheck=false&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960940919&spellcheck.onlyMorePopular=false&group.limit=10&spellcheck.extendedResults=false&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=0
[junit4:junit4] 2> 2393 T2362 C123 oashc.SpellCheckComponent.finishStage 127.0.0.1:39300/zr_hwj null
[junit4:junit4] 2> 2393 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&spellcheck.build=true&wt=javabin&rows=100&group=true&q=kings&spellcheck=true&version=2&shards=127.0.0.1:39300/zr_hwj&qt=spellCheckCompRH&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} status=0 QTime=19
[junit4:junit4] 2> 2399 T2352 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&group=true&rows=100&q=*:*&version=2&fq=a_s:a&facet=true&distrib=false&facet.field=a_t&group.limit=10&sort=a_si+asc,+id+asc&fl=id,a_si&group.truncate=true} hits=0 status=0 QTime=4
[junit4:junit4] 2> 2407 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&group=true&rows=100&q=*:*&version=2&fq=a_s:a&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&facet=false&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960940946&facet.field=a_t&group.limit=10&sort=a_si+asc,+id+asc&fl=id&group.truncate=true} status=0 QTime=0
[junit4:junit4] 2> 2417 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&group=true&rows=100&f.a_t.facet.limit=160&q=*:*&version=2&fq=a_s:a&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&facet=true&isShard=true&distrib=false&NOW=1355960940946&facet.field=a_t&group.limit=10&sort=a_si+asc,+id+asc&fl=id&group.truncate=true&group.distributed.second=true} status=0 QTime=8
[junit4:junit4] 2> 2418 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&group=true&rows=100&q=*:*&version=2&fq=a_s:a&facet=true&shards=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&facet.field=a_t&group.limit=10&sort=a_si+asc,+id+asc&fl=id,a_si&group.truncate=true} status=0 QTime=17
[junit4:junit4] 2> 2433 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[1]} 0 8
[junit4:junit4] 2> 2436 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[1]} 0 1
[junit4:junit4] 2> 2438 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[2]} 0 0
[junit4:junit4] 2> 2440 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[2]} 0 0
[junit4:junit4] 2> 2443 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[3]} 0 1
[junit4:junit4] 2> 2445 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[3]} 0 0
[junit4:junit4] 2> 2448 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[4]} 0 1
[junit4:junit4] 2> 2450 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[4]} 0 0
[junit4:junit4] 2> 2452 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[5]} 0 0
[junit4:junit4] 2> 2455 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[5]} 0 1
[junit4:junit4] 2> 2457 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[6]} 0 1
[junit4:junit4] 2> 2459 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[6]} 0 1
[junit4:junit4] 2> 2461 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[7]} 0 0
[junit4:junit4] 2> 2463 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[7]} 0 0
[junit4:junit4] 2> 2466 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[8]} 0 1
[junit4:junit4] 2> 2468 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[8]} 0 0
[junit4:junit4] 2> 2471 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[9]} 0 1
[junit4:junit4] 2> 2473 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[9]} 0 0
[junit4:junit4] 2> 2478 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[10]} 0 3
[junit4:junit4] 2> 2483 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[10]} 0 2
[junit4:junit4] 2> 2486 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[11]} 0 1
[junit4:junit4] 2> 2490 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[11]} 0 2
[junit4:junit4] 2> 2493 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[12]} 0 1
[junit4:junit4] 2> 2495 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[12]} 0 1
[junit4:junit4] 2> 2497 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[14]} 0 1
[junit4:junit4] 2> 2499 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[14]} 0 0
[junit4:junit4] 2> 2502 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[15]} 0 1
[junit4:junit4] 2> 2504 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[15]} 0 0
[junit4:junit4] 2> 2507 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[16]} 0 1
[junit4:junit4] 2> 2509 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[16]} 0 0
[junit4:junit4] 2> 2513 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[17]} 0 2
[junit4:junit4] 2> 2516 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[17]} 0 1
[junit4:junit4] 2> 2519 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[18]} 0 1
[junit4:junit4] 2> 2521 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[18]} 0 0
[junit4:junit4] 2> 2524 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[19]} 0 0
[junit4:junit4] 2> 2527 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[19]} 0 1
[junit4:junit4] 2> 2529 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[20]} 0 0
[junit4:junit4] 2> 2532 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[20]} 0 0
[junit4:junit4] 2> 2539 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[21]} 0 4
[junit4:junit4] 2> 2545 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[21]} 0 4
[junit4:junit4] 2> 2552 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[22]} 0 1
[junit4:junit4] 2> 2555 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[22]} 0 0
[junit4:junit4] 2> 2558 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[23]} 0 0
[junit4:junit4] 2> 2560 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[23]} 0 0
[junit4:junit4] 2> 2563 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[100]} 0 0
[junit4:junit4] 2> 2565 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[100]} 0 0
[junit4:junit4] 2> 2567 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[101]} 0 0
[junit4:junit4] 2> 2570 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[101]} 0 1
[junit4:junit4] 2> 2572 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[102]} 0 0
[junit4:junit4] 2> 2574 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[102]} 0 0
[junit4:junit4] 2> 2577 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[103]} 0 1
[junit4:junit4] 2> 2580 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[103]} 0 1
[junit4:junit4] 2> 2582 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[104]} 0 0
[junit4:junit4] 2> 2585 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[104]} 0 1
[junit4:junit4] 2> 2587 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[105]} 0 0
[junit4:junit4] 2> 2589 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[105]} 0 0
[junit4:junit4] 2> 2592 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[106]} 0 1
[junit4:junit4] 2> 2594 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[106]} 0 0
[junit4:junit4] 2> 2599 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[107]} 0 2
[junit4:junit4] 2> 2603 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[107]} 0 2
[junit4:junit4] 2> 2606 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[108]} 0 0
[junit4:junit4] 2> 2609 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[108]} 0 0
[junit4:junit4] 2> 2612 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[109]} 0 1
[junit4:junit4] 2> 2615 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[109]} 0 1
[junit4:junit4] 2> 2618 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[110]} 0 1
[junit4:junit4] 2> 2621 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[110]} 0 1
[junit4:junit4] 2> 2623 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[111]} 0 0
[junit4:junit4] 2> 2626 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[111]} 0 1
[junit4:junit4] 2> 2628 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[112]} 0 0
[junit4:junit4] 2> 2631 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[112]} 0 1
[junit4:junit4] 2> 2633 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[113]} 0 0
[junit4:junit4] 2> 2636 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[113]} 0 1
[junit4:junit4] 2> 2638 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[114]} 0 0
[junit4:junit4] 2> 2641 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[114]} 0 1
[junit4:junit4] 2> 2643 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[115]} 0 0
[junit4:junit4] 2> 2646 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[115]} 0 1
[junit4:junit4] 2> 2648 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[116]} 0 0
[junit4:junit4] 2> 2650 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[116]} 0 0
[junit4:junit4] 2> 2654 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[117]} 0 1
[junit4:junit4] 2> 2658 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[117]} 0 2
[junit4:junit4] 2> 2661 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[118]} 0 1
[junit4:junit4] 2> 2663 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[118]} 0 0
[junit4:junit4] 2> 2665 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[119]} 0 0
[junit4:junit4] 2> 2668 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[119]} 0 1
[junit4:junit4] 2> 2670 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[120]} 0 0
[junit4:junit4] 2> 2672 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[120]} 0 0
[junit4:junit4] 2> 2674 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[121]} 0 0
[junit4:junit4] 2> 2677 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[121]} 0 0
[junit4:junit4] 2> 2680 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[122]} 0 1
[junit4:junit4] 2> 2683 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[122]} 0 1
[junit4:junit4] 2> 2686 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[123]} 0 1
[junit4:junit4] 2> 2689 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[123]} 0 1
[junit4:junit4] 2> 2692 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[124]} 0 1
[junit4:junit4] 2> 2695 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[124]} 0 1
[junit4:junit4] 2> 2697 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[125]} 0 0
[junit4:junit4] 2> 2700 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[125]} 0 0
[junit4:junit4] 2> 2703 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[126]} 0 1
[junit4:junit4] 2> 2706 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[126]} 0 0
[junit4:junit4] 2> 2713 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[127]} 0 4
[junit4:junit4] 2> 2717 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[127]} 0 2
[junit4:junit4] 2> 2720 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[128]} 0 1
[junit4:junit4] 2> 2723 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[128]} 0 1
[junit4:junit4] 2> 2726 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[129]} 0 1
[junit4:junit4] 2> 2728 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[129]} 0 0
[junit4:junit4] 2> 2732 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[130]} 0 0
[junit4:junit4] 2> 2735 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[130]} 0 1
[junit4:junit4] 2> 2738 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[131]} 0 1
[junit4:junit4] 2> 2740 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[131]} 0 0
[junit4:junit4] 2> 2743 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[132]} 0 1
[junit4:junit4] 2> 2746 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[132]} 0 1
[junit4:junit4] 2> 2749 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[133]} 0 1
[junit4:junit4] 2> 2751 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[133]} 0 0
[junit4:junit4] 2> 2754 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[134]} 0 1
[junit4:junit4] 2> 2757 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[134]} 0 0
[junit4:junit4] 2> 2760 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[135]} 0 1
[junit4:junit4] 2> 2762 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[135]} 0 0
[junit4:junit4] 2> 2765 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[136]} 0 1
[junit4:junit4] 2> 2767 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[136]} 0 0
[junit4:junit4] 2> 2770 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[137]} 0 1
[junit4:junit4] 2> 2775 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[137]} 0 2
[junit4:junit4] 2> 2778 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[138]} 0 1
[junit4:junit4] 2> 2781 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[138]} 0 1
[junit4:junit4] 2> 2784 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[139]} 0 1
[junit4:junit4] 2> 2787 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[139]} 0 1
[junit4:junit4] 2> 2790 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[140]} 0 1
[junit4:junit4] 2> 2792 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[140]} 0 0
[junit4:junit4] 2> 2794 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[141]} 0 0
[junit4:junit4] 2> 2797 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[141]} 0 1
[junit4:junit4] 2> 2799 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[142]} 0 0
[junit4:junit4] 2> 2802 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[142]} 0 1
[junit4:junit4] 2> 2805 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[143]} 0 1
[junit4:junit4] 2> 2808 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[143]} 0 1
[junit4:junit4] 2> 2810 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[144]} 0 0
[junit4:junit4] 2> 2813 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[144]} 0 1
[junit4:junit4] 2> 2816 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[145]} 0 1
[junit4:junit4] 2> 2818 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[145]} 0 0
[junit4:junit4] 2> 2821 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[146]} 0 0
[junit4:junit4] 2> 2824 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[146]} 0 0
[junit4:junit4] 2> 2833 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[147]} 0 5
[junit4:junit4] 2> 2839 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[147]} 0 3
[junit4:junit4] 2> 2842 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[148]} 0 1
[junit4:junit4] 2> 2845 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[148]} 0 1
[junit4:junit4] 2> 2847 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[149]} 0 0
[junit4:junit4] 2> 2849 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[149]} 0 0
[junit4:junit4] 2> 2852 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[500]} 0 1
[junit4:junit4] 2> 2854 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[500]} 0 0
[junit4:junit4] 2> 2856 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[501]} 0 0
[junit4:junit4] 2> 2858 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[501]} 0 0
[junit4:junit4] 2> 2861 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[502]} 0 1
[junit4:junit4] 2> 2863 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[502]} 0 0
[junit4:junit4] 2> 2865 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[503]} 0 0
[junit4:junit4] 2> 2867 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[503]} 0 0
[junit4:junit4] 2> 2869 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[504]} 0 0
[junit4:junit4] 2> 2871 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[504]} 0 0
[junit4:junit4] 2> 2874 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[505]} 0 1
[junit4:junit4] 2> 2876 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[505]} 0 1
[junit4:junit4] 2> 2878 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[506]} 0 0
[junit4:junit4] 2> 2880 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[506]} 0 0
[junit4:junit4] 2> 2883 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[507]} 0 1
[junit4:junit4] 2> 2887 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[507]} 0 1
[junit4:junit4] 2> 2890 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[508]} 0 1
[junit4:junit4] 2> 2893 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[508]} 0 1
[junit4:junit4] 2> 2895 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[509]} 0 0
[junit4:junit4] 2> 2898 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[509]} 0 0
[junit4:junit4] 2> 2901 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[510]} 0 1
[junit4:junit4] 2> 2903 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[510]} 0 0
[junit4:junit4] 2> 2905 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[511]} 0 0
[junit4:junit4] 2> 2908 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[511]} 0 1
[junit4:junit4] 2> 2910 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[512]} 0 0
[junit4:junit4] 2> 2913 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[512]} 0 0
[junit4:junit4] 2> 2916 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[513]} 0 1
[junit4:junit4] 2> 2918 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[513]} 0 0
[junit4:junit4] 2> 2921 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[514]} 0 1
[junit4:junit4] 2> 2923 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[514]} 0 1
[junit4:junit4] 2> 2925 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[515]} 0 0
[junit4:junit4] 2> 2927 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[515]} 0 0
[junit4:junit4] 2> 2929 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[516]} 0 0
[junit4:junit4] 2> 2931 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[516]} 0 0
[junit4:junit4] 2> 2934 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[517]} 0 1
[junit4:junit4] 2> 2937 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[517]} 0 1
[junit4:junit4] 2> 2939 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[518]} 0 0
[junit4:junit4] 2> 2941 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[518]} 0 0
[junit4:junit4] 2> 2944 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[519]} 0 1
[junit4:junit4] 2> 2946 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[519]} 0 0
[junit4:junit4] 2> 2948 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[520]} 0 0
[junit4:junit4] 2> 2950 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[520]} 0 0
[junit4:junit4] 2> 2952 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[521]} 0 0
[junit4:junit4] 2> 2954 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[521]} 0 0
[junit4:junit4] 2> 2957 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[522]} 0 1
[junit4:junit4] 2> 2959 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[522]} 0 0
[junit4:junit4] 2> 2961 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[523]} 0 0
[junit4:junit4] 2> 2963 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[523]} 0 0
[junit4:junit4] 2> 2965 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[524]} 0 0
[junit4:junit4] 2> 2967 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[524]} 0 0
[junit4:junit4] 2> 2969 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[525]} 0 0
[junit4:junit4] 2> 2971 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[525]} 0 0
[junit4:junit4] 2> 2989 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[526]} 0 0
[junit4:junit4] 2> 2992 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[526]} 0 0
[junit4:junit4] 2> 2995 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[527]} 0 1
[junit4:junit4] 2> 2999 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[527]} 0 1
[junit4:junit4] 2> 3002 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[528]} 0 1
[junit4:junit4] 2> 3004 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[528]} 0 0
[junit4:junit4] 2> 3009 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[529]} 0 0
[junit4:junit4] 2> 3012 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[529]} 0 0
[junit4:junit4] 2> 3015 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[530]} 0 1
[junit4:junit4] 2> 3019 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[530]} 0 0
[junit4:junit4] 2> 3022 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[531]} 0 0
[junit4:junit4] 2> 3024 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[531]} 0 0
[junit4:junit4] 2> 3027 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[532]} 0 0
[junit4:junit4] 2> 3029 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[532]} 0 0
[junit4:junit4] 2> 3032 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[533]} 0 1
[junit4:junit4] 2> 3034 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[533]} 0 0
[junit4:junit4] 2> 3037 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[534]} 0 1
[junit4:junit4] 2> 3040 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[534]} 0 1
[junit4:junit4] 2> 3042 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[535]} 0 0
[junit4:junit4] 2> 3045 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[535]} 0 0
[junit4:junit4] 2> 3048 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[536]} 0 1
[junit4:junit4] 2> 3050 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[536]} 0 0
[junit4:junit4] 2> 3054 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[537]} 0 1
[junit4:junit4] 2> 3058 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[537]} 0 2
[junit4:junit4] 2> 3060 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[538]} 0 0
[junit4:junit4] 2> 3063 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[538]} 0 0
[junit4:junit4] 2> 3066 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[539]} 0 0
[junit4:junit4] 2> 3069 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[539]} 0 0
[junit4:junit4] 2> 3072 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[540]} 0 1
[junit4:junit4] 2> 3075 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[540]} 0 1
[junit4:junit4] 2> 3077 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[541]} 0 0
[junit4:junit4] 2> 3080 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[541]} 0 0
[junit4:junit4] 2> 3083 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[542]} 0 0
[junit4:junit4] 2> 3086 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[542]} 0 0
[junit4:junit4] 2> 3092 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[543]} 0 0
[junit4:junit4] 2> 3095 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[543]} 0 0
[junit4:junit4] 2> 3098 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[544]} 0 0
[junit4:junit4] 2> 3100 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[544]} 0 0
[junit4:junit4] 2> 3103 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[545]} 0 0
[junit4:junit4] 2> 3106 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[545]} 0 1
[junit4:junit4] 2> 3108 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[546]} 0 0
[junit4:junit4] 2> 3111 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[546]} 0 1
[junit4:junit4] 2> 3114 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[547]} 0 1
[junit4:junit4] 2> 3118 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[547]} 0 1
[junit4:junit4] 2> 3121 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[548]} 0 0
[junit4:junit4] 2> 3124 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[548]} 0 1
[junit4:junit4] 2> 3127 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[549]} 0 1
[junit4:junit4] 2> 3130 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[549]} 0 1
[junit4:junit4] 2> 3132 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[550]} 0 0
[junit4:junit4] 2> 3135 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[550]} 0 0
[junit4:junit4] 2> 3138 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[551]} 0 1
[junit4:junit4] 2> 3141 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[551]} 0 1
[junit4:junit4] 2> 3144 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[552]} 0 1
[junit4:junit4] 2> 3147 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[552]} 0 0
[junit4:junit4] 2> 3150 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[553]} 0 0
[junit4:junit4] 2> 3152 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[553]} 0 0
[junit4:junit4] 2> 3155 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[554]} 0 0
[junit4:junit4] 2> 3157 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[554]} 0 0
[junit4:junit4] 2> 3160 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[555]} 0 1
[junit4:junit4] 2> 3162 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[555]} 0 0
[junit4:junit4] 2> 3164 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[556]} 0 0
[junit4:junit4] 2> 3166 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[556]} 0 0
[junit4:junit4] 2> 3169 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[557]} 0 1
[junit4:junit4] 2> 3172 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[557]} 0 1
[junit4:junit4] 2> 3174 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[558]} 0 0
[junit4:junit4] 2> 3176 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[558]} 0 0
[junit4:junit4] 2> 3179 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[559]} 0 1
[junit4:junit4] 2> 3181 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[559]} 0 0
[junit4:junit4] 2> 3184 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[560]} 0 1
[junit4:junit4] 2> 3186 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[560]} 0 0
[junit4:junit4] 2> 3188 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[561]} 0 0
[junit4:junit4] 2> 3190 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[561]} 0 0
[junit4:junit4] 2> 3193 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[562]} 0 1
[junit4:junit4] 2> 3195 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[562]} 0 0
[junit4:junit4] 2> 3197 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[563]} 0 0
[junit4:junit4] 2> 3199 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[563]} 0 0
[junit4:junit4] 2> 3202 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[564]} 0 1
[junit4:junit4] 2> 3204 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[564]} 0 0
[junit4:junit4] 2> 3206 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[565]} 0 0
[junit4:junit4] 2> 3208 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[565]} 0 0
[junit4:junit4] 2> 3211 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[566]} 0 1
[junit4:junit4] 2> 3213 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[566]} 0 1
[junit4:junit4] 2> 3216 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[567]} 0 1
[junit4:junit4] 2> 3219 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[567]} 0 1
[junit4:junit4] 2> 3222 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[568]} 0 1
[junit4:junit4] 2> 3224 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[568]} 0 0
[junit4:junit4] 2> 3226 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[569]} 0 0
[junit4:junit4] 2> 3228 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[569]} 0 0
[junit4:junit4] 2> 3231 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[570]} 0 1
[junit4:junit4] 2> 3233 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[570]} 0 0
[junit4:junit4] 2> 3235 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[571]} 0 0
[junit4:junit4] 2> 3237 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[571]} 0 0
[junit4:junit4] 2> 3239 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[572]} 0 0
[junit4:junit4] 2> 3241 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[572]} 0 0
[junit4:junit4] 2> 3243 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[573]} 0 0
[junit4:junit4] 2> 3247 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[573]} 0 0
[junit4:junit4] 2> 3257 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[574]} 0 0
[junit4:junit4] 2> 3260 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[574]} 0 1
[junit4:junit4] 2> 3263 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[575]} 0 1
[junit4:junit4] 2> 3265 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[575]} 0 0
[junit4:junit4] 2> 3267 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[576]} 0 0
[junit4:junit4] 2> 3270 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[576]} 0 0
[junit4:junit4] 2> 3274 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[577]} 0 2
[junit4:junit4] 2> 3277 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[577]} 0 1
[junit4:junit4] 2> 3280 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[578]} 0 0
[junit4:junit4] 2> 3283 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[578]} 0 1
[junit4:junit4] 2> 3285 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[579]} 0 0
[junit4:junit4] 2> 3288 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[579]} 0 1
[junit4:junit4] 2> 3290 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[580]} 0 0
[junit4:junit4] 2> 3292 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[580]} 0 0
[junit4:junit4] 2> 3295 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[581]} 0 0
[junit4:junit4] 2> 3298 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[581]} 0 1
[junit4:junit4] 2> 3300 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[582]} 0 0
[junit4:junit4] 2> 3302 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[582]} 0 0
[junit4:junit4] 2> 3304 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[583]} 0 0
[junit4:junit4] 2> 3306 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[583]} 0 0
[junit4:junit4] 2> 3308 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[584]} 0 0
[junit4:junit4] 2> 3310 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[584]} 0 0
[junit4:junit4] 2> 3312 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[585]} 0 1
[junit4:junit4] 2> 3314 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[585]} 0 1
[junit4:junit4] 2> 3315 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[586]} 0 0
[junit4:junit4] 2> 3317 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[586]} 0 0
[junit4:junit4] 2> 3320 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[587]} 0 1
[junit4:junit4] 2> 3322 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[587]} 0 1
[junit4:junit4] 2> 3325 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[588]} 0 1
[junit4:junit4] 2> 3327 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[588]} 0 0
[junit4:junit4] 2> 3329 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[589]} 0 0
[junit4:junit4] 2> 3331 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[589]} 0 0
[junit4:junit4] 2> 3334 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[590]} 0 1
[junit4:junit4] 2> 3336 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[590]} 0 1
[junit4:junit4] 2> 3338 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[591]} 0 0
[junit4:junit4] 2> 3341 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[591]} 0 1
[junit4:junit4] 2> 3350 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[592]} 0 1
[junit4:junit4] 2> 3354 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[592]} 0 2
[junit4:junit4] 2> 3359 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[593]} 0 0
[junit4:junit4] 2> 3362 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[593]} 0 1
[junit4:junit4] 2> 3365 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[594]} 0 1
[junit4:junit4] 2> 3367 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[594]} 0 0
[junit4:junit4] 2> 3369 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[595]} 0 0
[junit4:junit4] 2> 3372 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[595]} 0 0
[junit4:junit4] 2> 3375 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[596]} 0 0
[junit4:junit4] 2> 3377 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[596]} 0 0
[junit4:junit4] 2> 3380 T2353 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[597]} 0 1
[junit4:junit4] 2> 3384 T2362 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[597]} 0 1
[junit4:junit4] 2> 3386 T2354 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[598]} 0 0
[junit4:junit4] 2> 3389 T2365 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[598]} 0 0
[junit4:junit4] 2> 3392 T2352 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[599]} 0 1
[junit4:junit4] 2> 3394 T2364 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={version=2&wt=javabin} {add=[599]} 0 0
[junit4:junit4] 2> 3396 T2351 C122 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 3400 T2351 C122 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@2f3190c2 lockFactory=org.apache.lucene.store.NativeFSLockFactory@50d66953)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@2f3190c2 lockFactory=org.apache.lucene.store.NativeFSLockFactory@50d66953)),segFN=segments_3,generation=3,filenames=[_h_Lucene40_0.tip, _g.si, _i_nrm.cfs, _i_Lucene40_0.tim, _j_Lucene40_0.tip, _h.si, _j_nrm.cfs, _g_Lucene40_0.tim, _i_nrm.cfe, _j_Lucene40_0.prx, _i.fdt, _i_Lucene40_0.prx, _i.fnm, _h_Lucene40_0.tim, _h_Lucene40_0.prx, _i.fdx, _g.fnm, _g_Lucene40_0.tip, _g_Lucene40_0.frq, _i_Lucene40_0.frq, _g_nrm.cfs, _j.si, _h.fdx, _h.fdt, _j.fdx, _j_nrm.cfe, _h_Lucene40_0.frq, _j_Lucene40_0.tim, _h_nrm.cfe, _h_nrm.cfs, _g.fdt, _i.si, _g_Lucene40_0.prx, _i_Lucene40_0.tip, _g_nrm.cfe, _j.fdt, _j_Lucene40_0.frq, _h.fnm, _j.fnm, segments_3, _g.fdx]
[junit4:junit4] 2> 3401 T2351 C122 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_h_Lucene40_0.tip, _g.si, _i_nrm.cfs, _i_Lucene40_0.tim, _j_Lucene40_0.tip, _h.si, _j_nrm.cfs, _g_Lucene40_0.tim, _i_nrm.cfe, _j_Lucene40_0.prx, _i.fdt, _i_Lucene40_0.prx, _i.fnm, _h_Lucene40_0.tim, _h_Lucene40_0.prx, _i.fdx, _g.fnm, _g_Lucene40_0.tip, _g_Lucene40_0.frq, _i_Lucene40_0.frq, _g_nrm.cfs, _j.si, _h.fdx, _h.fdt, _j.fdx, _j_nrm.cfe, _h_Lucene40_0.frq, _j_Lucene40_0.tim, _h_nrm.cfe, _h_nrm.cfs, _g.fdt, _i.si, _g_Lucene40_0.prx, _i_Lucene40_0.tip, _g_nrm.cfe, _j.fdt, _j_Lucene40_0.frq, _h.fnm, _j.fnm, segments_3, _g.fdx]
[junit4:junit4] 2> 3402 T2351 C122 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data
[junit4:junit4] 2> 3455 T2351 C122 oass.SolrIndexSearcher.<init> Opening Searcher@33fb2718 main
[junit4:junit4] 2> 3456 T2351 C122 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 3457 T2356 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@33fb2718 main{StandardDirectoryReader(segments_3:42 _g(5.0):C150 _h(5.0):C10 _i(5.0):C10 _j(5.0):C2)}
[junit4:junit4] 2> 3457 T2356 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data/index
[junit4:junit4] 2> 3457 T2351 C122 UPDATE [collection1] webapp=/zr_hwj path=/update params={commit=true&version=2&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 61
[junit4:junit4] 2> 3459 T2363 C123 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 3462 T2363 C123 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b65d27f lockFactory=org.apache.lucene.store.NativeFSLockFactory@20d6698f)),segFN=segments_2,generation=2,filenames=[segments_2]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirWrapper(org.apache.lucene.store.RAMDirectory@6b65d27f lockFactory=org.apache.lucene.store.NativeFSLockFactory@20d6698f)),segFN=segments_3,generation=3,filenames=[_h_Lucene40_0.tip, _g.si, _i_nrm.cfs, _i_Lucene40_0.tim, _j_Lucene40_0.tip, _h.si, _j_nrm.cfs, _g_Lucene40_0.tim, _i_nrm.cfe, _j_Lucene40_0.prx, _i.fdt, _i_Lucene40_0.prx, _i.fnm, _h_Lucene40_0.tim, _h_Lucene40_0.prx, _i.fdx, _g.fnm, _g_Lucene40_0.tip, _g_Lucene40_0.frq, _i_Lucene40_0.frq, _g_nrm.cfs, _j.si, _h.fdx, _h.fdt, _j.fdx, _j_nrm.cfe, _h_Lucene40_0.frq, _j_Lucene40_0.tim, _h_nrm.cfe, _h_nrm.cfs, _g.fdt, _i.si, _g_Lucene40_0.prx, _i_Lucene40_0.tip, _g_nrm.cfe, _j.fdt, _j_Lucene40_0.frq, _h.fnm, _j.fnm, segments_3, _g.fdx]
[junit4:junit4] 2> 3463 T2363 C123 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_h_Lucene40_0.tip, _g.si, _i_nrm.cfs, _i_Lucene40_0.tim, _j_Lucene40_0.tip, _h.si, _j_nrm.cfs, _g_Lucene40_0.tim, _i_nrm.cfe, _j_Lucene40_0.prx, _i.fdt, _i_Lucene40_0.prx, _i.fnm, _h_Lucene40_0.tim, _h_Lucene40_0.prx, _i.fdx, _g.fnm, _g_Lucene40_0.tip, _g_Lucene40_0.frq, _i_Lucene40_0.frq, _g_nrm.cfs, _j.si, _h.fdx, _h.fdt, _j.fdx, _j_nrm.cfe, _h_Lucene40_0.frq, _j_Lucene40_0.tim, _h_nrm.cfe, _h_nrm.cfs, _g.fdt, _i.si, _g_Lucene40_0.prx, _i_Lucene40_0.tip, _g_nrm.cfe, _j.fdt, _j_Lucene40_0.frq, _h.fnm, _j.fnm, segments_3, _g.fdx]
[junit4:junit4] 2> 3463 T2363 C123 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data
[junit4:junit4] 2> 3517 T2363 C123 oass.SolrIndexSearcher.<init> Opening Searcher@632d6155 main
[junit4:junit4] 2> 3518 T2363 C123 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 3519 T2367 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@632d6155 main{StandardDirectoryReader(segments_3:42 _g(5.0):C150 _h(5.0):C10 _i(5.0):C10 _j(5.0):C2)}
[junit4:junit4] 2> 3519 T2367 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data/index
[junit4:junit4] 2> 3520 T2363 C123 UPDATE [collection1] webapp=/zr_hwj path=/update params={commit=true&version=2&softCommit=false&waitSearcher=true&wt=javabin} {commit=} 0 61
[junit4:junit4] 2> 3540 T2353 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&distrib=false&rows=100&group=true&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} hits=172 status=0 QTime=18
[junit4:junit4] 2> 3548 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942089&group.limit=10&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=2
[junit4:junit4] 2> 3580 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942089&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=25
[junit4:junit4] 2> 3615 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&q=*:*&ids=19,17,18,15,16,14,11,12,21,20,105,104,103,102,101,100,505,506,503,504,509,507,508,22,23,501,502,500,3,2,1,10,7,6,5,4,9,8&version=2&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942089&group.limit=10&fl=id,a_si,id} status=0 QTime=12
[junit4:junit4] 2> 3620 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&shards=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&rows=100&group=true&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=76
[junit4:junit4] 2> 3626 T2354 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&distrib=false&rows=100&group=true&group.limit=10&fl=id,a_si&sort=id+asc,+_docid_+asc&q=*:*} hits=172 status=0 QTime=3
[junit4:junit4] 2> 3640 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942174&group.limit=10&fl=id&sort=id+asc,+_docid_+asc} status=0 QTime=1
[junit4:junit4] 2> 3644 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=100&group.topgroups.a_si=50&group.topgroups.a_si=2&group.topgroups.a_si=-100&group.topgroups.a_si=500&group.topgroups.a_si=-600&group.topgroups.a_si=123&group.topgroups.a_si=876&group.topgroups.a_si=7&group.topgroups.a_si=4321&group.topgroups.a_si=-987&group.topgroups.a_si=379&group.topgroups.a_si=%01&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=9999&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942174&group.limit=10&fl=id&sort=id+asc,+_docid_+asc&group.distributed.second=true} status=0 QTime=1
[junit4:junit4] 2> 3648 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&q=*:*&ids=105,104,103,102,101,100,21,20,17,18,15,16,14,11,12,19,9,8,3,2,10,1,7,6,5,4,22,23,501,502,500,505,506,503,504,509,507,508&version=2&shard.url=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942174&group.limit=10&fl=id,a_si,id} status=0 QTime=1
[junit4:junit4] 2> 3650 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&shards=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&rows=100&group=true&group.limit=10&fl=id,a_si&sort=id+asc,+_docid_+asc&q=*:*} status=0 QTime=21
[junit4:junit4] 2> 3654 T2351 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&distrib=false&rows=100&group=true&group.limit=10&fl=id,a_si&sort={!func}add(a_si,5)+asc,+id+asc&q=*:*} hits=172 status=0 QTime=2
[junit4:junit4] 2> 3659 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942201&group.limit=10&fl=id&sort={!func}add(a_si,5)+asc,+id+asc} status=0 QTime=1
[junit4:junit4] 2> 3664 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=%01&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942201&group.limit=10&fl=id&sort={!func}add(a_si,5)+asc,+id+asc&group.distributed.second=true} status=0 QTime=2
[junit4:junit4] 2> 3668 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&q=*:*&ids=103,104,105,100,101,102,20,21,16,15,18,17,12,11,14,19,8,9,10,1,2,3,4,5,6,7,23,22,500,502,501,504,503,506,505,508,507,509&version=2&shard.url=127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942201&group.limit=10&fl=id,a_si,id} status=0 QTime=1
[junit4:junit4] 2> 3680 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&shards=127.0.0.1:39300/zr_hwj&rows=100&group=true&group.limit=10&fl=id,a_si&sort={!func}add(a_si,5)+asc,+id+asc&q=*:*} status=0 QTime=24
[junit4:junit4] 2> 3687 T2353 C122 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=a_t,memSize=5158,tindexSize=41,time=2,phase1=2,nTerms=55,bigTerms=1,termInstances=77,uses=0}
[junit4:junit4] 2> 3688 T2353 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&facet=true&distrib=false&facet.field=a_t&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} hits=172 status=0 QTime=5
[junit4:junit4] 2> 3693 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj&facet=false&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942235&facet.field=a_t&group.limit=10&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=1
[junit4:junit4] 2> 3698 T2363 C123 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> 3699 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&f.a_t.facet.limit=160&q=*:*&version=2&start=0&shard.url=[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj&facet=true&isShard=true&distrib=false&NOW=1355960942235&facet.field=a_t&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=3
[junit4:junit4] 2> 3703 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&q=*:*&ids=7,6,5,4,3,2,1,10,9,8,509,507,508,505,506,503,504,501,502,500,22,23,21,20,102,101,100,105,104,103,19,14,11,12,17,18,15,16&version=2&shard.url=[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj&facet=false&isShard=true&distrib=false&NOW=1355960942235&facet.field=a_t&group.limit=10&fl=id,a_si,id} status=0 QTime=1
[junit4:junit4] 2> 3704 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&facet=true&shards=[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj&facet.field=a_t&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} status=0 QTime=14
[junit4:junit4] 2> 3720 T2352 C122 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> 3721 T2352 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=true&wt=javabin&stats.field=other_tl1&rows=100&group=true&q=*:*&version=2&distrib=false&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} hits=172 status=0 QTime=15
[junit4:junit4] 2> 3726 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=false&wt=javabin&stats.field=other_tl1&rows=100&group=true&q=*:*&version=2&start=0&shard.url=[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942269&group.limit=10&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=0
[junit4:junit4] 2> 3732 T2364 C123 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> 3734 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=true&wt=javabin&stats.field=other_tl1&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942269&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=4
[junit4:junit4] 2> 3738 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=false&wt=javabin&stats.field=other_tl1&rows=100&q=*:*&ids=20,21,105,103,104,101,102,100,19,18,17,16,15,14,12,11,2,3,1,10,6,7,4,5,8,9,506,505,504,503,509,508,507,23,22,502,501,500&version=2&shard.url=[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942269&group.limit=10&fl=id,a_si,id} status=0 QTime=1
[junit4:junit4] 2> 3739 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&stats=true&wt=javabin&stats.field=other_tl1&rows=100&group=true&q=*:*&version=2&shards=[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} status=0 QTime=15
[junit4:junit4] 2> 3752 T2354 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&spellcheck.build=true&wt=javabin&rows=100&group=true&q=kings&spellcheck=true&version=2&distrib=false&qt=spellCheckCompRH&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} hits=1 status=0 QTime=10
[junit4:junit4] 2> 3785 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&spellcheck.build=true&wt=javabin&spellcheck.count=1&rows=100&group=true&q=kings&spellcheck=false&version=2&start=0&shard.url=[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942300&spellcheck.onlyMorePopular=false&group.limit=10&spellcheck.extendedResults=false&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=2
[junit4:junit4] 2> 3788 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&spellcheck.build=true&wt=javabin&spellcheck.count=5&rows=100&group=true&group.topgroups.a_si=876&q=kings&spellcheck=true&version=2&start=0&shard.url=[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942300&spellcheck.onlyMorePopular=false&group.limit=10&spellcheck.extendedResults=false&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=1
[junit4:junit4] 2> 3791 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&spellcheck.build=true&wt=javabin&spellcheck.count=1&rows=100&q=kings&ids=8&spellcheck=false&version=2&shard.url=[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942300&spellcheck.onlyMorePopular=false&group.limit=10&spellcheck.extendedResults=false&fl=id,a_si,id} status=0 QTime=0
[junit4:junit4] 2> 3792 T2363 C123 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj null
[junit4:junit4] 2> 3792 T2363 C123 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj null
[junit4:junit4] 2> 3793 T2363 C123 oashc.SpellCheckComponent.finishStage [ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj null
[junit4:junit4] 2> 3793 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&spellcheck.build=true&wt=javabin&rows=100&group=true&q=kings&spellcheck=true&version=2&shards=[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&qt=spellCheckCompRH&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc} status=0 QTime=38
[junit4:junit4] 2> 3800 T2351 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&facet=true&distrib=false&hl.fl=a_t&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&hl=true} hits=172 status=0 QTime=5
[junit4:junit4] 2> 3805 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&facet=false&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942348&hl.fl=a_t&group.limit=10&fl=id&sort=a_si+asc,+id+asc&hl=false} status=0 QTime=0
[junit4:junit4] 2> 3810 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&facet=true&isShard=true&distrib=false&NOW=1355960942348&hl.fl=a_t&group.limit=10&fl=id&sort=a_si+asc,+id+asc&hl=false&group.distributed.second=true} status=0 QTime=2
[junit4:junit4] 2> 3817 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&q=*:*&ids=12,11,14,16,15,18,17,19,100,101,102,103,104,105,20,21,500,502,501,23,22,508,507,509,504,503,506,505,8,9,4,5,6,7,1,10,2,3&version=2&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&facet=false&isShard=true&distrib=false&NOW=1355960942348&hl.fl=a_t&group.limit=10&fl=id,a_si,id&hl=true} status=0 QTime=4
[junit4:junit4] 2> 3818 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&facet=true&shards=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&hl.fl=a_t&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&hl=true} status=0 QTime=15
[junit4:junit4] 2> 3822 T2353 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&distrib=false&rows=100&group=true&group.sort=id+desc&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3829 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942371&group.sort=id+desc&group.limit=10&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=1
[junit4:junit4] 2> 3832 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942371&group.sort=id+desc&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=1
[junit4:junit4] 2> 3836 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&q=*:*&ids=19,11,12,18,21,20,147,599,148,598,149,143,595,144,594,145,597,146,596,22,23,7,6,5,4,3,2,1,10,140,590,591,142,592,141,593,9,8&version=2&shard.url=[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942371&group.sort=id+desc&group.limit=10&fl=id,a_si,id} status=0 QTime=1
[junit4:junit4] 2> 3838 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&shards=[ff01::213]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&rows=100&group=true&group.sort=id+desc&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=12
[junit4:junit4] 2> 3842 T2352 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&distrib=false&rows=100&group=true&group.limit=5&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.offset=5} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3846 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942389&group.limit=5&fl=id&sort=a_si+asc,+id+asc&group.offset=5} status=0 QTime=0
[junit4:junit4] 2> 3850 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942389&group.limit=5&fl=id&sort=a_si+asc,+id+asc&group.offset=5&group.distributed.second=true} status=0 QTime=1
[junit4:junit4] 2> 3865 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&q=*:*&ids=505,506,509,507,508,105,104,103,102,101&version=2&shard.url=[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942389&group.limit=5&fl=id,a_si,id&group.offset=5} status=0 QTime=12
[junit4:junit4] 2> 3866 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&shards=[ff01::083]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj&rows=100&group=true&group.limit=5&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&group.offset=5} status=0 QTime=22
[junit4:junit4] 2> 3869 T2354 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&group=true&q=*:*&version=2&distrib=false&group.limit=5&fl=id,a_si&sort=a_si+asc,+id+asc&group.offset=5&offset=5} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3874 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942417&group.limit=5&fl=id&sort=a_si+asc,+id+asc&group.offset=5&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3878 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942417&group.limit=5&fl=id&sort=a_si+asc,+id+asc&group.offset=5&group.distributed.second=true&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3881 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&q=*:*&ids=101,102,103,104,105,508,507,509,506,505&version=2&shard.url=127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942417&group.limit=5&fl=id,a_si,id&group.offset=5&offset=5} status=0 QTime=0
[junit4:junit4] 2> 3882 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&group=true&q=*:*&version=2&shards=127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj&group.limit=5&fl=id,a_si&sort=a_si+asc,+id+asc&group.offset=5&offset=5} status=0 QTime=10
[junit4:junit4] 2> 3885 T2351 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&group.format=simple&wt=javabin&distrib=false&rows=100&rows=5&group=true&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&offset=5} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3890 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&group.format=simple&start=0&shard.url=127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942433&fl=id&sort=a_si+asc,+id+asc&offset=5} status=0 QTime=0
[junit4:junit4] 2> 3894 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&group.format=simple&start=0&shard.url=127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942433&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3898 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&q=*:*&ids=9,8,5,4,7,6,10,1,3,2,11,500,12,14,18,23&version=2&group.format=simple&shard.url=127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942433&fl=id,a_si,id&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3899 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&group.format=simple&wt=javabin&shards=127.0.0.1:39300/zr_hwj&rows=100&rows=5&group=true&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&offset=5} status=0 QTime=11
[junit4:junit4] 2> 3902 T2353 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&group.main=true&distrib=false&rows=100&rows=5&group=true&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&offset=5} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3907 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&group.distributed.first=true&isShard=true&group.main=true&distrib=false&NOW=1355960942450&fl=id&sort=a_si+asc,+id+asc&offset=5} status=0 QTime=0
[junit4:junit4] 2> 3911 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&group.main=true&distrib=false&NOW=1355960942450&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3914 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&q=*:*&ids=18,23,14,11,500,12,3,2,10,1,7,6,5,4,9,8&version=2&shard.url=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&group.main=true&distrib=false&NOW=1355960942450&fl=id,a_si,id&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3915 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&shards=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&group.main=true&rows=100&rows=5&group=true&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*&offset=5} status=0 QTime=10
[junit4:junit4] 2> 3918 T2352 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&group=true&q=*:*&version=2&group.format=simple&distrib=false&group.limit=5&fl=id,a_si&sort=a_si+asc,+id+asc&group.offset=5&offset=5} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3923 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&group.format=simple&start=0&shard.url=[ff01::083]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942465&group.limit=5&fl=id&sort=a_si+asc,+id+asc&group.offset=5&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3927 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&group.format=simple&start=0&shard.url=[ff01::083]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942465&group.limit=5&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3933 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&q=*:*&ids=503,504,501,502,500,22,23,7,6,5,4,3,2,1,10,9,8,19,14,11,12,17,18,15,16,21,20,100&version=2&group.format=simple&shard.url=[ff01::083]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&isShard=true&distrib=false&NOW=1355960942465&group.limit=5&fl=id,a_si,id&group.offset=5&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3934 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&group=true&q=*:*&version=2&group.format=simple&shards=[ff01::083]:33332/zr_hwj|[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj&group.limit=5&fl=id,a_si&sort=a_si+asc,+id+asc&group.offset=5&offset=5} status=0 QTime=14
[junit4:junit4] 2> 3937 T2354 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&group=true&q=*:*&version=2&group.main=true&distrib=false&group.limit=5&fl=id,a_si&sort=a_si+asc,+id+asc&group.offset=5&offset=5} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3942 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj&group.distributed.first=true&isShard=true&group.main=true&distrib=false&NOW=1355960942485&group.limit=5&fl=id&sort=a_si+asc,+id+asc&group.offset=5&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3946 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj&isShard=true&group.main=true&distrib=false&NOW=1355960942485&group.limit=5&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3951 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&q=*:*&ids=12,11,14,16,15,18,17,19,100,20,21,500,502,501,23,22,504,503,8,9,4,5,6,7,1,10,2,3&version=2&shard.url=127.0.0.1:39300/zr_hwj&isShard=true&group.main=true&distrib=false&NOW=1355960942485&group.limit=5&fl=id,a_si,id&group.offset=5&offset=5} status=0 QTime=1
[junit4:junit4] 2> 3952 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&rows=100&rows=5&group=true&q=*:*&version=2&shards=127.0.0.1:39300/zr_hwj&group.main=true&group.limit=5&fl=id,a_si&sort=a_si+asc,+id+asc&group.offset=5&offset=5} status=0 QTime=12
[junit4:junit4] 2> 3955 T2351 C122 REQ [collection1] webapp=/zr_hwj path=/select params={version=2&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&distrib=false&rows=100&group=true&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} hits=172 status=0 QTime=1
[junit4:junit4] 2> 3966 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={wt=javabin&group.query=a_t:kings+OR+a_t:eggs&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942503&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=6
[junit4:junit4] 2> 3970 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={wt=javabin&group.query=a_t:kings+OR+a_t:eggs&rows=100&q=*:*&ids=23,18,22,8,19,20,21&version=2&shard.url=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942503&group.limit=10&fl=id,a_si,id} status=0 QTime=1
[junit4:junit4] 2> 3971 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={version=2&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&shards=127.0.0.1:39300/zr_hwj|[ff01::114]:33332/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&rows=100&group=true&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=13
[junit4:junit4] 2> 3976 T2353 C122 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&distrib=false&rows=100&group=true&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} hits=172 status=0 QTime=3
[junit4:junit4] 2> 3982 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&rows=100&group=true&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&group.distributed.first=true&isShard=true&distrib=false&NOW=1355960942525&group.limit=10&fl=id&sort=a_si+asc,+id+asc} status=0 QTime=0
[junit4:junit4] 2> 3987 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&rows=100&group=true&group.topgroups.a_si=-987&group.topgroups.a_si=-600&group.topgroups.a_si=-100&group.topgroups.a_si=2&group.topgroups.a_si=7&group.topgroups.a_si=50&group.topgroups.a_si=100&group.topgroups.a_si=123&group.topgroups.a_si=232&group.topgroups.a_si=233&group.topgroups.a_si=379&group.topgroups.a_si=500&group.topgroups.a_si=876&group.topgroups.a_si=4321&group.topgroups.a_si=9999&group.topgroups.a_si=%01&q=*:*&version=2&start=0&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942525&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=2
[junit4:junit4] 2> 3991 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&rows=100&q=*:*&ids=14,12,11,18,17,16,15,19,101,102,100,105,103,104,20,21,502,501,500,23,22,509,508,507,506,505,504,503,8,9,6,7,4,5,2,3,1,10&version=2&shard.url=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942525&group.limit=10&fl=id,a_si,id} status=0 QTime=1
[junit4:junit4] 2> 3992 T2364 C123 REQ [collection1] webapp=/zr_hwj path=/select params={group.field=a_si&version=2&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&shards=127.0.0.1:39300/zr_hwj|[ff01::213]:33332/zr_hwj|[ff01::083]:33332/zr_hwj&rows=100&group=true&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=12
[junit4:junit4] 2> 3996 T2354 C122 REQ [collection1] webapp=/zr_hwj path=/select params={version=2&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&distrib=false&rows=100&group=true&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} hits=172 status=0 QTime=1
[junit4:junit4] 2> 4002 T2363 C123 REQ [collection1] webapp=/zr_hwj path=/select params={wt=javabin&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&rows=100&group=true&q=*:*&version=2&start=0&shard.url=[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj|[ff01::213]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942544&group.limit=10&fl=id&sort=a_si+asc,+id+asc&group.distributed.second=true} status=0 QTime=1
[junit4:junit4] 2> 4005 T2362 C123 REQ [collection1] webapp=/zr_hwj path=/select params={wt=javabin&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&rows=100&q=*:*&ids=19,5,21,20,22,23,18,8&version=2&shard.url=[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj|[ff01::213]:33332/zr_hwj&isShard=true&distrib=false&NOW=1355960942544&group.limit=10&fl=id,a_si,id} status=0 QTime=0
[junit4:junit4] 2> 4006 T2365 C123 REQ [collection1] webapp=/zr_hwj path=/select params={version=2&wt=javabin&group.query=a_t:kings+OR+a_t:eggs&group.query=id:5&shards=[ff01::114]:33332/zr_hwj|127.0.0.1:39300/zr_hwj|[ff01::083]:33332/zr_hwj|[ff01::213]:33332/zr_hwj&rows=100&group=true&group.limit=10&fl=id,a_si&sort=a_si+asc,+id+asc&q=*:*} status=0 QTime=7
[junit4:junit4] 2> 4007 T2345 oas.BaseDistributedSearchTestCase.compareResponses SEVERE Mismatched responses:
[junit4:junit4] 2> {responseHeader={status=0,QTime=7},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> 4041 T2345 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=120452726
[junit4:junit4] 2> 4042 T2345 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@66abce24
[junit4:junit4] 2> 4048 T2345 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> 4049 T2345 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4] 2> 4050 T2345 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4] 2> 4050 T2345 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4] 2> 4052 T2345 C122 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data/index
[junit4:junit4] 2> 4056 T2345 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4] 2> 4107 T2345 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data/index
[junit4:junit4] 2> 4108 T2345 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-1355960938550/control/data/index
[junit4:junit4] 2> 4109 T2345 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data/index
[junit4:junit4] 2> 4109 T2345 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-1355960938550/control/data
[junit4:junit4] 2> 4110 T2345 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/control/data
[junit4:junit4] 2> 4110 T2345 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/zr_hwj,null}
[junit4:junit4] 2> 4183 T2345 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=7022812
[junit4:junit4] 2> 4184 T2345 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@11370440
[junit4:junit4] 2> 4193 T2345 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> 4194 T2345 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4] 2> 4194 T2345 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4] 2> 4195 T2345 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4] 2> 4197 T2345 C123 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data/index
[junit4:junit4] 2> 4198 T2345 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4] 2> 4249 T2345 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data/index
[junit4:junit4] 2> 4250 T2345 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-1355960938550/shard0/data/index
[junit4:junit4] 2> 4250 T2345 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data/index
[junit4:junit4] 2> 4251 T2345 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-1355960938550/shard0/data
[junit4:junit4] 2> 4251 T2345 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J1/./org.apache.solr.TestDistributedGrouping-1355960938550/shard0/data
[junit4:junit4] 2> 4253 T2345 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/zr_hwj,null}
[junit4:junit4] 2> 4313 T2345 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDistributedGrouping -Dtests.method=testDistribSearch -Dtests.seed=77CFC390E60CDDC -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_MA -Dtests.timezone=Pacific/Ponape -Dtests.file.encoding=US-ASCII
[junit4:junit4] FAILURE 4.34s 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([77CFC390E60CDDC:869A7221793FADE0]: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> 4338 T2345 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 2> NOTE: test params are: codec=Lucene40, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ar_MA, timezone=Pacific/Ponape
[junit4:junit4] 2> NOTE: Linux 3.2.0-35-generic amd64/Oracle Corporation 1.8.0-ea (64-bit)/cpus=8,threads=1,free=87145720,total=287821824
[junit4:junit4] 2> NOTE: All tests run in this JVM: [TestSolrXMLSerializer, SoftAutoCommitTest, DOMUtilTest, TestCSVLoader, TestSurroundQueryParser, SolrIndexConfigTest, TestQuerySenderListener, PathHierarchyTokenizerFactoryTest, IndexSchemaRuntimeFieldTest, TestElisionMultitermQuery, DocumentAnalysisRequestHandlerTest, TestPropInject, OutputWriterTest, TestBinaryField, TestPropInjectDefaults, FileUtilsTest, MultiTermTest, ClusterStateUpdateTest, TestReload, TestLazyCores, TestSolrDeletionPolicy1, StatsComponentTest, SignatureUpdateProcessorFactoryTest, SuggesterTest, TestLRUCache, TestArbitraryIndexDir, TestHashPartitioner, LeaderElectionTest, TestPluginEnable, ScriptEngineTest, LukeRequestHandlerTest, AnalysisAfterCoreReloadTest, RAMDirectoryFactoryTest, DisMaxRequestHandlerTest, TestMergePolicyConfig, PrimitiveFieldTypeTest, LegacyHTMLStripCharFilterTest, SolrInfoMBeanTest, QueryParsingTest, DebugComponentTest, TestStressVersions, CoreContainerCoreInitFailuresTest, OverseerCollectionProcessorTest, TestBM25SimilarityFactory, RecoveryZkTest, UpdateParamsTest, StandardRequestHandlerTest, SchemaVersionSpecificBehaviorTest, TestSolrCoreProperties, BasicZkTest, SolrCoreTest, TestMultiCoreConfBootstrap, PeerSyncTest, PolyFieldTest, TestFunctionQuery, TestPhraseSuggestions, TestDFRSimilarityFactory, TestRemoteStreaming, TestDistributedSearch, DocumentBuilderTest, HighlighterTest, OverseerTest, SpellCheckComponentTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler, LeaderElectionIntegrationTest, DistributedSpellCheckComponentTest, TestRealTimeGet, ZkControllerTest, TestDistributedGrouping]
[junit4:junit4] Completed on J1 in 4.36s, 1 test, 1 failure <<< FAILURES!
[...truncated 496 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: 25 minutes 10 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 64bit/jdk1.8.0-ea-b65 -XX:+UseSerialGC
Email was triggered for: Failure
Sending email for trigger: Failure