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...@thetaphi.de> on 2014/02/18 01:01:32 UTC
[JENKINS] Lucene-Solr-4.x-MacOSX (64bit/jdk1.6.0) - Build # 1308 -
Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-MacOSX/1308/
Java: 64bit/jdk1.6.0 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
REGRESSION: org.apache.solr.TestDistributedSearch.testDistribSearch
Error Message:
Expected the partialResults header to be null
Stack Trace:
java.lang.AssertionError: Expected the partialResults header to be null
at __randomizedtesting.SeedInfo.seed([77D88FE16BF6E66D:F63E01F91CA98651]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.TestDistributedSearch.validateControlData(TestDistributedSearch.java:525)
at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:445)
at org.apache.solr.TestDistributedSearch.doTest(TestDistributedSearch.java:379)
at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:876)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
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:695)
Build Log:
[...truncated 9605 lines...]
[junit4] Suite: org.apache.solr.TestDistributedSearch
[junit4] 2> 1159749 T3815 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
[junit4] 2> 1159750 T3815 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /kwst/zl
[junit4] 2> 1159753 T3815 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> 1159755 T3815 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1159761 T3815 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1] of [SSLv2Hello, SSLv3, TLSv1]
[junit4] 2> 1159769 T3815 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:55991
[junit4] 2> 1159771 T3815 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1159772 T3815 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1159772 T3815 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr
[junit4] 2> 1159773 T3815 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/'
[junit4] 2> 1159800 T3815 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/solr.xml
[junit4] 2> 1159850 T3815 oasc.CoreContainer.<init> New CoreContainer 2009854986
[junit4] 2> 1159850 T3815 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/]
[junit4] 2> 1159853 T3815 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 1159853 T3815 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 1159853 T3815 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1159854 T3815 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1159854 T3815 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1159854 T3815 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1159855 T3815 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1159855 T3815 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1159856 T3815 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1159883 T3815 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1159884 T3815 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1159885 T3815 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1159893 T3825 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 1159894 T3825 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 1159896 T3825 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1159896 T3825 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1160030 T3825 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 1160117 T3825 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1160118 T3825 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1160130 T3825 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1160676 T3825 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 1160677 T3825 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 1160678 T3825 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1160690 T3825 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1160693 T3825 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1160703 T3825 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1160708 T3825 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1160715 T3825 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1160716 T3825 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1160716 T3825 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1160717 T3825 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1160718 T3825 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1160718 T3825 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1160719 T3825 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1160719 T3825 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedSearch-1392679530077/control/data/
[junit4] 2> 1160720 T3825 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@737a8712
[junit4] 2> 1160720 T3825 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.TestDistributedSearch-1392679530077/control/data
[junit4] 2> 1160721 T3825 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedSearch-1392679530077/control/data/index/
[junit4] 2> 1160722 T3825 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.TestDistributedSearch-1392679530077/control/data/index' doesn't exist. Creating new index...
[junit4] 2> 1160723 T3825 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.TestDistributedSearch-1392679530077/control/data/index
[junit4] 2> 1160725 T3825 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1987168503, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1160727 T3825 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@17decc82 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cee6a2c)),segFN=segments_1,generation=1}
[junit4] 2> 1160727 T3825 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1160728 T3825 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 1160734 T3825 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1160735 T3825 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1160735 T3825 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1160736 T3825 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1160736 T3825 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1160737 T3825 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1160737 T3825 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1160738 T3825 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 1160738 T3825 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 1160739 T3825 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1160739 T3825 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1160739 T3825 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1160740 T3825 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1160740 T3825 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1160740 T3825 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1160741 T3825 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1160742 T3825 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1160743 T3825 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1160744 T3825 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 1160745 T3825 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 1160745 T3825 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1160746 T3825 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1160747 T3825 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 1160747 T3825 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1160748 T3825 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 1160749 T3825 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1160750 T3825 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1160750 T3825 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1160751 T3825 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1160752 T3825 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1160753 T3825 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1160754 T3825 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1160755 T3825 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1160756 T3825 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1160757 T3825 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 1160757 T3825 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 1160766 T3825 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1160768 T3825 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 1160774 T3825 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1160775 T3825 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1160776 T3825 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=30.7041015625, floorSegmentMB=0.2275390625, forceMergeDeletesPctAllowed=24.735282542211408, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1160777 T3825 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@17decc82 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cee6a2c)),segFN=segments_1,generation=1}
[junit4] 2> 1160778 T3825 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1160778 T3825 oass.SolrIndexSearcher.<init> Opening Searcher@1f28dafb[collection1] main
[junit4] 2> 1160779 T3825 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 1160793 T3825 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1160846 T3826 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f28dafb[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1160855 T3825 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1160857 T3815 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 1160857 T3815 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 1160864 T3815 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 1160871 T3815 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1] of [SSLv2Hello, SSLv3, TLSv1]
[junit4] 2> 1160872 T3815 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:55992
[junit4] 2> 1160876 T3815 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 1160878 T3815 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1160878 T3815 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr
[junit4] 2> 1160879 T3815 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/'
[junit4] 2> 1160923 T3815 oasc.ConfigSolr.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/solr.xml
[junit4] 2> 1160986 T3815 oasc.CoreContainer.<init> New CoreContainer 2129426865
[junit4] 2> 1160986 T3815 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/]
[junit4] 2> 1160988 T3815 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 1160989 T3815 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https
[junit4] 2> 1160989 T3815 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 1160990 T3815 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 1160995 T3815 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 1160996 T3815 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 1160997 T3815 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 1160998 T3815 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 1160998 T3815 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 1161032 T3815 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1161033 T3815 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1161034 T3815 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 1161041 T3837 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1
[junit4] 2> 1161043 T3837 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1/'
[junit4] 2> 1161044 T3837 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 1161045 T3837 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 1161120 T3837 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 1161194 T3837 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1161197 T3837 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 1161207 T3837 oass.IndexSchema.readSchema [collection1] Schema name=test
[junit4] 2> 1161745 T3837 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 1161746 T3837 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 1161747 T3837 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1161756 T3837 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 1161760 T3837 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 1161773 T3837 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1161777 T3837 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 1161782 T3837 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1161783 T3837 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1161783 T3837 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1161783 T3837 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1161784 T3837 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 1161785 T3837 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 1161785 T3837 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1161786 T3837 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test-files/solr/collection1/, dataDir=./org.apache.solr.TestDistributedSearch-1392679530077/shard0/data/
[junit4] 2> 1161787 T3837 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@737a8712
[junit4] 2> 1161788 T3837 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.TestDistributedSearch-1392679530077/shard0/data
[junit4] 2> 1161789 T3837 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=./org.apache.solr.TestDistributedSearch-1392679530077/shard0/data/index/
[junit4] 2> 1161789 T3837 oasc.SolrCore.initIndex WARN [collection1] Solr index directory './org.apache.solr.TestDistributedSearch-1392679530077/shard0/data/index' doesn't exist. Creating new index...
[junit4] 2> 1161790 T3837 oasc.CachingDirectoryFactory.get return new directory for ./org.apache.solr.TestDistributedSearch-1392679530077/shard0/data/index
[junit4] 2> 1161790 T3837 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1987168503, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 1161793 T3837 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@16e733bb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6cb7c1c8)),segFN=segments_1,generation=1}
[junit4] 2> 1161793 T3837 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1161794 T3837 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4] 2> 1161799 T3837 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1161799 T3837 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1161799 T3837 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1161800 T3837 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 1161800 T3837 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1161800 T3837 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1161800 T3837 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1161801 T3837 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead
[junit4] 2> 1161801 T3837 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params
[junit4] 2> 1161801 T3837 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 1161801 T3837 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1161803 T3837 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1161803 T3837 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1161803 T3837 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1161803 T3837 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4] 2> 1161804 T3837 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 1161805 T3837 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4] 2> 1161805 T3837 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 1161806 T3837 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4] 2> 1161807 T3837 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4] 2> 1161807 T3837 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4] 2> 1161808 T3837 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler
[junit4] 2> 1161808 T3837 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4] 2> 1161808 T3837 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4] 2> 1161809 T3837 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4] 2> 1161809 T3837 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 1161811 T3837 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1161811 T3837 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1161812 T3837 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1161812 T3837 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1161814 T3837 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1161815 T3837 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1161815 T3837 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1161816 T3837 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4] 2> 1161817 T3837 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4] 2> 1161817 T3837 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 1161824 T3837 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 1161825 T3837 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 1161831 T3837 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4] 2> 1161831 T3837 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 1161832 T3837 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=26, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=30.7041015625, floorSegmentMB=0.2275390625, forceMergeDeletesPctAllowed=24.735282542211408, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1161833 T3837 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@16e733bb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6cb7c1c8)),segFN=segments_1,generation=1}
[junit4] 2> 1161833 T3837 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 1161834 T3837 oass.SolrIndexSearcher.<init> Opening Searcher@7164c486[collection1] main
[junit4] 2> 1161834 T3837 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 1161842 T3837 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1161904 T3838 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7164c486[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 1161922 T3837 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 1161929 T3815 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr-core/test/J0
[junit4] 2> 1161930 T3815 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> ASYNC NEW_CORE C1112 name=collection1 org.apache.solr.core.SolrCore@7845d517
[junit4] 2> 1161979 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1460330333255761920)} 0 7
[junit4] 2> ASYNC NEW_CORE C1113 name=collection1 org.apache.solr.core.SolrCore@748fc494
[junit4] 2> 1162009 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1460330333292462080)} 0 3
[junit4] 2> 1162020 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[1 (1460330333302947840)]} 0 5
[junit4] 2> 1162029 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[1 (1460330333313433600)]} 0 3
[junit4] 2> 1162036 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[2 (1460330333321822208)]} 0 2
[junit4] 2> 1162043 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[2 (1460330333330210816)]} 0 1
[junit4] 2> 1162050 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[3 (1460330333336502272)]} 0 2
[junit4] 2> 1162058 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[3 (1460330333344890880)]} 0 2
[junit4] 2> 1162069 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[4 (1460330333357473792)]} 0 2
[junit4] 2> 1162074 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[4 (1460330333362716672)]} 0 1
[junit4] 2> 1162081 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[5 (1460330333370056704)]} 0 1
[junit4] 2> 1162090 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[5 (1460330333378445312)]} 0 2
[junit4] 2> 1162097 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[6 (1460330333384736768)]} 0 3
[junit4] 2> 1162106 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[6 (1460330333395222528)]} 0 2
[junit4] 2> 1162111 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[7 (1460330333401513984)]} 0 1
[junit4] 2> 1162116 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[7 (1460330333406756864)]} 0 1
[junit4] 2> 1162120 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[8 (1460330333410951168)]} 0 1
[junit4] 2> 1162124 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[8 (1460330333415145472)]} 0 1
[junit4] 2> 1162129 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[9 (1460330333420388352)]} 0 1
[junit4] 2> 1162134 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[9 (1460330333426679808)]} 0 0
[junit4] 2> 1162141 T3823 C1112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1162153 T3823 C1112 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@17decc82 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cee6a2c)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@17decc82 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cee6a2c)),segFN=segments_2,generation=2}
[junit4] 2> 1162154 T3823 C1112 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 1162211 T3823 C1112 oass.SolrIndexSearcher.<init> Opening Searcher@7b0e0809[collection1] main
[junit4] 2> 1162213 T3823 C1112 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 1162217 T3826 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7b0e0809[collection1] main{StandardDirectoryReader(segments_2:3:nrt _0(4.7):C9)}
[junit4] 2> 1162218 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 77
[junit4] 2> 1162225 T3834 C1113 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1162251 T3834 C1113 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@16e733bb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6cb7c1c8)),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@16e733bb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6cb7c1c8)),segFN=segments_2,generation=2}
[junit4] 2> 1162251 T3834 C1113 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 1162305 T3834 C1113 oass.SolrIndexSearcher.<init> Opening Searcher@38864035[collection1] main
[junit4] 2> 1162306 T3834 C1113 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 1162309 T3838 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38864035[collection1] main{StandardDirectoryReader(segments_2:3:nrt _0(4.7):C9)}
[junit4] 2> 1162310 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 85
[junit4] 2> 1162325 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[10 (1460330333621714944)]} 0 6
[junit4] 2> 1162339 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[10 (1460330333635346432)]} 0 6
[junit4] 2> 1162347 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[11 (1460330333647929344)]} 0 2
[junit4] 2> 1162356 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[11 (1460330333657366528)]} 0 2
[junit4] 2> 1162363 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[12 (1460330333664706560)]} 0 2
[junit4] 2> 1162370 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[12 (1460330333673095168)]} 0 1
[junit4] 2> 1162380 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[13 (1460330333682532352)]} 0 3
[junit4] 2> 1162386 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[13 (1460330333689872384)]} 0 1
[junit4] 2> 1162395 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[1001 (1460330333698260992)]} 0 2
[junit4] 2> 1162404 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[1001 (1460330333707698176)]} 0 2
[junit4] 2> 1162412 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[14 (1460330333716086784)]} 0 3
[junit4] 2> 1162419 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[14 (1460330333724475392)]} 0 2
[junit4] 2> 1162429 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[15 (1460330333733912576)]} 0 2
[junit4] 2> 1162438 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[15 (1460330333744398336)]} 0 1
[junit4] 2> 1162445 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[16 (1460330333751738368)]} 0 2
[junit4] 2> 1162452 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[16 (1460330333758029824)]} 0 2
[junit4] 2> 1162462 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[17 (1460330333767467008)]} 0 3
[junit4] 2> 1162476 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[17 (1460330333782147072)]} 0 4
[junit4] 2> 1162484 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[100 (1460330333792632832)]} 0 1
[junit4] 2> 1162494 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[100 (1460330333803118592)]} 0 1
[junit4] 2> 1162502 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[101 (1460330333812555776)]} 0 1
[junit4] 2> 1162511 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[101 (1460330333820944384)]} 0 2
[junit4] 2> 1162517 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[102 (1460330333828284416)]} 0 1
[junit4] 2> 1162524 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[102 (1460330333834575872)]} 0 1
[junit4] 2> 1162533 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[103 (1460330333844013056)]} 0 1
[junit4] 2> 1162540 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[103 (1460330333851353088)]} 0 1
[junit4] 2> 1162548 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[104 (1460330333859741696)]} 0 1
[junit4] 2> 1162554 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[104 (1460330333866033152)]} 0 1
[junit4] 2> 1162560 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[105 (1460330333872324608)]} 0 1
[junit4] 2> 1162567 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[105 (1460330333879664640)]} 0 1
[junit4] 2> 1162575 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[106 (1460330333888053248)]} 0 1
[junit4] 2> 1162581 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[106 (1460330333894344704)]} 0 1
[junit4] 2> 1162590 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[107 (1460330333903781888)]} 0 1
[junit4] 2> 1162597 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[107 (1460330333911121920)]} 0 2
[junit4] 2> 1162612 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[108 (1460330333925801984)]} 0 2
[junit4] 2> 1162622 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[108 (1460330333936287744)]} 0 3
[junit4] 2> 1162630 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[109 (1460330333945724928)]} 0 2
[junit4] 2> 1162639 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[109 (1460330333956210688)]} 0 1
[junit4] 2> 1162645 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[110 (1460330333961453568)]} 0 1
[junit4] 2> 1162652 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[110 (1460330333968793600)]} 0 1
[junit4] 2> 1162659 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[111 (1460330333977182208)]} 0 1
[junit4] 2> 1162665 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[111 (1460330333982425088)]} 0 1
[junit4] 2> 1162672 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[112 (1460330333988716544)]} 0 2
[junit4] 2> 1162679 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[112 (1460330333997105152)]} 0 1
[junit4] 2> 1162690 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[113 (1460330334008639488)]} 0 1
[junit4] 2> 1162697 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[113 (1460330334015979520)]} 0 1
[junit4] 2> 1162705 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[114 (1460330334024368128)]} 0 1
[junit4] 2> 1162712 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[114 (1460330334031708160)]} 0 1
[junit4] 2> 1162719 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[115 (1460330334039048192)]} 0 1
[junit4] 2> 1162730 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[115 (1460330334050582528)]} 0 1
[junit4] 2> 1162738 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[116 (1460330334057922560)]} 0 2
[junit4] 2> 1162745 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[116 (1460330334065262592)]} 0 2
[junit4] 2> 1162751 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[117 (1460330334072602624)]} 0 1
[junit4] 2> 1162758 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[117 (1460330334079942656)]} 0 2
[junit4] 2> 1162764 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[118 (1460330334086234112)]} 0 1
[junit4] 2> 1162770 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[118 (1460330334092525568)]} 0 1
[junit4] 2> 1162779 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[119 (1460330334101962752)]} 0 1
[junit4] 2> 1162785 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[119 (1460330334108254208)]} 0 1
[junit4] 2> 1162792 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[120 (1460330334114545664)]} 0 2
[junit4] 2> 1162801 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[120 (1460330334123982848)]} 0 1
[junit4] 2> 1162809 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[121 (1460330334133420032)]} 0 2
[junit4] 2> 1162820 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[121 (1460330334144954368)]} 0 2
[junit4] 2> 1162827 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[122 (1460330334152294400)]} 0 1
[junit4] 2> 1162834 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[122 (1460330334159634432)]} 0 1
[junit4] 2> 1162841 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[123 (1460330334166974464)]} 0 1
[junit4] 2> 1162848 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[123 (1460330334173265920)]} 0 2
[junit4] 2> 1162855 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[124 (1460330334181654528)]} 0 2
[junit4] 2> 1162861 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[124 (1460330334187945984)]} 0 1
[junit4] 2> 1162868 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[125 (1460330334194237440)]} 0 2
[junit4] 2> 1162874 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[125 (1460330334201577472)]} 0 1
[junit4] 2> 1162883 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[126 (1460330334211014656)]} 0 1
[junit4] 2> 1162890 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[126 (1460330334218354688)]} 0 2
[junit4] 2> 1162899 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[127 (1460330334227791872)]} 0 1
[junit4] 2> 1162911 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[127 (1460330334240374784)]} 0 1
[junit4] 2> 1162919 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[128 (1460330334247714816)]} 0 2
[junit4] 2> 1162929 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[128 (1460330334259249152)]} 0 2
[junit4] 2> 1162939 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[129 (1460330334269734912)]} 0 1
[junit4] 2> 1162947 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[129 (1460330334279172096)]} 0 0
[junit4] 2> 1162953 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[130 (1460330334284414976)]} 0 1
[junit4] 2> 1162958 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[130 (1460330334290706432)]} 0 0
[junit4] 2> 1162974 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[131 (1460330334298046464)]} 0 9
[junit4] 2> 1162983 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[131 (1460330334315872256)]} 0 1
[junit4] 2> 1162988 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[132 (1460330334322163712)]} 0 0
[junit4] 2> 1162998 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[132 (1460330334331600896)]} 0 1
[junit4] 2> 1163003 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[133 (1460330334336843776)]} 0 1
[junit4] 2> 1163007 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[133 (1460330334341038080)]} 0 1
[junit4] 2> 1163011 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[134 (1460330334345232384)]} 0 1
[junit4] 2> 1163015 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[134 (1460330334349426688)]} 0 1
[junit4] 2> 1163020 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[135 (1460330334354669568)]} 0 1
[junit4] 2> 1163024 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[135 (1460330334359912448)]} 0 0
[junit4] 2> 1163028 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[136 (1460330334363058176)]} 0 1
[junit4] 2> 1163032 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[136 (1460330334367252480)]} 0 1
[junit4] 2> 1163036 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[137 (1460330334371446784)]} 0 1
[junit4] 2> 1163042 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[137 (1460330334378786816)]} 0 1
[junit4] 2> 1163047 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[138 (1460330334382981120)]} 0 1
[junit4] 2> 1163053 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[138 (1460330334389272576)]} 0 1
[junit4] 2> 1163059 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[139 (1460330334395564032)]} 0 1
[junit4] 2> 1163065 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[139 (1460330334401855488)]} 0 1
[junit4] 2> 1163072 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[140 (1460330334409195520)]} 0 1
[junit4] 2> 1163075 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[140 (1460330334413389824)]} 0 0
[junit4] 2> 1163081 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[141 (1460330334419681280)]} 0 0
[junit4] 2> 1163085 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[141 (1460330334423875584)]} 0 0
[junit4] 2> 1163089 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[142 (1460330334428069888)]} 0 0
[junit4] 2> 1163093 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[142 (1460330334432264192)]} 0 0
[junit4] 2> 1163097 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[143 (1460330334435409920)]} 0 1
[junit4] 2> 1163101 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[143 (1460330334439604224)]} 0 1
[junit4] 2> 1163105 T3819 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[144 (1460330334443798528)]} 0 1
[junit4] 2> 1163109 T3836 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[144 (1460330334447992832)]} 0 1
[junit4] 2> 1163112 T3821 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[145 (1460330334452187136)]} 0 0
[junit4] 2> 1163117 T3835 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[145 (1460330334456381440)]} 0 1
[junit4] 2> 1163120 T3822 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[146 (1460330334460575744)]} 0 0
[junit4] 2> 1163125 T3832 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[146 (1460330334465818624)]} 0 0
[junit4] 2> 1163132 T3823 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[147 (1460330334472110080)]} 0 1
[junit4] 2> 1163137 T3830 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[147 (1460330334477352960)]} 0 1
[junit4] 2> 1163144 T3824 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[148 (1460330334483644416)]} 0 2
[junit4] 2> 1163149 T3834 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[148 (1460330334490984448)]} 0 1
[junit4] 2> 1163161 T3820 C1112 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[149 (1460330334502518784)]} 0 2
[junit4] 2> 1163169 T3833 C1113 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={wt=javabin&version=2} {add=[149 (1460330334509858816)]} 0 2
[junit4] 2> 1163176 T3819 C1112 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C1114 name=collection1 org.apache.solr.core.SolrCore@7845d517
[junit4] 2> 1163248 T3819 C1114 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@17decc82 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cee6a2c)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@17decc82 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1cee6a2c)),segFN=segments_3,generation=3}
[junit4] 2> 1163250 T3819 C1114 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 1163255 T3819 C1114 oass.SolrIndexSearcher.<init> Opening Searcher@45832fc[collection1] main
[junit4] 2> 1163258 T3826 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@45832fc[collection1] main{StandardDirectoryReader(segments_3:5:nrt _0(4.7):C9 _1(4.7):C59)}
[junit4] 2> 1163258 T3819 C1114 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 1163259 T3819 C1114 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 83
[junit4] 2> ASYNC NEW_CORE C1115 name=collection1 org.apache.solr.core.SolrCore@748fc494
[junit4] 2> 1163265 T3836 C1115 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1163333 T3836 C1115 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@16e733bb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6cb7c1c8)),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@16e733bb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6cb7c1c8)),segFN=segments_3,generation=3}
[junit4] 2> 1163334 T3836 C1115 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 1163338 T3836 C1115 oass.SolrIndexSearcher.<init> Opening Searcher@731943d7[collection1] main
[junit4] 2> 1163341 T3838 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@731943d7[collection1] main{StandardDirectoryReader(segments_3:5:nrt _0(4.7):C9 _1(4.7):C59)}
[junit4] 2> 1163341 T3836 C1115 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 1163342 T3836 C1115 oasup.LogUpdateProcessor.finish [collection1] webapp=/kwst/zl path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 77
[junit4] 2> 1163351 T3821 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_ti1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1163401 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533692&shard.url=https://127.0.0.1:55992/kwst/zl&fl=id&sort=n_ti1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1163412 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533692&shard.url=https://127.0.0.1:55992/kwst/zl&ids=3,116,137,4,106,8,140,11,142,12&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=2
[junit4] 2> 1163435 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl&sort=n_ti1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=67
[junit4] 2> 1163442 T3822 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_ti1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1163461 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533774&shard.url=[ff01::083]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&fl=id&sort=n_ti1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1163468 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533774&shard.url=[ff01::083]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&ids=143,132,133,128,138,107,105,120,16,131&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1163493 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=[ff01::083]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&sort=n_ti1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=43
[junit4] 2> 1163499 T3824 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_f1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1163510 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533829&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&fl=id&sort=n_f1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1163518 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533829&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&ids=134,125,143,109,139,6,123,4,106,119&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1163530 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&sort=n_f1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=25
[junit4] 2> 1163539 T3820 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_f1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1163556 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533870&shard.url=[ff01::114]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&fl=id&sort=n_f1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1163565 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533870&shard.url=[ff01::114]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&ids=3,145,122,137,111,9,15,129,11,12&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1163593 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=[ff01::114]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&sort=n_f1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=47
[junit4] 2> 1163598 T3819 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_tf1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1163607 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533927&shard.url=[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&fl=id&sort=n_tf1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1163613 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533927&shard.url=[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&ids=135,1,132,10,138,6,136,108,102,100&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1163621 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&sort=n_tf1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=18
[junit4] 2> 1163627 T3821 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_tf1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1163638 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533958&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl|[ff01::114]:33332/kwst/zl&fl=id&sort=n_tf1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1163649 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533958&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl|[ff01::114]:33332/kwst/zl&ids=3,143,117,109,5,149,17,15,131,14&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1163653 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl|[ff01::114]:33332/kwst/zl&sort=n_tf1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=19
[junit4] 2> 1163659 T3822 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_d1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1163671 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533990&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&fl=id&sort=n_d1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1163677 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679533990&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&ids=134,145,10,7,6,139,5,137,106,17&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1163681 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&sort=n_d1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=15
[junit4] 2> 1163688 T3823 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_d1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1163708 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534024&shard.url=[ff01::083]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&fl=id&sort=n_d1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1163718 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534024&shard.url=[ff01::083]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&ids=3,147,113,136,124,15,120,103,13,141&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1163720 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=[ff01::083]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&sort=n_d1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=20
[junit4] 2> 1163728 T3824 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_td1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1163738 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534058&shard.url=https://127.0.0.1:55992/kwst/zl&fl=id&sort=n_td1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1163743 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534058&shard.url=https://127.0.0.1:55992/kwst/zl&ids=143,125,126,135,10,107,105,129,11,142&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1163746 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl&sort=n_td1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=12
[junit4] 2> 1163754 T3820 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_td1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1163767 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534085&shard.url=https://127.0.0.1:55992/kwst/zl&fl=id&sort=n_td1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1163775 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534085&shard.url=https://127.0.0.1:55992/kwst/zl&ids=116,144,1,146,138,108,17,131,14,12&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1163780 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl&sort=n_td1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=19
[junit4] 2> 1163787 T3819 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_l1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1163796 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534116&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&fl=id&sort=n_l1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1163803 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534116&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&ids=143,2,1,122,136,4,103,129,130,142&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1163844 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&sort=n_l1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=52
[junit4] 2> 1163913 T3821 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_l1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1163982 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534257&shard.url=[ff01::213]:33332/kwst/zl|[ff01::114]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&fl=id&sort=n_l1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1164000 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534257&shard.url=[ff01::213]:33332/kwst/zl|[ff01::114]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&ids=125,126,117,135,127,138,108,124,9,131&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1164003 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=[ff01::213]:33332/kwst/zl|[ff01::114]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&sort=n_l1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=70
[junit4] 2> 1164024 T3823 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_tl1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1164086 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534368&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&fl=id&sort=n_tl1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1164110 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534368&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&ids=114,145,128,123,107,124,120,103,140,131&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1164120 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl|[ff01::213]:33332/kwst/zl&sort=n_tl1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=76
[junit4] 2> 1164131 T3824 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_tl1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1164140 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534461&shard.url=https://127.0.0.1:55992/kwst/zl&fl=id&sort=n_tl1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1164147 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534461&shard.url=https://127.0.0.1:55992/kwst/zl&ids=116,3,135,1001,115,112,113,105,15,142&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1164162 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl&sort=n_tl1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=24
[junit4] 2> 1164194 T3820 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_dt1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=16
[junit4] 2> 1164205 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534522&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&fl=id&sort=n_dt1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1164214 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534522&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&ids=117,145,114,7,5,107,9,102,14,119&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1164218 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl|[ff01::114]:33332/kwst/zl&sort=n_dt1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=20
[junit4] 2> 1164228 T3819 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_dt1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1164240 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534558&shard.url=https://127.0.0.1:55992/kwst/zl&fl=id&sort=n_dt1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1164270 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534558&shard.url=https://127.0.0.1:55992/kwst/zl&ids=2,135,1001,133,148,106,120,11,12,141&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1164277 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl&sort=n_dt1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=43
[junit4] 2> 1164290 T3821 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_tdt1+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1164315 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534633&shard.url=https://127.0.0.1:55992/kwst/zl&fl=id&sort=n_tdt1+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1164346 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534633&shard.url=https://127.0.0.1:55992/kwst/zl&ids=1,115,109,137,106,9,15,140,130,100&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1164357 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl&sort=n_tdt1+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=48
[junit4] 2> 1164373 T3822 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=n_tdt1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1164395 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534709&shard.url=[ff01::114]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&fl=id&sort=n_tdt1+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=0
[junit4] 2> 1164410 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534709&shard.url=[ff01::114]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&ids=125,134,117,145,127,1001,7,147,108,141&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1164416 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=[ff01::114]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&sort=n_tdt1+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=31
[junit4] 2> 1164429 T3824 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1164457 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534769&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&fl=id&sort=a_si+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1164476 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534769&shard.url=https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&ids=3,2,10,1,7,5,9,8,13,12&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=5
[junit4] 2> 1164482 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl|[ff01::083]:33332/kwst/zl&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=37
[junit4] 2> 1164496 T3820 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort={!func}testfunc(add(a_si,5))+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1164522 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534834&shard.url=https://127.0.0.1:55992/kwst/zl&fl=id&sort={!func}testfunc(add(a_si,5))+desc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1164528 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534834&shard.url=https://127.0.0.1:55992/kwst/zl&ids=3,2,10,1,7,5,9,8,13,12&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1164537 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl&sort={!func}testfunc(add(a_si,5))+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=27
[junit4] 2> 1164565 T3819 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={sort=a_si+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1164608 T3834 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534909&shard.url=https://127.0.0.1:55992/kwst/zl&fl=id&sort=a_si+asc&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=5
[junit4] 2> 1164648 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679534909&shard.url=https://127.0.0.1:55992/kwst/zl&ids=3,2,1,7,6,4,9,13,11,12&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=1
[junit4] 2> 1164657 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=https://127.0.0.1:55992/kwst/zl&sort=a_si+asc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=72
[junit4] 2> 1164673 T3821 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={fl=*,score&sort=a_si+desc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=1
[junit4] 2> 1164688 T3835 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679535006&shard.url=[ff01::114]:33332/kwst/zl|[ff01::083]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&sort=a_si+desc&fl=id,score&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1164708 T3833 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679535006&shard.url=[ff01::114]:33332/kwst/zl|[ff01::083]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&fl=*,score&ids=3,2,10,1,7,5,9,8,13,12&q=*:*&distrib=false&wt=javabin&isShard=true&version=2} status=0 QTime=0
[junit4] 2> 1164717 T3830 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={shards=[ff01::114]:33332/kwst/zl|[ff01::083]:33332/kwst/zl|[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&fl=*,score&sort=a_si+desc&q=*:*&wt=javabin&version=2} hits=68 status=0 QTime=35
[junit4] 2> 1164730 T3823 C1114 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={fl=*,score&sort=n_tl1+asc&q=*:*&distrib=false&wt=javabin&version=2} hits=68 status=0 QTime=0
[junit4] 2> 1164750 T3836 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679535065&shard.url=[ff01::213]:33332/kwst/zl|https://127.0.0.1:55992/kwst/zl&sort=n_tl1+asc&fl=id,score&start=0&q=*:*&distrib=false&wt=javabin&isShard=true&fsv=true&version=2&rows=10} hits=68 status=0 QTime=1
[junit4] 2> 1164760 T3832 C1115 oasc.SolrCore.execute [collection1] webapp=/kwst/zl path=/select params={NOW=1392679535065&shard.url=[ff01::213]:33332/kwst/zl|https:
[...truncated too long message...]
stDistributedSearch-1392679530077/shard0/data
[junit4] 2> 1177878 T3815 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.TestDistributedSearch-1392679530077/shard0/data/index [CachedDir<<refCount=0;path=./org.apache.solr.TestDistributedSearch-1392679530077/shard0/data/index;done=false>>]
[junit4] 2> 1177879 T3815 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.TestDistributedSearch-1392679530077/shard0/data/index
[junit4] 2> 1177881 T3815 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/kwst/zl,null}
[junit4] 2> 1177952 T3815 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=287276031
[junit4] 2> 1177958 T3815 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@29c63873
[junit4] 2> 1177981 T3815 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=36,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=8909,transaction_logs_total_number=3}
[junit4] 2> 1177981 T3815 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 1177982 T3815 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1177982 T3815 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 1177985 T3815 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 1177986 T3815 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1177986 T3815 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.TestDistributedSearch-1392679530077/shard1/data/index [CachedDir<<refCount=0;path=./org.apache.solr.TestDistributedSearch-1392679530077/shard1/data/index;done=false>>]
[junit4] 2> 1177986 T3815 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.TestDistributedSearch-1392679530077/shard1/data/index
[junit4] 2> 1177987 T3815 oasc.CachingDirectoryFactory.closeCacheValue looking to close ./org.apache.solr.TestDistributedSearch-1392679530077/shard1/data [CachedDir<<refCount=0;path=./org.apache.solr.TestDistributedSearch-1392679530077/shard1/data;done=false>>]
[junit4] 2> 1177987 T3815 oasc.CachingDirectoryFactory.close Closing directory: ./org.apache.solr.TestDistributedSearch-1392679530077/shard1/data
[junit4] 2> 1177989 T3815 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/kwst/zl,null}
[junit4] 2> 1178087 T3815 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDistributedSearch -Dtests.method=testDistribSearch -Dtests.seed=77D88FE16BF6E66D -Dtests.slow=true -Dtests.locale=fr_CH -Dtests.timezone=America/Glace_Bay -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 18.3s | TestDistributedSearch.testDistribSearch <<<
[junit4] > Throwable #1: java.lang.AssertionError: Expected the partialResults header to be null
[junit4] > at __randomizedtesting.SeedInfo.seed([77D88FE16BF6E66D:F63E01F91CA98651]:0)
[junit4] > at org.apache.solr.TestDistributedSearch.validateControlData(TestDistributedSearch.java:525)
[junit4] > at org.apache.solr.TestDistributedSearch.queryPartialResults(TestDistributedSearch.java:445)
[junit4] > at org.apache.solr.TestDistributedSearch.doTest(TestDistributedSearch.java:379)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:876)
[junit4] > at java.lang.Thread.run(Thread.java:695)
[junit4] 2> 1178096 T3815 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene46: {foo_b=Pulsing41(freqCutoff=8 minBlockSize=41 maxBlockSize=154), n_f1=PostingsFormat(name=FSTPulsing41), lowerfilt=PostingsFormat(name=FSTPulsing41), foo_d=Lucene41(blocksize=128), foo_f=Pulsing41(freqCutoff=8 minBlockSize=41 maxBlockSize=154), n_tl1=PostingsFormat(name=FSTPulsing41), lowerfilt1and2=PostingsFormat(name=FSTPulsing41), n_d1=PostingsFormat(name=TestBloomFilteredLucene41Postings), rnd_b=Lucene41(blocksize=128), intDefault=PostingsFormat(name=TestBloomFilteredLucene41Postings), n_td1=PostingsFormat(name=FSTPulsing41), timestamp=PostingsFormat(name=TestBloomFilteredLucene41Postings), id=Lucene41(blocksize=128), range_facet_sl=Pulsing41(freqCutoff=8 minBlockSize=41 maxBlockSize=154), range_facet_si=PostingsFormat(name=FSTPulsing41), oddField_s=Pulsing41(freqCutoff=8 minBlockSize=41 maxBlockSize=154), multiDefault=PostingsFormat(name=FSTPulsing41), n_tf1=PostingsFormat(name=TestBloomFilteredLucene41Postings), n_dt1=PostingsFormat(name=FSTPulsing41), a_n_tdt=Lucene41(blocksize=128), n_ti1=Lucene41(blocksize=128), range_facet_l=PostingsFormat(name=TestBloomFilteredLucene41Postings), text=Pulsing41(freqCutoff=8 minBlockSize=41 maxBlockSize=154), _version_=PostingsFormat(name=TestBloomFilteredLucene41Postings), SubjectTerms_mfacet=PostingsFormat(name=TestBloomFilteredLucene41Postings), b_n_tdt=PostingsFormat(name=TestBloomFilteredLucene41Postings), a_t=PostingsFormat(name=TestBloomFilteredLucene41Postings), n_tdt1=PostingsFormat(name=TestBloomFilteredLucene41Postings), other_tl1=PostingsFormat(name=TestBloomFilteredLucene41Postings), n_l1=PostingsFormat(name=TestBloomFilteredLucene41Postings), a_si=PostingsFormat(name=FSTPulsing41)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=fr_CH, timezone=America/Glace_Bay
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Apple Inc. 1.6.0_65 (64-bit)/cpus=2,threads=2,free=95793080,total=355794944
[junit4] 2> NOTE: All tests run in this JVM: [TestCopyFieldCollectionResource, TestCodecSupport, TestFieldTypeResource, BlockDirectoryTest, BasicFunctionalityTest, DirectUpdateHandlerOptimizeTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestStressVersions, TestSolrQueryParserDefaultOperatorResource, PathHierarchyTokenizerFactoryTest, TestFastLRUCache, TestOverriddenPrefixQueryForCustomFieldType, SoftAutoCommitTest, TestDFRSimilarityFactory, BasicDistributedZkTest, TestFileDictionaryLookup, LeaderElectionTest, ParsingFieldUpdateProcessorsTest, OpenCloseCoreStressTest, SuggesterFSTTest, IndexSchemaRuntimeFieldTest, TestQueryUtils, OverseerCollectionProcessorTest, InfoHandlerTest, ZkSolrClientTest, SolrXmlInZkTest, SliceStateUpdateTest, TestAddFieldRealTimeGet, BJQParserTest, ZkCLITest, TestRandomFaceting, DistributedSuggestComponentTest, AddBlockUpdateTest, StandardRequestHandlerTest, SliceStateTest, TestComponentsName, TestOmitPositions, TestSolrIndexConfig, DistanceFunctionTest, DocValuesMissingTest, XmlUpdateRequestHandlerTest, TestFastWriter, TestRTGBase, ChangedSchemaMergeTest, CacheHeaderTest, TestSchemaNameResource, SchemaVersionSpecificBehaviorTest, ShardRoutingTest, TestLMJelinekMercerSimilarityFactory, TestSuggestSpellingConverter, TestQuerySenderNoQuery, BadIndexSchemaTest, TestPHPSerializedResponseWriter, TestStandardQParsers, DisMaxRequestHandlerTest, TestStressRecovery, ChaosMonkeyNothingIsSafeTest, IndexBasedSpellCheckerTest, TestTrie, BadCopyFieldTest, TestStressUserVersions, ChaosMonkeySafeLeaderTest, ShardRoutingCustomTest, TestFastOutputStream, RegexBoostProcessorTest, TestBinaryField, TestCSVResponseWriter, SystemInfoHandlerTest, TestSchemaSimilarityResource, TestCoreDiscovery, OverseerRolesTest, SuggesterWFSTTest, DeleteShardTest, TestRecoveryHdfs, TestHighlightDedupGrouping, PrimUtilsTest, ClusterStateUpdateTest, TestReloadAndDeleteDocs, CustomCollectionTest, MoreLikeThisHandlerTest, TestManagedSchemaFieldResource, AnalysisAfterCoreReloadTest, TestNRTOpen, IndexSchemaTest, DocValuesTest, JSONWriterTest, BasicZkTest, PluginInfoTest, SimplePostToolTest, TermVectorComponentDistributedTest, SynonymTokenizerTest, HdfsBasicDistributedZk2Test, TestIBSimilarityFactory, TestStressReorder, TestSolrXml, DefaultValueUpdateProcessorTest, TestDynamicFieldCollectionResource, SuggesterTest, BadComponentTest, TestZkChroot, SuggestComponentTest, CursorPagingTest, HdfsLockFactoryTest, HdfsChaosMonkeySafeLeaderTest, NumericFieldsTest, HdfsUnloadDistributedZkTest, TestSolr4Spatial, HdfsBasicDistributedZkTest, RecoveryZkTest, MBeansHandlerTest, AssignTest, TestInitQParser, ZkControllerTest, TestDistributedSearch]
[junit4] Completed in 18.38s, 1 test, 1 failure <<< FAILURES!
[...truncated 747 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:459: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:439: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:39: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/extra-targets.xml:37: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build.xml:189: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/common-build.xml:491: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/lucene/common-build.xml:1308: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/lucene/common-build.xml:941: There were test failures: 362 suites, 1563 tests, 1 failure, 40 ignored (6 assumptions)
Total time: 88 minutes 59 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.6.0 -XX:-UseCompressedOops -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure