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 2015/05/17 19:52:05 UTC

[JENKINS] Lucene-Solr-5.x-Linux (32bit/jdk1.7.0_80) - Build # 12543 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/12543/
Java: 32bit/jdk1.7.0_80 -server -XX:+UseG1GC

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.search.QueryEqualityTest

Error Message:
testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll

Stack Trace:
java.lang.AssertionError: testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
	at __randomizedtesting.SeedInfo.seed([5DCA540194741A4D]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.search.QueryEqualityTest.afterClassParserCoverageTest(QueryEqualityTest.java:63)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	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:365)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10582 lines...]
   [junit4] Suite: org.apache.solr.search.QueryEqualityTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001
   [junit4]   2> 972383 T6034 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 972384 T6034 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 972384 T6034 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 972385 T6034 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 972385 T6034 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 972416 T6034 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 972446 T6034 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 972487 T6034 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 972488 T6034 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 972494 T6034 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 972629 T6034 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 972631 T6034 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 972632 T6034 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 972633 T6034 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 972639 T6034 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 972639 T6034 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 972640 T6034 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 972652 T6034 oasc.CoreContainer.<init> New CoreContainer 5814177
   [junit4]   2> 972652 T6034 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 972652 T6034 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 972653 T6034 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib).
   [junit4]   2> 972658 T6034 oashc.HttpShardHandlerFactory.init created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 972659 T6034 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 972660 T6034 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 972660 T6034 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 972660 T6034 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 972661 T6034 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {shard=shard1, name=collection1, instanceDir=collection1, collection=collection1, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001, loadOnStartup=true, transient=false, schema=schema15.xml, config=solrconfig.xml, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/}
   [junit4]   2> 972662 T6035 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 972663 T6035 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 972663 T6035 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 972685 T6035 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 972704 T6035 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 972848 T6035 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 972848 T6035 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 972852 T6035 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 972976 T6035 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 972978 T6035 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 972979 T6035 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 972982 T6035 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 972990 T6035 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 972990 T6035 x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 972990 T6035 x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/], dataDir=[null]
   [junit4]   2> 972991 T6035 x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@977673
   [junit4]   2> 972991 T6035 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001
   [junit4]   2> 972992 T6035 x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index/
   [junit4]   2> 972992 T6035 x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 972992 T6035 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index
   [junit4]   2> 972993 T6035 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=39942840, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
   [junit4]   2> 972994 T6035 x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1fee384 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b0fee),segFN=segments_1,generation=1}
   [junit4]   2> 972994 T6035 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 973000 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 973000 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 973001 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 973001 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 973001 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 973001 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 973002 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 973002 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 973002 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 973003 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 973003 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 973003 T6035 x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 973006 T6035 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 973008 T6035 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 973009 T6035 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 973010 T6035 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 973015 T6035 x:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 973017 T6035 x:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: spellCheckWithWordbreak_Direct,/admin/system,/admin/luke,/mlt,spellCheckCompRH1,/admin/plugins,/admin/threads,/update/json/docs,/admin/logging,defaults,/debug/dump,spellCheckCompRH_Direct,mltrh,/admin/segments,mock,tvrh,lazy,/admin/mbeans,/config,spellCheckWithWordbreak,/update/csv,/replication,/search-facet-def,/get,/update,/search-facet-invariants,/terms,dismax,spellCheckCompRH,/admin/properties,standard,/admin/ping,/admin/file,/update/json,/schema
   [junit4]   2> 973018 T6035 x:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 973019 T6035 x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 973020 T6035 x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 973020 T6035 x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 973021 T6035 x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 973021 T6035 x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 973021 T6035 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 973022 T6035 x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1fee384 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b0fee),segFN=segments_1,generation=1}
   [junit4]   2> 973022 T6035 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 973023 T6035 x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@25cf6[collection1] main
   [junit4]   2> 973023 T6035 x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 973023 T6035 x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 973023 T6035 x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 973024 T6035 x:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 973053 T6035 x:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 973163 T6035 x:collection1 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 973164 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
   [junit4]   2> 973164 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct
   [junit4]   2> 973164 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
   [junit4]   2> 973164 T6035 x:collection1 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 973164 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields
   [junit4]   2> 973165 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 973165 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external
   [junit4]   2> 973165 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq
   [junit4]   2> 973166 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn
   [junit4]   2> 973166 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict
   [junit4]   2> 973166 T6034 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 973167 T6036 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@25cf6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 973171 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryFunc
   [junit4]   2> 973173 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryFunc
   [junit4]   2> 973178 T6034 oas.SolrTestCaseJ4.setUp ###Starting testTestFuncs
   [junit4]   2> 973181 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testTestFuncs
   [junit4]   2> 973185 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryDismax
   [junit4]   2> 973191 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryDismax
   [junit4]   2> 973195 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncField
   [junit4]   2> 973196 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncField
   [junit4]   2> 973200 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQuerySwitch
   [junit4]   2> 973204 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySwitch
   [junit4]   2> 973208 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSingleValueMathFuncs
   [junit4]   2> 973214 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSingleValueMathFuncs
   [junit4]   2> 973219 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncGeodist
   [junit4]   2> 973223 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGeodist
   [junit4]   2> 973228 T6034 oas.SolrTestCaseJ4.setUp ###Starting testField
   [junit4]   2> 973228 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testField
   [junit4]   2> 973233 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMax
   [junit4]   2> 973234 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMax
   [junit4]   2> 973239 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncLinear
   [junit4]   2> 973241 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncLinear
   [junit4]   2> 973246 T6034 oas.SolrTestCaseJ4.setUp ###Starting testTerms
   [junit4]   2> 973253 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testTerms
   [junit4]   2> 973258 T6034 oas.SolrTestCaseJ4.setUp ###Starting testBlockJoin
   [junit4]   2> 973264 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testBlockJoin
   [junit4]   2> 973268 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryComplexPhrase
   [junit4]   2> 973271 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryComplexPhrase
   [junit4]   2> 973275 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryTerm
   [junit4]   2> 973276 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryTerm
   [junit4]   2> 973281 T6034 oas.SolrTestCaseJ4.setUp ###Starting testReRankQuery
   [junit4]   2> 973286 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testReRankQuery
   [junit4]   2> 973303 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryCollapse
   [junit4]   2> 973303 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryCollapse
   [junit4]   2> 973308 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryLucenePlusSort
   [junit4]   2> 973309 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryLucenePlusSort
   [junit4]   2> 973313 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMin
   [junit4]   2> 973314 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMin
   [junit4]   2> 973317 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncHsin
   [junit4]   2> 973321 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncHsin
   [junit4]   2> 973325 T6034 oas.SolrTestCaseJ4.setUp ###Starting testParserCoverage
   [junit4]   2> 973326 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testParserCoverage
   [junit4]   2> 973330 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSum
   [junit4]   2> 973332 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSum
   [junit4]   2> 973336 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncTop
   [junit4]   2> 973337 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTop
   [junit4]   2> 973341 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncOrd
   [junit4]   2> 973342 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncOrd
   [junit4]   2> 973346 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncVector
   [junit4]   2> 973347 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncVector
   [junit4]   2> 973352 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncCscore
   [junit4]   2> 973352 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncCscore
   [junit4]   2> 973357 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMs
   [junit4]   2> 973359 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMs
   [junit4]   2> 973363 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncBoost
   [junit4]   2> 973366 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncBoost
   [junit4]   2> 973371 T6034 oas.SolrTestCaseJ4.setUp ###Starting testDateMathParsingEquality
   [junit4]   2> 973373 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testDateMathParsingEquality
   [junit4]   2> 973378 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryBbox
   [junit4]   2> 973388 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryBbox
   [junit4]   2> 973393 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncBools
   [junit4]   2> 973394 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncBools
   [junit4]   2> 973400 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncCurrency
   [junit4]   2> 973403 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncCurrency
   [junit4]   2> 973414 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncRecip
   [junit4]   2> 973415 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncRecip
   [junit4]   2> 973420 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDist
   [junit4]   2> 973421 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDist
   [junit4]   2> 973426 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMap
   [junit4]   2> 973427 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMap
   [junit4]   2> 973432 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncIf
   [junit4]   2> 973433 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncIf
   [junit4]   2> 973438 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryLucene
   [junit4]   2> 973440 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryLucene
   [junit4]   2> 973444 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryNested
   [junit4]   2> 973445 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryNested
   [junit4]   2> 973450 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQuerySimple
   [junit4]   2> 973458 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySimple
   [junit4]   2> 973462 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSub
   [junit4]   2> 973463 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSub
   [junit4]   2> 973468 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncProduct
   [junit4]   2> 973469 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncProduct
   [junit4]   2> 973473 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSqedist
   [junit4]   2> 973474 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSqedist
   [junit4]   2> 973479 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncGeohash
   [junit4]   2> 973481 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGeohash
   [junit4]   2> 973500 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryPrefix
   [junit4]   2> 973501 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryPrefix
   [junit4]   2> 973505 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMathConsts
   [junit4]   2> 973506 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMathConsts
   [junit4]   2> 973511 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncJoindf
   [junit4]   2> 973514 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncJoindf
   [junit4]   2> 973518 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncStrdist
   [junit4]   2> 973520 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncStrdist
   [junit4]   2> 973525 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncQuery
   [junit4]   2> 973526 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncQuery
   [junit4]   2> 973530 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncNorm
   [junit4]   2> 973531 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNorm
   [junit4]   2> 973535 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQuerySurround
   [junit4]   2> 973580 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySurround
   [junit4]   2> 973591 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMod
   [junit4]   2> 973593 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMod
   [junit4]   2> 973597 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncTestfunc
   [junit4]   2> 973598 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTestfunc
   [junit4]   2> 973601 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDef
   [junit4]   2> 973602 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDef
   [junit4]   2> 973605 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncNot
   [junit4]   2> 973606 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNot
   [junit4]   2> 973610 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryGeofilt
   [junit4]   2> 973612 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryGeofilt
   [junit4]   2> 973616 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSttf
   [junit4]   2> 973617 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSttf
   [junit4]   2> 973623 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncLiteral
   [junit4]   2> 973623 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncLiteral
   [junit4]   2> 973628 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncScale
   [junit4]   2> 973629 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncScale
   [junit4]   2> 973634 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMaxdoc
   [junit4]   2> 973634 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMaxdoc
   [junit4]   2> 973638 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryMLT
   [junit4]   2> ASYNC  NEW_CORE C1453 name=collection1 org.apache.solr.core.SolrCore@dc540c
   [junit4]   2> 973641 T6034 C1453 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1501439759570960384)]} 0 2
   [junit4]   2> 973648 T6034 C1453 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973650 T6034 C1453 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1fee384 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b0fee),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@1fee384 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b0fee),segFN=segments_2,generation=2}
   [junit4]   2> 973651 T6034 C1453 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 973652 T6034 C1453 oass.SolrIndexSearcher.<init> Opening Searcher@1207338[collection1] main
   [junit4]   2> 973653 T6034 C1453 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 973655 T6036 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1207338[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)))}
   [junit4]   2> 973655 T6034 C1453 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
   [junit4]   2> 973658 T6034 C1453 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973658 T6034 C1453 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 973659 T6034 C1453 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 973659 T6034 C1453 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 973660 T6034 C1453 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 973661 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryMLT
   [junit4]   2> 973666 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDoubleValueBools
   [junit4]   2> 973668 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDoubleValueBools
   [junit4]   2> 973673 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncExists
   [junit4]   2> 973679 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncExists
   [junit4]   2> 973684 T6034 oas.SolrTestCaseJ4.setUp ###Starting testHash
   [junit4]   2> 973689 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testHash
   [junit4]   2> 973713 T6034 oas.SolrTestCaseJ4.setUp ###Starting testAggs
   [junit4]   2> 973716 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testAggs
   [junit4]   2> 973721 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryJoin
   [junit4]   2> 973722 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryJoin
   [junit4]   2> 973726 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncRord
   [junit4]   2> 973726 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncRord
   [junit4]   2> 973731 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncGhhsin
   [junit4]   2> 973731 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGhhsin
   [junit4]   2> 973736 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryRaw
   [junit4]   2> 973737 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryRaw
   [junit4]   2> 973741 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncNumdocs
   [junit4]   2> 973742 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNumdocs
   [junit4]   2> 973746 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryMaxScore
   [junit4]   2> 973748 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryMaxScore
   [junit4]   2> 973752 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDiv
   [junit4]   2> 973753 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDiv
   [junit4]   2> 973756 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDoubleValueMathFuncs
   [junit4]   2> 973758 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDoubleValueMathFuncs
   [junit4]   2> 973763 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncTerms
   [junit4]   2> 973769 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTerms
   [junit4]   2> 973773 T6034 oas.SolrTestCaseJ4.setUp ###Starting testExportQuery
   [junit4]   2> 973774 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testExportQuery
   [junit4]   2> 973778 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryBoost
   [junit4]   2> 973779 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryBoost
   [junit4]   2> 973784 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryFrange
   [junit4]   2> 973784 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryFrange
   [junit4]   2> 973786 T6034 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 973786 T6034 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=5814177
   [junit4]   2> 973787 T6034 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@dc540c
   [junit4]   2> 973787 T6034 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=119,transaction_logs_total_number=1}
   [junit4]   2> 973788 T6034 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 973788 T6034 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 973788 T6034 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 973789 T6034 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 973800 T6034 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 973800 T6034 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 973801 T6034 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index
   [junit4]   2> 973801 T6034 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001;done=false>>]
   [junit4]   2> 973801 T6034 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001
   [junit4]   2> NOTE: test params are: codec=Lucene50, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=mk, timezone=Etc/GMT-7
   [junit4]   2> NOTE: Linux 3.13.0-52-generic i386/Oracle Corporation 1.7.0_80 (32-bit)/cpus=12,threads=1,free=108039352,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestSortingResponseWriter, DistribDocExpirationUpdateProcessorTest, HdfsLockFactoryTest, TestAnalyzeInfixSuggestions, TestJoin, StandardRequestHandlerTest, BasicZkTest, TestRandomFaceting, TestPostingsSolrHighlighter, TestSolr4Spatial, TestTolerantSearch, TestClassNameShortening, TestBlendedInfixSuggestions, TestReplicaProperties, TestArbitraryIndexDir, TestDistributedMissingSort, TermVectorComponentTest, TestChildDocTransformer, MultiTermTest, PrimitiveFieldTypeTest, HighlighterConfigTest, TestMacros, BasicDistributedZkTest, TestBadConfig, TestOrdValues, TestCustomSort, TestBinaryField, HdfsUnloadDistributedZkTest, TestCopyFieldCollectionResource, TestAuthorizationFramework, RuleEngineTest, TestCollapseQParserPlugin, TestJsonFacets, UniqFieldsUpdateProcessorFactoryTest, TestIndexingPerformance, TestConfig, QueryElevationComponentTest, TestRangeQuery, TestUpdate, TestHighlightDedupGrouping, TestLeaderElectionZkExpiry, DateFieldTest, TestDynamicFieldCollectionResource, DistribJoinFromCollectionTest, DistribCursorPagingTest, TestRealTimeGet, SolrTestCaseJ4Test, TestSolrQueryParserResource, TimeZoneUtilsTest, TestFunctionQuery, TestSolrIndexConfig, TestDynamicLoading, SolrCoreTest, TestManagedResourceStorage, UUIDFieldTest, ChaosMonkeyNothingIsSafeTest, IndexBasedSpellCheckerTest, TestJmxIntegration, LeaderElectionIntegrationTest, TestManagedSchemaFieldResource, TestSolrConfigHandlerCloud, TestJmxMonitoredMap, MinimalSchemaTest, TestDistributedSearch, SimpleCollectionCreateDeleteTest, TestComplexPhraseQParserPlugin, TestRemoteStreaming, HdfsBasicDistributedZkTest, DefaultValueUpdateProcessorTest, VMParamsZkACLAndCredentialsProvidersTest, SuggesterWFSTTest, SchemaVersionSpecificBehaviorTest, TestMiniSolrCloudCluster, RequestHandlersTest, ZkNodePropsTest, TestIBSimilarityFactory, CoreAdminCreateDiscoverTest, MergeStrategyTest, TestZkChroot, TestRandomDVFaceting, TestReload, StatsComponentTest, SignatureUpdateProcessorFactoryTest, CoreAdminHandlerTest, SuggesterTSTTest, TestCSVLoader, WordBreakSolrSpellCheckerTest, QueryEqualityTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=QueryEqualityTest -Dtests.seed=5DCA540194741A4D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=mk -Dtests.timezone=Etc/GMT-7 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | QueryEqualityTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([5DCA540194741A4D]:0)
   [junit4]    > 	at org.apache.solr.search.QueryEqualityTest.afterClassParserCoverageTest(QueryEqualityTest.java:63)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [296/490] on J0 in 1.48s, 75 tests, 1 failure <<< FAILURES!

[...truncated 607 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:536: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:484: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:229: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:511: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1433: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:991: There were test failures: 490 suites, 1960 tests, 1 suite-level error, 57 ignored (25 assumptions)

Total time: 55 minutes 23 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



Re: [JENKINS] Lucene-Solr-5.x-Linux (32bit/jdk1.7.0_80) - Build # 12543 - Failure!

Posted by Yonik Seeley <yo...@apache.org>.
Fixing this...
-Yonik


On Sun, May 17, 2015 at 1:52 PM, Policeman Jenkins Server
<je...@thetaphi.de> wrote:
> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/12543/
> Java: 32bit/jdk1.7.0_80 -server -XX:+UseG1GC
>
> 1 tests failed.
> FAILED:  junit.framework.TestSuite.org.apache.solr.search.QueryEqualityTest
>
> Error Message:
> testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
>
> Stack Trace:
> java.lang.AssertionError: testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
>         at __randomizedtesting.SeedInfo.seed([5DCA540194741A4D]:0)
>         at org.junit.Assert.fail(Assert.java:93)
>         at org.junit.Assert.assertTrue(Assert.java:43)
>         at org.apache.solr.search.QueryEqualityTest.afterClassParserCoverageTest(QueryEqualityTest.java:63)
>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>         at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>         at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>         at java.lang.reflect.Method.invoke(Method.java:606)
>         at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
>         at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
>         at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
>         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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
>         at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
>         at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
>         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:365)
>         at java.lang.Thread.run(Thread.java:745)
>
>
>
>
> Build Log:
> [...truncated 10582 lines...]
>    [junit4] Suite: org.apache.solr.search.QueryEqualityTest
>    [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001
>    [junit4]   2> 972383 T6034 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
>    [junit4]   2> 972384 T6034 oas.SolrTestCaseJ4.initCore ####initCore
>    [junit4]   2> 972384 T6034 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
>    [junit4]   2> 972385 T6034 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
>    [junit4]   2> 972385 T6034 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
>    [junit4]   2> 972416 T6034 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
>    [junit4]   2> 972446 T6034 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
>    [junit4]   2> 972487 T6034 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
>    [junit4]   2> 972488 T6034 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
>    [junit4]   2> 972494 T6034 oass.IndexSchema.readSchema [null] Schema name=test
>    [junit4]   2> 972629 T6034 oass.IndexSchema.readSchema default search field in schema is text
>    [junit4]   2> 972631 T6034 oass.IndexSchema.readSchema unique key field: id
>    [junit4]   2> 972632 T6034 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
>    [junit4]   2> 972633 T6034 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
>    [junit4]   2> 972639 T6034 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
>    [junit4]   2> 972639 T6034 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
>    [junit4]   2> 972640 T6034 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/'
>    [junit4]   2> 972652 T6034 oasc.CoreContainer.<init> New CoreContainer 5814177
>    [junit4]   2> 972652 T6034 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/]
>    [junit4]   2> 972652 T6034 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
>    [junit4]   2> 972653 T6034 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib).
>    [junit4]   2> 972658 T6034 oashc.HttpShardHandlerFactory.init created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
>    [junit4]   2> 972659 T6034 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
>    [junit4]   2> 972660 T6034 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
>    [junit4]   2> 972660 T6034 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
>    [junit4]   2> 972660 T6034 oasc.CoreContainer.load Node Name: testNode
>    [junit4]   2> 972661 T6034 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {shard=shard1, name=collection1, instanceDir=collection1, collection=collection1, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001, loadOnStartup=true, transient=false, schema=schema15.xml, config=solrconfig.xml, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/}
>    [junit4]   2> 972662 T6035 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
>    [junit4]   2> 972663 T6035 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
>    [junit4]   2> 972663 T6035 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
>    [junit4]   2> 972685 T6035 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
>    [junit4]   2> 972704 T6035 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
>    [junit4]   2> 972848 T6035 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
>    [junit4]   2> 972848 T6035 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
>    [junit4]   2> 972852 T6035 oass.IndexSchema.readSchema [collection1] Schema name=test
>    [junit4]   2> 972976 T6035 oass.IndexSchema.readSchema default search field in schema is text
>    [junit4]   2> 972978 T6035 oass.IndexSchema.readSchema unique key field: id
>    [junit4]   2> 972979 T6035 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
>    [junit4]   2> 972982 T6035 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
>    [junit4]   2> 972990 T6035 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
>    [junit4]   2> 972990 T6035 x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
>    [junit4]   2> 972990 T6035 x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/], dataDir=[null]
>    [junit4]   2> 972991 T6035 x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@977673
>    [junit4]   2> 972991 T6035 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001
>    [junit4]   2> 972992 T6035 x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index/
>    [junit4]   2> 972992 T6035 x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index' doesn't exist. Creating new index...
>    [junit4]   2> 972992 T6035 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index
>    [junit4]   2> 972993 T6035 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=39942840, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
>    [junit4]   2> 972994 T6035 x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
>    [junit4]   2>                commit{dir=MockDirectoryWrapper(RAMDirectory@1fee384 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b0fee),segFN=segments_1,generation=1}
>    [junit4]   2> 972994 T6035 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
>    [junit4]   2> 973000 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
>    [junit4]   2> 973000 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
>    [junit4]   2> 973001 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
>    [junit4]   2> 973001 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
>    [junit4]   2> 973001 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
>    [junit4]   2> 973001 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
>    [junit4]   2> 973002 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
>    [junit4]   2> 973002 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
>    [junit4]   2> 973002 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
>    [junit4]   2> 973003 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
>    [junit4]   2> 973003 T6035 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
>    [junit4]   2> 973003 T6035 x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
>    [junit4]   2> 973006 T6035 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
>    [junit4]   2> 973008 T6035 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
>    [junit4]   2> 973009 T6035 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
>    [junit4]   2> 973010 T6035 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
>    [junit4]   2> 973015 T6035 x:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy
>    [junit4]   2> 973017 T6035 x:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: spellCheckWithWordbreak_Direct,/admin/system,/admin/luke,/mlt,spellCheckCompRH1,/admin/plugins,/admin/threads,/update/json/docs,/admin/logging,defaults,/debug/dump,spellCheckCompRH_Direct,mltrh,/admin/segments,mock,tvrh,lazy,/admin/mbeans,/config,spellCheckWithWordbreak,/update/csv,/replication,/search-facet-def,/get,/update,/search-facet-invariants,/terms,dismax,spellCheckCompRH,/admin/properties,standard,/admin/ping,/admin/file,/update/json,/schema
>    [junit4]   2> 973018 T6035 x:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
>    [junit4]   2> 973019 T6035 x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
>    [junit4]   2> 973020 T6035 x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
>    [junit4]   2> 973020 T6035 x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
>    [junit4]   2> 973021 T6035 x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
>    [junit4]   2> 973021 T6035 x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
>    [junit4]   2> 973021 T6035 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
>    [junit4]   2> 973022 T6035 x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
>    [junit4]   2>                commit{dir=MockDirectoryWrapper(RAMDirectory@1fee384 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b0fee),segFN=segments_1,generation=1}
>    [junit4]   2> 973022 T6035 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
>    [junit4]   2> 973023 T6035 x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@25cf6[collection1] main
>    [junit4]   2> 973023 T6035 x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
>    [junit4]   2> 973023 T6035 x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
>    [junit4]   2> 973023 T6035 x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
>    [junit4]   2> 973024 T6035 x:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers
>    [junit4]   2> 973053 T6035 x:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
>    [junit4]   2> 973163 T6035 x:collection1 oash.ReplicationHandler.inform Commits will be reserved for  10000
>    [junit4]   2> 973164 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
>    [junit4]   2> 973164 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct
>    [junit4]   2> 973164 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
>    [junit4]   2> 973164 T6035 x:collection1 oasc.CoreContainer.registerCore registering core: collection1
>    [junit4]   2> 973164 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields
>    [junit4]   2> 973165 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler
>    [junit4]   2> 973165 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external
>    [junit4]   2> 973165 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq
>    [junit4]   2> 973166 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn
>    [junit4]   2> 973166 T6036 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict
>    [junit4]   2> 973166 T6034 oas.SolrTestCaseJ4.initCore ####initCore end
>    [junit4]   2> 973167 T6036 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@25cf6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
>    [junit4]   2> 973171 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryFunc
>    [junit4]   2> 973173 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryFunc
>    [junit4]   2> 973178 T6034 oas.SolrTestCaseJ4.setUp ###Starting testTestFuncs
>    [junit4]   2> 973181 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testTestFuncs
>    [junit4]   2> 973185 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryDismax
>    [junit4]   2> 973191 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryDismax
>    [junit4]   2> 973195 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncField
>    [junit4]   2> 973196 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncField
>    [junit4]   2> 973200 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQuerySwitch
>    [junit4]   2> 973204 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySwitch
>    [junit4]   2> 973208 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSingleValueMathFuncs
>    [junit4]   2> 973214 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSingleValueMathFuncs
>    [junit4]   2> 973219 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncGeodist
>    [junit4]   2> 973223 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGeodist
>    [junit4]   2> 973228 T6034 oas.SolrTestCaseJ4.setUp ###Starting testField
>    [junit4]   2> 973228 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testField
>    [junit4]   2> 973233 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMax
>    [junit4]   2> 973234 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMax
>    [junit4]   2> 973239 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncLinear
>    [junit4]   2> 973241 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncLinear
>    [junit4]   2> 973246 T6034 oas.SolrTestCaseJ4.setUp ###Starting testTerms
>    [junit4]   2> 973253 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testTerms
>    [junit4]   2> 973258 T6034 oas.SolrTestCaseJ4.setUp ###Starting testBlockJoin
>    [junit4]   2> 973264 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testBlockJoin
>    [junit4]   2> 973268 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryComplexPhrase
>    [junit4]   2> 973271 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryComplexPhrase
>    [junit4]   2> 973275 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryTerm
>    [junit4]   2> 973276 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryTerm
>    [junit4]   2> 973281 T6034 oas.SolrTestCaseJ4.setUp ###Starting testReRankQuery
>    [junit4]   2> 973286 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testReRankQuery
>    [junit4]   2> 973303 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryCollapse
>    [junit4]   2> 973303 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryCollapse
>    [junit4]   2> 973308 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryLucenePlusSort
>    [junit4]   2> 973309 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryLucenePlusSort
>    [junit4]   2> 973313 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMin
>    [junit4]   2> 973314 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMin
>    [junit4]   2> 973317 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncHsin
>    [junit4]   2> 973321 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncHsin
>    [junit4]   2> 973325 T6034 oas.SolrTestCaseJ4.setUp ###Starting testParserCoverage
>    [junit4]   2> 973326 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testParserCoverage
>    [junit4]   2> 973330 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSum
>    [junit4]   2> 973332 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSum
>    [junit4]   2> 973336 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncTop
>    [junit4]   2> 973337 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTop
>    [junit4]   2> 973341 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncOrd
>    [junit4]   2> 973342 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncOrd
>    [junit4]   2> 973346 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncVector
>    [junit4]   2> 973347 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncVector
>    [junit4]   2> 973352 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncCscore
>    [junit4]   2> 973352 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncCscore
>    [junit4]   2> 973357 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMs
>    [junit4]   2> 973359 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMs
>    [junit4]   2> 973363 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncBoost
>    [junit4]   2> 973366 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncBoost
>    [junit4]   2> 973371 T6034 oas.SolrTestCaseJ4.setUp ###Starting testDateMathParsingEquality
>    [junit4]   2> 973373 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testDateMathParsingEquality
>    [junit4]   2> 973378 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryBbox
>    [junit4]   2> 973388 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryBbox
>    [junit4]   2> 973393 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncBools
>    [junit4]   2> 973394 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncBools
>    [junit4]   2> 973400 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncCurrency
>    [junit4]   2> 973403 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncCurrency
>    [junit4]   2> 973414 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncRecip
>    [junit4]   2> 973415 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncRecip
>    [junit4]   2> 973420 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDist
>    [junit4]   2> 973421 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDist
>    [junit4]   2> 973426 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMap
>    [junit4]   2> 973427 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMap
>    [junit4]   2> 973432 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncIf
>    [junit4]   2> 973433 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncIf
>    [junit4]   2> 973438 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryLucene
>    [junit4]   2> 973440 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryLucene
>    [junit4]   2> 973444 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryNested
>    [junit4]   2> 973445 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryNested
>    [junit4]   2> 973450 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQuerySimple
>    [junit4]   2> 973458 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySimple
>    [junit4]   2> 973462 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSub
>    [junit4]   2> 973463 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSub
>    [junit4]   2> 973468 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncProduct
>    [junit4]   2> 973469 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncProduct
>    [junit4]   2> 973473 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSqedist
>    [junit4]   2> 973474 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSqedist
>    [junit4]   2> 973479 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncGeohash
>    [junit4]   2> 973481 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGeohash
>    [junit4]   2> 973500 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryPrefix
>    [junit4]   2> 973501 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryPrefix
>    [junit4]   2> 973505 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMathConsts
>    [junit4]   2> 973506 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMathConsts
>    [junit4]   2> 973511 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncJoindf
>    [junit4]   2> 973514 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncJoindf
>    [junit4]   2> 973518 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncStrdist
>    [junit4]   2> 973520 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncStrdist
>    [junit4]   2> 973525 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncQuery
>    [junit4]   2> 973526 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncQuery
>    [junit4]   2> 973530 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncNorm
>    [junit4]   2> 973531 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNorm
>    [junit4]   2> 973535 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQuerySurround
>    [junit4]   2> 973580 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySurround
>    [junit4]   2> 973591 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMod
>    [junit4]   2> 973593 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMod
>    [junit4]   2> 973597 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncTestfunc
>    [junit4]   2> 973598 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTestfunc
>    [junit4]   2> 973601 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDef
>    [junit4]   2> 973602 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDef
>    [junit4]   2> 973605 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncNot
>    [junit4]   2> 973606 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNot
>    [junit4]   2> 973610 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryGeofilt
>    [junit4]   2> 973612 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryGeofilt
>    [junit4]   2> 973616 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncSttf
>    [junit4]   2> 973617 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSttf
>    [junit4]   2> 973623 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncLiteral
>    [junit4]   2> 973623 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncLiteral
>    [junit4]   2> 973628 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncScale
>    [junit4]   2> 973629 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncScale
>    [junit4]   2> 973634 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncMaxdoc
>    [junit4]   2> 973634 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMaxdoc
>    [junit4]   2> 973638 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryMLT
>    [junit4]   2> ASYNC  NEW_CORE C1453 name=collection1 org.apache.solr.core.SolrCore@dc540c
>    [junit4]   2> 973641 T6034 C1453 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1501439759570960384)]} 0 2
>    [junit4]   2> 973648 T6034 C1453 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
>    [junit4]   2> 973650 T6034 C1453 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
>    [junit4]   2>                commit{dir=MockDirectoryWrapper(RAMDirectory@1fee384 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b0fee),segFN=segments_1,generation=1}
>    [junit4]   2>                commit{dir=MockDirectoryWrapper(RAMDirectory@1fee384 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@10b0fee),segFN=segments_2,generation=2}
>    [junit4]   2> 973651 T6034 C1453 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
>    [junit4]   2> 973652 T6034 C1453 oass.SolrIndexSearcher.<init> Opening Searcher@1207338[collection1] main
>    [junit4]   2> 973653 T6034 C1453 oasu.DirectUpdateHandler2.commit end_commit_flush
>    [junit4]   2> 973655 T6036 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1207338[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)))}
>    [junit4]   2> 973655 T6034 C1453 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8
>    [junit4]   2> 973658 T6034 C1453 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
>    [junit4]   2> 973658 T6034 C1453 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
>    [junit4]   2> 973659 T6034 C1453 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
>    [junit4]   2> 973659 T6034 C1453 oasu.DirectUpdateHandler2.commit end_commit_flush
>    [junit4]   2> 973660 T6034 C1453 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
>    [junit4]   2> 973661 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryMLT
>    [junit4]   2> 973666 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDoubleValueBools
>    [junit4]   2> 973668 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDoubleValueBools
>    [junit4]   2> 973673 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncExists
>    [junit4]   2> 973679 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncExists
>    [junit4]   2> 973684 T6034 oas.SolrTestCaseJ4.setUp ###Starting testHash
>    [junit4]   2> 973689 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testHash
>    [junit4]   2> 973713 T6034 oas.SolrTestCaseJ4.setUp ###Starting testAggs
>    [junit4]   2> 973716 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testAggs
>    [junit4]   2> 973721 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryJoin
>    [junit4]   2> 973722 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryJoin
>    [junit4]   2> 973726 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncRord
>    [junit4]   2> 973726 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncRord
>    [junit4]   2> 973731 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncGhhsin
>    [junit4]   2> 973731 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGhhsin
>    [junit4]   2> 973736 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryRaw
>    [junit4]   2> 973737 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryRaw
>    [junit4]   2> 973741 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncNumdocs
>    [junit4]   2> 973742 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNumdocs
>    [junit4]   2> 973746 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryMaxScore
>    [junit4]   2> 973748 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryMaxScore
>    [junit4]   2> 973752 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDiv
>    [junit4]   2> 973753 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDiv
>    [junit4]   2> 973756 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncDoubleValueMathFuncs
>    [junit4]   2> 973758 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDoubleValueMathFuncs
>    [junit4]   2> 973763 T6034 oas.SolrTestCaseJ4.setUp ###Starting testFuncTerms
>    [junit4]   2> 973769 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTerms
>    [junit4]   2> 973773 T6034 oas.SolrTestCaseJ4.setUp ###Starting testExportQuery
>    [junit4]   2> 973774 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testExportQuery
>    [junit4]   2> 973778 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryBoost
>    [junit4]   2> 973779 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryBoost
>    [junit4]   2> 973784 T6034 oas.SolrTestCaseJ4.setUp ###Starting testQueryFrange
>    [junit4]   2> 973784 T6034 oas.SolrTestCaseJ4.tearDown ###Ending testQueryFrange
>    [junit4]   2> 973786 T6034 oas.SolrTestCaseJ4.deleteCore ###deleteCore
>    [junit4]   2> 973786 T6034 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=5814177
>    [junit4]   2> 973787 T6034 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@dc540c
>    [junit4]   2> 973787 T6034 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=119,transaction_logs_total_number=1}
>    [junit4]   2> 973788 T6034 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
>    [junit4]   2> 973788 T6034 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
>    [junit4]   2> 973788 T6034 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
>    [junit4]   2> 973789 T6034 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
>    [junit4]   2> 973800 T6034 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
>    [junit4]   2> 973800 T6034 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index;done=false>>]
>    [junit4]   2> 973801 T6034 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001/index
>    [junit4]   2> 973801 T6034 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001;done=false>>]
>    [junit4]   2> 973801 T6034 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5DCA540194741A4D-001/init-core-data-001
>    [junit4]   2> NOTE: test params are: codec=Lucene50, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=mk, timezone=Etc/GMT-7
>    [junit4]   2> NOTE: Linux 3.13.0-52-generic i386/Oracle Corporation 1.7.0_80 (32-bit)/cpus=12,threads=1,free=108039352,total=536870912
>    [junit4]   2> NOTE: All tests run in this JVM: [TestSortingResponseWriter, DistribDocExpirationUpdateProcessorTest, HdfsLockFactoryTest, TestAnalyzeInfixSuggestions, TestJoin, StandardRequestHandlerTest, BasicZkTest, TestRandomFaceting, TestPostingsSolrHighlighter, TestSolr4Spatial, TestTolerantSearch, TestClassNameShortening, TestBlendedInfixSuggestions, TestReplicaProperties, TestArbitraryIndexDir, TestDistributedMissingSort, TermVectorComponentTest, TestChildDocTransformer, MultiTermTest, PrimitiveFieldTypeTest, HighlighterConfigTest, TestMacros, BasicDistributedZkTest, TestBadConfig, TestOrdValues, TestCustomSort, TestBinaryField, HdfsUnloadDistributedZkTest, TestCopyFieldCollectionResource, TestAuthorizationFramework, RuleEngineTest, TestCollapseQParserPlugin, TestJsonFacets, UniqFieldsUpdateProcessorFactoryTest, TestIndexingPerformance, TestConfig, QueryElevationComponentTest, TestRangeQuery, TestUpdate, TestHighlightDedupGrouping, TestLeaderElectionZkExpiry, DateFieldTest, TestDynamicFieldCollectionResource, DistribJoinFromCollectionTest, DistribCursorPagingTest, TestRealTimeGet, SolrTestCaseJ4Test, TestSolrQueryParserResource, TimeZoneUtilsTest, TestFunctionQuery, TestSolrIndexConfig, TestDynamicLoading, SolrCoreTest, TestManagedResourceStorage, UUIDFieldTest, ChaosMonkeyNothingIsSafeTest, IndexBasedSpellCheckerTest, TestJmxIntegration, LeaderElectionIntegrationTest, TestManagedSchemaFieldResource, TestSolrConfigHandlerCloud, TestJmxMonitoredMap, MinimalSchemaTest, TestDistributedSearch, SimpleCollectionCreateDeleteTest, TestComplexPhraseQParserPlugin, TestRemoteStreaming, HdfsBasicDistributedZkTest, DefaultValueUpdateProcessorTest, VMParamsZkACLAndCredentialsProvidersTest, SuggesterWFSTTest, SchemaVersionSpecificBehaviorTest, TestMiniSolrCloudCluster, RequestHandlersTest, ZkNodePropsTest, TestIBSimilarityFactory, CoreAdminCreateDiscoverTest, MergeStrategyTest, TestZkChroot, TestRandomDVFaceting, TestReload, StatsComponentTest, SignatureUpdateProcessorFactoryTest, CoreAdminHandlerTest, SuggesterTSTTest, TestCSVLoader, WordBreakSolrSpellCheckerTest, QueryEqualityTest]
>    [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=QueryEqualityTest -Dtests.seed=5DCA540194741A4D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=mk -Dtests.timezone=Etc/GMT-7 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
>    [junit4] ERROR   0.00s J0 | QueryEqualityTest (suite) <<<
>    [junit4]    > Throwable #1: java.lang.AssertionError: testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
>    [junit4]    >        at __randomizedtesting.SeedInfo.seed([5DCA540194741A4D]:0)
>    [junit4]    >        at org.apache.solr.search.QueryEqualityTest.afterClassParserCoverageTest(QueryEqualityTest.java:63)
>    [junit4]    >        at java.lang.Thread.run(Thread.java:745)
>    [junit4] Completed [296/490] on J0 in 1.48s, 75 tests, 1 failure <<< FAILURES!
>
> [...truncated 607 lines...]
> BUILD FAILED
> /home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:536: The following error occurred while executing this line:
> /home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:484: The following error occurred while executing this line:
> /home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
> /home/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
> /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:229: The following error occurred while executing this line:
> /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:511: The following error occurred while executing this line:
> /home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1433: The following error occurred while executing this line:
> /home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:991: There were test failures: 490 suites, 1960 tests, 1 suite-level error, 57 ignored (25 assumptions)
>
> Total time: 55 minutes 23 seconds
> Build step 'Invoke Ant' marked build as failure
> Archiving artifacts
> Recording test results
> Email was triggered for: Failure - Any
> Sending email for trigger: Failure - Any
>


---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org


[JENKINS] Lucene-Solr-5.x-Linux (64bit/jdk1.7.0_80) - Build # 12545 - Still Failing!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/12545/
Java: 64bit/jdk1.7.0_80 -XX:-UseCompressedOops -XX:+UseParallelGC

2 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.HttpPartitionTest

Error Message:
Some resources were not closed, shutdown, or released.

Stack Trace:
java.lang.AssertionError: Some resources were not closed, shutdown, or released.
	at __randomizedtesting.SeedInfo.seed([5B3FCB46275D3B2C]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:234)
	at sun.reflect.GeneratedMethodAccessor41.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	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:365)
	at java.lang.Thread.run(Thread.java:745)


FAILED:  junit.framework.TestSuite.org.apache.solr.search.QueryEqualityTest

Error Message:
testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll

Stack Trace:
java.lang.AssertionError: testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
	at __randomizedtesting.SeedInfo.seed([5B3FCB46275D3B2C]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.search.QueryEqualityTest.afterClassParserCoverageTest(QueryEqualityTest.java:63)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:606)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	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:365)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10401 lines...]
   [junit4] Suite: org.apache.solr.search.QueryEqualityTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001
   [junit4]   2> 919268 T6789 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 919268 T6789 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 919268 T6789 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 919269 T6789 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 919269 T6789 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 919283 T6789 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 919294 T6789 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 919317 T6789 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 919318 T6789 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 919321 T6789 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 919434 T6789 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 919435 T6789 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 919436 T6789 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 919438 T6789 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 919442 T6789 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 919442 T6789 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 919442 T6789 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 919449 T6789 oasc.CoreContainer.<init> New CoreContainer 648834816
   [junit4]   2> 919449 T6789 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 919450 T6789 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 919450 T6789 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib).
   [junit4]   2> 919454 T6789 oashc.HttpShardHandlerFactory.init created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 919455 T6789 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 919455 T6789 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 919456 T6789 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 919456 T6789 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 919456 T6789 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {instanceDir=collection1, shard=shard1, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, name=collection1, transient=false, collection=collection1, loadOnStartup=true, schema=schema15.xml, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001, config=solrconfig.xml}
   [junit4]   2> 919457 T6790 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 919457 T6790 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 919457 T6790 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 919469 T6790 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 919491 T6790 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 919515 T6790 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 919515 T6790 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 919519 T6790 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 919640 T6790 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 919641 T6790 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 919642 T6790 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 919644 T6790 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 919648 T6790 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 919649 T6790 x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 919649 T6790 x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/], dataDir=[null]
   [junit4]   2> 919649 T6790 x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@591b1b5a
   [junit4]   2> 919650 T6790 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001
   [junit4]   2> 919650 T6790 x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001/index/
   [junit4]   2> 919650 T6790 x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 919650 T6790 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001/index
   [junit4]   2> 919650 T6790 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=38, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=65.333984375, floorSegmentMB=1.8310546875, forceMergeDeletesPctAllowed=12.98902442876898, segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8922340635776675
   [junit4]   2> 919651 T6790 x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@77f4fb3e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@749ae0f8),segFN=segments_1,generation=1}
   [junit4]   2> 919651 T6790 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 919653 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 919654 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 919654 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 919654 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 919654 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 919654 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 919654 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 919654 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 919654 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 919655 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 919655 T6790 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 919655 T6790 x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 919657 T6790 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 919657 T6790 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 919658 T6790 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 919659 T6790 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 919661 T6790 x:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 919662 T6790 x:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: tvrh,/search-facet-def,standard,/admin/luke,spellCheckCompRH,dismax,mltrh,/admin/properties,spellCheckCompRH_Direct,/debug/dump,lazy,/config,/terms,spellCheckWithWordbreak,mock,/replication,/admin/threads,spellCheckCompRH1,defaults,/mlt,/admin/ping,/admin/system,/update,/schema,/admin/mbeans,/admin/logging,/admin/segments,/update/json,/admin/file,/update/json/docs,/get,/search-facet-invariants,/update/csv,/admin/plugins,spellCheckWithWordbreak_Direct
   [junit4]   2> 919663 T6790 x:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 919664 T6790 x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 919664 T6790 x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 919664 T6790 x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 919664 T6790 x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 919664 T6790 x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 919665 T6790 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=50, maxMergeAtOnceExplicit=28, maxMergedSegmentMB=14.158203125, floorSegmentMB=1.9833984375, forceMergeDeletesPctAllowed=8.095548620969744, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7046990872074826
   [junit4]   2> 919665 T6790 x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@77f4fb3e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@749ae0f8),segFN=segments_1,generation=1}
   [junit4]   2> 919665 T6790 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 919665 T6790 x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@c6fc68b[collection1] main
   [junit4]   2> 919666 T6790 x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 919666 T6790 x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 919666 T6790 x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 919666 T6790 x:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 919684 T6790 x:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 919786 T6790 x:collection1 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 919787 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
   [junit4]   2> 919787 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct
   [junit4]   2> 919787 T6790 x:collection1 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 919787 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
   [junit4]   2> 919787 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields
   [junit4]   2> 919788 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 919788 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external
   [junit4]   2> 919788 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq
   [junit4]   2> 919789 T6789 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 919789 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn
   [junit4]   2> 919789 T6791 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict
   [junit4]   2> 919790 T6791 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c6fc68b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 919791 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryMLT
   [junit4]   2> ASYNC  NEW_CORE C1879 name=collection1 org.apache.solr.core.SolrCore@5fd6a60c
   [junit4]   2> 919793 T6789 C1879 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1501451152975200256)]} 0 1
   [junit4]   2> 919794 T6789 C1879 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 919795 T6789 C1879 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@77f4fb3e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@749ae0f8),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@77f4fb3e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@749ae0f8),segFN=segments_2,generation=2}
   [junit4]   2> 919796 T6789 C1879 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 919796 T6789 C1879 oass.SolrIndexSearcher.<init> Opening Searcher@7e27a9b3[collection1] main
   [junit4]   2> 919797 T6789 C1879 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 919797 T6791 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7e27a9b3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)))}
   [junit4]   2> 919798 T6789 C1879 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 4
   [junit4]   2> 919802 T6789 C1879 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 919802 T6789 C1879 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 919802 T6789 C1879 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 919802 T6789 C1879 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 919803 T6789 C1879 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 919803 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryMLT
   [junit4]   2> 919805 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncDoubleValueMathFuncs
   [junit4]   2> 919807 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDoubleValueMathFuncs
   [junit4]   2> 919808 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncRecip
   [junit4]   2> 919809 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncRecip
   [junit4]   2> 919811 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryTerm
   [junit4]   2> 919811 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryTerm
   [junit4]   2> 919813 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryGeofilt
   [junit4]   2> 919817 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryGeofilt
   [junit4]   2> 919820 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncDiv
   [junit4]   2> 919821 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDiv
   [junit4]   2> 919822 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncOrd
   [junit4]   2> 919823 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncOrd
   [junit4]   2> 919824 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncGeohash
   [junit4]   2> 919825 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGeohash
   [junit4]   2> 919827 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryMaxScore
   [junit4]   2> 919830 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryMaxScore
   [junit4]   2> 919832 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncTerms
   [junit4]   2> 919836 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTerms
   [junit4]   2> 919839 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncNumdocs
   [junit4]   2> 919839 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNumdocs
   [junit4]   2> 919841 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncField
   [junit4]   2> 919841 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncField
   [junit4]   2> 919843 T6789 oas.SolrTestCaseJ4.setUp ###Starting testParserCoverage
   [junit4]   2> 919843 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testParserCoverage
   [junit4]   2> 919845 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncMin
   [junit4]   2> 919846 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMin
   [junit4]   2> 919848 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryLucenePlusSort
   [junit4]   2> 919850 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryLucenePlusSort
   [junit4]   2> 919852 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncLinear
   [junit4]   2> 919853 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncLinear
   [junit4]   2> 919862 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncQuery
   [junit4]   2> 919863 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncQuery
   [junit4]   2> 919865 T6789 oas.SolrTestCaseJ4.setUp ###Starting testHash
   [junit4]   2> 919867 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testHash
   [junit4]   2> 919869 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncJoindf
   [junit4]   2> 919870 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncJoindf
   [junit4]   2> 919872 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryBbox
   [junit4]   2> 919873 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryBbox
   [junit4]   2> 919883 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryFrange
   [junit4]   2> 919883 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryFrange
   [junit4]   2> 919899 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQuerySimple
   [junit4]   2> 919903 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySimple
   [junit4]   2> 919912 T6789 oas.SolrTestCaseJ4.setUp ###Starting testExportQuery
   [junit4]   2> 919913 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testExportQuery
   [junit4]   2> 919915 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryCollapse
   [junit4]   2> 919917 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryCollapse
   [junit4]   2> 919918 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncExists
   [junit4]   2> 919919 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncExists
   [junit4]   2> 919931 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryRaw
   [junit4]   2> 919931 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryRaw
   [junit4]   2> 919935 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncBools
   [junit4]   2> 919935 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncBools
   [junit4]   2> 919937 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncMathConsts
   [junit4]   2> 919937 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMathConsts
   [junit4]   2> 919940 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryLucene
   [junit4]   2> 919941 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryLucene
   [junit4]   2> 919943 T6789 oas.SolrTestCaseJ4.setUp ###Starting testBlockJoin
   [junit4]   2> 919947 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testBlockJoin
   [junit4]   2> 919949 T6789 oas.SolrTestCaseJ4.setUp ###Starting testAggs
   [junit4]   2> 919951 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testAggs
   [junit4]   2> 919953 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncLiteral
   [junit4]   2> 919953 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncLiteral
   [junit4]   2> 919955 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncNorm
   [junit4]   2> 919955 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNorm
   [junit4]   2> 919957 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncMs
   [junit4]   2> 919958 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMs
   [junit4]   2> 919960 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryNested
   [junit4]   2> 919960 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryNested
   [junit4]   2> 919962 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncGeodist
   [junit4]   2> 919963 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGeodist
   [junit4]   2> 919964 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncMap
   [junit4]   2> 919965 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMap
   [junit4]   2> 919967 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncProduct
   [junit4]   2> 919968 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncProduct
   [junit4]   2> 919969 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncSingleValueMathFuncs
   [junit4]   2> 919974 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSingleValueMathFuncs
   [junit4]   2> 919976 T6789 oas.SolrTestCaseJ4.setUp ###Starting testTerms
   [junit4]   2> 919981 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testTerms
   [junit4]   2> 919983 T6789 oas.SolrTestCaseJ4.setUp ###Starting testField
   [junit4]   2> 919984 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testField
   [junit4]   2> 919986 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncSttf
   [junit4]   2> 919986 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSttf
   [junit4]   2> 919988 T6789 oas.SolrTestCaseJ4.setUp ###Starting testDateMathParsingEquality
   [junit4]   2> 919988 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testDateMathParsingEquality
   [junit4]   2> 919990 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryComplexPhrase
   [junit4]   2> 919991 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryComplexPhrase
   [junit4]   2> 919993 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncCscore
   [junit4]   2> 919994 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncCscore
   [junit4]   2> 919996 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryDismax
   [junit4]   2> 920001 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryDismax
   [junit4]   2> 920003 T6789 oas.SolrTestCaseJ4.setUp ###Starting testTestFuncs
   [junit4]   2> 920005 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testTestFuncs
   [junit4]   2> 920007 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncNot
   [junit4]   2> 920008 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNot
   [junit4]   2> 920010 T6789 oas.SolrTestCaseJ4.setUp ###Starting testReRankQuery
   [junit4]   2> 920011 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testReRankQuery
   [junit4]   2> 920013 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncSub
   [junit4]   2> 920013 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSub
   [junit4]   2> 920015 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncDef
   [junit4]   2> 920015 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDef
   [junit4]   2> 920017 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncMaxdoc
   [junit4]   2> 920017 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMaxdoc
   [junit4]   2> 920019 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQuerySwitch
   [junit4]   2> 920021 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySwitch
   [junit4]   2> 920022 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncMax
   [junit4]   2> 920023 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMax
   [junit4]   2> 920024 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncSum
   [junit4]   2> 920025 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSum
   [junit4]   2> 920028 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQuerySurround
   [junit4]   2> 920051 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySurround
   [junit4]   2> 920053 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryFunc
   [junit4]   2> 920054 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryFunc
   [junit4]   2> 920056 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncGhhsin
   [junit4]   2> 920056 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGhhsin
   [junit4]   2> 920058 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncDist
   [junit4]   2> 920059 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDist
   [junit4]   2> 920060 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncIf
   [junit4]   2> 920061 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncIf
   [junit4]   2> 920063 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncCurrency
   [junit4]   2> 920064 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncCurrency
   [junit4]   2> 920066 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncMod
   [junit4]   2> 920067 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMod
   [junit4]   2> 920068 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncTop
   [junit4]   2> 920069 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTop
   [junit4]   2> 920070 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncStrdist
   [junit4]   2> 920071 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncStrdist
   [junit4]   2> 920073 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncBoost
   [junit4]   2> 920074 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncBoost
   [junit4]   2> 920076 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncTestfunc
   [junit4]   2> 920076 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTestfunc
   [junit4]   2> 920078 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncRord
   [junit4]   2> 920079 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncRord
   [junit4]   2> 920080 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryJoin
   [junit4]   2> 920081 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryJoin
   [junit4]   2> 920083 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncDoubleValueBools
   [junit4]   2> 920084 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDoubleValueBools
   [junit4]   2> 920085 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncVector
   [junit4]   2> 920086 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncVector
   [junit4]   2> 920088 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncScale
   [junit4]   2> 920088 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncScale
   [junit4]   2> 920090 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryBoost
   [junit4]   2> 920090 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryBoost
   [junit4]   2> 920092 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncSqedist
   [junit4]   2> 920092 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSqedist
   [junit4]   2> 920094 T6789 oas.SolrTestCaseJ4.setUp ###Starting testFuncHsin
   [junit4]   2> 920095 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testFuncHsin
   [junit4]   2> 920097 T6789 oas.SolrTestCaseJ4.setUp ###Starting testQueryPrefix
   [junit4]   2> 920098 T6789 oas.SolrTestCaseJ4.tearDown ###Ending testQueryPrefix
   [junit4]   2> 920098 T6789 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 920098 T6789 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=648834816
   [junit4]   2> 920098 T6789 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@5fd6a60c
   [junit4]   2> 920099 T6789 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=119,transaction_logs_total_number=1}
   [junit4]   2> 920099 T6789 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 920099 T6789 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 920099 T6789 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 920099 T6789 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 920122 T6789 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 920122 T6789 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001;done=false>>]
   [junit4]   2> 920122 T6789 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001
   [junit4]   2> 920122 T6789 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 920122 T6789 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.search.QueryEqualityTest 5B3FCB46275D3B2C-001/init-core-data-001/index
   [junit4]   2> NOTE: test params are: codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=32389, maxDocsPerChunk=1, blockSize=219), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION, chunkSize=32389, blockSize=219)), sim=DefaultSimilarity, locale=sr__#Latn, timezone=America/Argentina/Cordoba
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=12,threads=1,free=282442088,total=472907776
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrIndexConfig, HdfsLockFactoryTest, TestBinaryField, TestHighlightDedupGrouping, TestSolrConfigHandlerConcurrent, IndexBasedSpellCheckerTest, MergeStrategyTest, TestReplicaProperties, TestAddFieldRealTimeGet, SignatureUpdateProcessorFactoryTest, CoreAdminCreateDiscoverTest, TestFreeTextSuggestions, TestBlendedInfixSuggestions, VMParamsZkACLAndCredentialsProvidersTest, DistributedFacetPivotWhiteBoxTest, TestRemoveLastDynamicCopyField, TestRandomDVFaceting, TestJsonFacets, TestObjectReleaseTracker, TestDFRSimilarityFactory, SuggestComponentTest, TestComplexPhraseQParserPlugin, SolrRequestParserTest, SchemaVersionSpecificBehaviorTest, TestDistributedSearch, DeleteInactiveReplicaTest, DocExpirationUpdateProcessorFactoryTest, TestCustomSort, TestClassNameShortening, UniqFieldsUpdateProcessorFactoryTest, TestSolrConfigHandler, DistribJoinFromCollectionTest, TestSolrQueryParserResource, TestDistributedMissingSort, TestLazyCores, TestUpdate, MinimalSchemaTest, QueryElevationComponentTest, TermsComponentTest, DistanceUnitsTest, DistribCursorPagingTest, UpdateRequestProcessorFactoryTest, TestMacros, TestSolrDynamicMBean, TestMiniSolrCloudClusterSSL, TestTolerantSearch, SolrCoreTest, TestJmxMonitoredMap, TestPhraseSuggestions, PingRequestHandlerTest, TestFaceting, TestSolrConfigHandlerCloud, DistributedSpellCheckComponentTest, FacetPivotSmallTest, TestCursorMarkWithoutUniqueKey, TestStressLucene, TestStressUserVersions, TestShardHandlerFactory, TermVectorComponentTest, ClusterStateTest, PreAnalyzedUpdateProcessorTest, TestMiniSolrCloudCluster, TestQuerySenderListener, TestManagedSynonymFilterFactory, TestFieldCollectionResource, TestCodecSupport, TestCollationFieldDocValues, HdfsUnloadDistributedZkTest, ExternalFileFieldSortTest, TestReRankQParserPlugin, DefaultValueUpdateProcessorTest, TestPostingsSolrHighlighter, BasicDistributedZkTest, TestConfig, TestDynamicFieldCollectionResource, SolrTestCaseJ4Test, DebugComponentTest, TestManagedSchemaFieldResource, SyncSliceTest, LeaderElectionIntegrationTest, BasicZkTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, ZkSolrClientTest, TestRecovery, TermVectorComponentDistributedTest, TestJoin, SimpleFacetsTest, TestGroupingSearch, TestFunctionQuery, TestBadConfig, OverseerCollectionProcessorTest, HighlighterTest, SoftAutoCommitTest, TestPseudoReturnFields, QueryEqualityTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=QueryEqualityTest -Dtests.seed=5B3FCB46275D3B2C -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr__#Latn -Dtests.timezone=America/Argentina/Cordoba -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | QueryEqualityTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([5B3FCB46275D3B2C]:0)
   [junit4]    > 	at org.apache.solr.search.QueryEqualityTest.afterClassParserCoverageTest(QueryEqualityTest.java:63)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [295/490] on J0 in 0.89s, 75 tests, 1 failure <<< FAILURES!

[...truncated 286 lines...]
   [junit4] Suite: org.apache.solr.cloud.HttpPartitionTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/init-core-data-001
   [junit4]   2> 1056073 T8735 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
   [junit4]   2> 1056076 T8735 oasc.ZkTestServer.run STARTING ZK TEST SERVER
   [junit4]   2> 1056076 T8736 oasc.ZkTestServer$2$1.setClientPort client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1056076 T8736 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
   [junit4]   2> 1056176 T8735 oasc.ZkTestServer.run start zk server on port:51754
   [junit4]   2> 1056177 T8735 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 1056177 T8735 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1056179 T8743 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7d9bde3d name:ZooKeeperConnection Watcher:127.0.0.1:51754 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1056179 T8735 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1056179 T8735 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 1056179 T8735 oascc.SolrZkClient.makePath makePath: /solr
   [junit4]   2> 1056181 T8735 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 1056181 T8735 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1056182 T8746 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@35bb620 name:ZooKeeperConnection Watcher:127.0.0.1:51754/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1056182 T8735 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1056182 T8735 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 1056182 T8735 oascc.SolrZkClient.makePath makePath: /collections/collection1
   [junit4]   2> 1056183 T8735 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
   [junit4]   2> 1056184 T8735 oascc.SolrZkClient.makePath makePath: /collections/control_collection
   [junit4]   2> 1056184 T8735 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
   [junit4]   2> 1056185 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
   [junit4]   2> 1056186 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1056187 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
   [junit4]   2> 1056187 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
   [junit4]   2> 1056188 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1056188 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1056188 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
   [junit4]   2> 1056189 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 1056189 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
   [junit4]   2> 1056189 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
   [junit4]   2> 1056190 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
   [junit4]   2> 1056190 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
   [junit4]   2> 1056191 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1056191 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 1056192 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1056192 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1056192 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1056192 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1056193 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1056193 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 1056194 T8735 oasc.AbstractZkTestCase.putConfig put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
   [junit4]   2> 1056194 T8735 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 1056236 T8735 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1
   [junit4]   2> 1056238 T8735 oejs.Server.doStart jetty-9.2.10.v20150310
   [junit4]   2> 1056239 T8735 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@3d5b0e56{/,null,AVAILABLE}
   [junit4]   2> 1056241 T8735 oejs.AbstractConnector.doStart Started ServerConnector@47ee0d3d{HTTP/1.1}{127.0.0.1:48017}
   [junit4]   2> 1056241 T8735 oejs.Server.doStart Started @1057236ms
   [junit4]   2> 1056241 T8735 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/tempDir-001/control/data, hostContext=/, hostPort=32771, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores}
   [junit4]   2> 1056242 T8735 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@7b3cb2c6
   [junit4]   2> 1056242 T8735 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/'
   [junit4]   2> 1056260 T8735 oasc.SolrXmlConfig.fromFile Loading container configuration from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/solr.xml
   [junit4]   2> 1056268 T8735 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores
   [junit4]   2> 1056268 T8735 oasc.CoreContainer.<init> New CoreContainer 1190186690
   [junit4]   2> 1056269 T8735 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/]
   [junit4]   2> 1056269 T8735 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/lib
   [junit4]   2> 1056269 T8735 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/lib).
   [junit4]   2> 1056274 T8735 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1056274 T8735 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1056275 T8735 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1056275 T8735 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1056275 T8735 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 1056275 T8735 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:51754/solr
   [junit4]   2> 1056275 T8735 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 1056275 T8735 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 1056276 T8735 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1056277 T8760 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4a97333c name:ZooKeeperConnection Watcher:127.0.0.1:51754 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1056277 T8735 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1056277 T8735 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 1056278 T8735 n:127.0.0.1:32771_ oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1056279 T8763 n:127.0.0.1:32771_ oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1f11afe8 name:ZooKeeperConnection Watcher:127.0.0.1:51754/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1056279 T8735 n:127.0.0.1:32771_ oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1056280 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer/queue
   [junit4]   2> 1056281 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
   [junit4]   2> 1056282 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running
   [junit4]   2> 1056282 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed
   [junit4]   2> 1056283 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure
   [junit4]   2> 1056284 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /live_nodes
   [junit4]   2> 1056284 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /aliases.json
   [junit4]   2> 1056285 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /clusterstate.json
   [junit4]   2> 1056286 T8735 n:127.0.0.1:32771_ oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32771_
   [junit4]   2> 1056286 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:32771_
   [junit4]   2> 1056286 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer_elect
   [junit4]   2> 1056287 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer_elect/election
   [junit4]   2> 1056288 T8735 n:127.0.0.1:32771_ oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 1056288 T8735 n:127.0.0.1:32771_ oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:32771_
   [junit4]   2> 1056288 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
   [junit4]   2> 1056289 T8735 n:127.0.0.1:32771_ oasc.Overseer.start Overseer (id=93840705993179139-127.0.0.1:32771_-n_0000000000) starting
   [junit4]   2> 1056290 T8735 n:127.0.0.1:32771_ oascc.SolrZkClient.makePath makePath: /overseer/queue-work
   [junit4]   2> 1056292 T8735 n:127.0.0.1:32771_ oasc.OverseerAutoReplicaFailoverThread.<init> Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1056292 T8735 n:127.0.0.1:32771_ oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 1056292 T8765 n:127.0.0.1:32771_ oasc.OverseerCollectionProcessor.run Process current queue of collection creations
   [junit4]   2> 1056292 T8764 n:127.0.0.1:32771_ oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
   [junit4]   2> 1056293 T8735 n:127.0.0.1:32771_ oasc.CoreContainer.intializeAuthorizationPlugin Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1056294 T8735 n:127.0.0.1:32771_ oasc.CorePropertiesLocator.discover Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores
   [junit4]   2> 1056295 T8735 n:127.0.0.1:32771_ oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1/, transient=false, shard=, instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1, collection=control_collection, name=collection1, schema=schema.xml, config=solrconfig.xml, loadOnStartup=true, coreNodeName=, dataDir=data/}
   [junit4]   2> 1056295 T8735 n:127.0.0.1:32771_ oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1/
   [junit4]   2> 1056295 T8735 n:127.0.0.1:32771_ oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 1056296 T8767 n:127.0.0.1:32771_ c:control_collection x:collection1 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection
   [junit4]   2> 1056296 T8767 n:127.0.0.1:32771_ c:control_collection x:collection1 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1056296 T8767 n:127.0.0.1:32771_ oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 1056296 T8763 n:127.0.0.1:32771_ oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 1056297 T8764 n:127.0.0.1:32771_ oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2> 	  "shard":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:32771_",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:32771",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "numShards":"1",
   [junit4]   2> 	  "collection":"control_collection",
   [junit4]   2> 	  "roles":null} current state version: 0
   [junit4]   2> 1056297 T8764 n:127.0.0.1:32771_ oasco.ReplicaMutator.updateState Update state numShards=1 message={
   [junit4]   2> 	  "shard":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:32771_",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:32771",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "numShards":"1",
   [junit4]   2> 	  "collection":"control_collection",
   [junit4]   2> 	  "roles":null}
   [junit4]   2> 1056297 T8764 n:127.0.0.1:32771_ oasco.ClusterStateMutator.createCollection building a new cName: control_collection
   [junit4]   2> 1056297 T8764 n:127.0.0.1:32771_ oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 1056298 T8763 n:127.0.0.1:32771_ oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 1057296 T8767 n:127.0.0.1:32771_ oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1
   [junit4]   2> 1057296 T8767 n:127.0.0.1:32771_ oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection
   [junit4]   2> 1057297 T8767 n:127.0.0.1:32771_ oasc.ZkController.createCollectionZkNode Collection zkNode exists
   [junit4]   2> 1057297 T8767 n:127.0.0.1:32771_ oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
   [junit4]   2> 1057297 T8767 n:127.0.0.1:32771_ oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 1057297 T8767 n:127.0.0.1:32771_ oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1/'
   [junit4]   2> 1057304 T8767 n:127.0.0.1:32771_ oasc.Config.<init> loaded config solrconfig.xml with version 0 
   [junit4]   2> 1057308 T8767 n:127.0.0.1:32771_ oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 1057315 T8767 n:127.0.0.1:32771_ oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 1057330 T8767 n:127.0.0.1:32771_ oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1057331 T8767 n:127.0.0.1:32771_ oass.IndexSchema.readSchema Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 1057336 T8767 n:127.0.0.1:32771_ oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 1057464 T8767 n:127.0.0.1:32771_ oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1057468 T8767 n:127.0.0.1:32771_ oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1057469 T8767 n:127.0.0.1:32771_ oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1057473 T8767 n:127.0.0.1:32771_ oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1057475 T8767 n:127.0.0.1:32771_ oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1057476 T8767 n:127.0.0.1:32771_ oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1057477 T8767 n:127.0.0.1:32771_ oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1057477 T8767 n:127.0.0.1:32771_ oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1057477 T8767 n:127.0.0.1:32771_ oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1057477 T8767 n:127.0.0.1:32771_ oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1057477 T8767 n:127.0.0.1:32771_ oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1057478 T8767 n:127.0.0.1:32771_ oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection
   [junit4]   2> 1057478 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1057478 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1/], dataDir=[null]
   [junit4]   2> 1057478 T8767 n:127.0.0.1:32771_ x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@2518b78d
   [junit4]   2> 1057478 T8767 n:127.0.0.1:32771_ x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1/data
   [junit4]   2> 1057478 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1/data/index/
   [junit4]   2> 1057479 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1057479 T8767 n:127.0.0.1:32771_ x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/control-001/cores/collection1/data/index
   [junit4]   2> 1057479 T8767 n:127.0.0.1:32771_ x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.316818945056222]
   [junit4]   2> 1057479 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@28b05744 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5131463a),segFN=segments_1,generation=1}
   [junit4]   2> 1057480 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1057482 T8767 n:127.0.0.1:32771_ x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "nodistrib"
   [junit4]   2> 1057482 T8767 n:127.0.0.1:32771_ x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1057482 T8767 n:127.0.0.1:32771_ x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1057482 T8767 n:127.0.0.1:32771_ x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1057482 T8767 n:127.0.0.1:32771_ x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1057483 T8767 n:127.0.0.1:32771_ x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1057483 T8767 n:127.0.0.1:32771_ x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1057483 T8767 n:127.0.0.1:32771_ x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1057483 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1057485 T8767 n:127.0.0.1:32771_ x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1057486 T8767 n:127.0.0.1:32771_ x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1057486 T8767 n:127.0.0.1:32771_ x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1057487 T8767 n:127.0.0.1:32771_ x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1057503 T8767 n:127.0.0.1:32771_ x:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /config,/admin/file,/update,standard,/update/json/docs,/admin/segments,/admin/plugins,/update/json,/update/csv,/admin/mbeans,/replication,/admin/properties,/admin/threads,/admin/logging,/schema,/admin/ping,/admin/luke,/get,/admin/system
   [junit4]   2> 1057504 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1057504 T8767 n:127.0.0.1:32771_ x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1057504 T8767 n:127.0.0.1:32771_ x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 1057504 T8767 n:127.0.0.1:32771_ x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1057504 T8767 n:127.0.0.1:32771_ x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1057505 T8767 n:127.0.0.1:32771_ x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 1057505 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@28b05744 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5131463a),segFN=segments_1,generation=1}
   [junit4]   2> 1057506 T8767 n:127.0.0.1:32771_ x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1057506 T8767 n:127.0.0.1:32771_ x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@2e133dd8[collection1] main
   [junit4]   2> 1057506 T8767 n:127.0.0.1:32771_ x:collection1 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection
   [junit4]   2> 1057506 T8767 n:127.0.0.1:32771_ x:collection1 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
   [junit4]   2> 1057506 T8767 n:127.0.0.1:32771_ x:collection1 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 1057507 T8767 n:127.0.0.1:32771_ x:collection1 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1057507 T8767 n:127.0.0.1:32771_ x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {}
   [junit4]   2> 1057507 T8767 n:127.0.0.1:32771_ x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1057507 T8767 n:127.0.0.1:32771_ x:collection1 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 1057507 T8767 n:127.0.0.1:32771_ x:collection1 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1057507 T8767 n:127.0.0.1:32771_ x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 1057508 T8767 n:127.0.0.1:32771_ x:collection1 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 1057508 T8767 n:127.0.0.1:32771_ x:collection1 oasc.ZkController.getConfDirListeners watch zkdir /configs/conf1
   [junit4]   2> 1057508 T8768 n:127.0.0.1:32771_ x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2e133dd8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1057508 T8767 n:127.0.0.1:32771_ x:collection1 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1057508 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ZkController.register Register replica - core:collection1 address:http://127.0.0.1:32771 collection:control_collection shard:shard1
   [junit4]   2> 1057509 T8735 n:127.0.0.1:32771_ oass.SolrDispatchFilter.init user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2
   [junit4]   2> 1057509 T8735 n:127.0.0.1:32771_ oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1057509 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 1057510 T8735 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 1057511 T8735 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1057511 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1
   [junit4]   2> 1057512 T8775 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6d858049 name:ZooKeeperConnection Watcher:127.0.0.1:51754/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1057512 T8735 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1057512 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
   [junit4]   2> 1057512 T8735 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 1057512 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
   [junit4]   2> 1057512 T8763 n:127.0.0.1:32771_ oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> ASYNC  NEW_CORE C1122 name=collection1 org.apache.solr.core.SolrCore@c6b216f url=http://127.0.0.1:32771/collection1 node=127.0.0.1:32771_ C1122_STATE=coll:control_collection core:collection1 props:{node_name=127.0.0.1:32771_, core=collection1, base_url=http://127.0.0.1:32771, state=down}
   [junit4]   2> 1057512 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 C1122 oasc.SyncStrategy.sync Sync replicas to http://127.0.0.1:32771/collection1/
   [junit4]   2> 1057512 T8735 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 1057513 T8764 n:127.0.0.1:32771_ oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2> 	  "operation":"leader",
   [junit4]   2> 	  "shard":"shard1",
   [junit4]   2> 	  "collection":"control_collection"} current state version: 1
   [junit4]   2> 1057513 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 C1122 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me
   [junit4]   2> 1057513 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 C1122 oasc.SyncStrategy.syncToMe http://127.0.0.1:32771/collection1/ has no replicas
   [junit4]   2> 1057513 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:32771/collection1/ shard1
   [junit4]   2> 1057513 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 1057514 T8735 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
   [junit4]   2> 1057515 T8763 n:127.0.0.1:32771_ oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 1057515 T8764 n:127.0.0.1:32771_ oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2> 	  "operation":"leader",
   [junit4]   2> 	  "shard":"shard1",
   [junit4]   2> 	  "collection":"control_collection",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:32771",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "state":"active"} current state version: 1
   [junit4]   2> 1057557 T8735 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/cores/collection1
   [junit4]   2> 1057557 T8735 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1 in directory /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001
   [junit4]   2> 1057558 T8735 oejs.Server.doStart jetty-9.2.10.v20150310
   [junit4]   2> 1057559 T8735 oejsh.ContextHandler.doStart Started o.e.j.s.ServletContextHandler@38864eae{/,null,AVAILABLE}
   [junit4]   2> 1057559 T8735 oejs.AbstractConnector.doStart Started ServerConnector@5126e236{HTTP/1.1}{127.0.0.1:57377}
   [junit4]   2> 1057560 T8735 oejs.Server.doStart Started @1058555ms
   [junit4]   2> 1057560 T8735 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/, hostPort=33237, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/tempDir-001/jetty1, solrconfig=solrconfig.xml, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/cores}
   [junit4]   2> 1057560 T8735 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@7b3cb2c6
   [junit4]   2> 1057560 T8735 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/'
   [junit4]   2> 1057568 T8735 oasc.SolrXmlConfig.fromFile Loading container configuration from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/solr.xml
   [junit4]   2> 1057575 T8735 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/cores
   [junit4]   2> 1057576 T8735 oasc.CoreContainer.<init> New CoreContainer 857272985
   [junit4]   2> 1057576 T8735 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/]
   [junit4]   2> 1057576 T8735 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/lib
   [junit4]   2> 1057576 T8735 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/lib).
   [junit4]   2> 1057580 T8735 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1057581 T8735 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1057582 T8735 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1057582 T8735 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1057582 T8735 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 1057582 T8735 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:51754/solr
   [junit4]   2> 1057582 T8735 oasc.ZkController.checkChrootPath zkHost includes chroot
   [junit4]   2> 1057582 T8735 oascc.SolrZkClient.createZkCredentialsToAddAutomatically Using default ZkCredentialsProvider
   [junit4]   2> 1057583 T8735 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1057584 T8789 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1bc0fe73 name:ZooKeeperConnection Watcher:127.0.0.1:51754 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1057584 T8735 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1057584 T8735 oascc.SolrZkClient.createZkACLProvider Using default ZkACLProvider
   [junit4]   2> 1057585 T8735 n:127.0.0.1:33237_ oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
   [junit4]   2> 1057586 T8792 n:127.0.0.1:33237_ oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@64463dd9 name:ZooKeeperConnection Watcher:127.0.0.1:51754/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 1057586 T8735 n:127.0.0.1:33237_ oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
   [junit4]   2> 1057588 T8735 n:127.0.0.1:33237_ oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
   [junit4]   2> 1057617 T8775 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 1057617 T8763 n:127.0.0.1:32771_ oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 1057617 T8792 n:127.0.0.1:33237_ oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 1057666 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ZkController.register We are http://127.0.0.1:32771/collection1/ and leader is http://127.0.0.1:32771/collection1/
   [junit4]   2> 1057666 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:32771
   [junit4]   2> 1057666 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ZkController.checkRecovery I am the leader, no recovery necessary
   [junit4]   2> 1057666 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ZkController.publish publishing core=collection1 state=active collection=control_collection
   [junit4]   2> 1057666 T8771 n:127.0.0.1:32771_ c:control_collection s:shard1 x:collection1 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1057667 T8763 n:127.0.0.1:32771_ oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 1057668 T8764 n:127.0.0.1:32771_ oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2> 	  "shard":"shard1",
   [junit4]   2> 	  "node_name":"127.0.0.1:32771_",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "core_node_name":"core_node1",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:32771",
   [junit4]   2> 	  "state":"active",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "collection":"control_collection",
   [junit4]   2> 	  "roles":null} current state version: 2
   [junit4]   2> 1057668 T8764 n:127.0.0.1:32771_ oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2> 	  "shard":"shard1",
   [junit4]   2> 	  "node_name":"127.0.0.1:32771_",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "core_node_name":"core_node1",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:32771",
   [junit4]   2> 	  "state":"active",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "collection":"control_collection",
   [junit4]   2> 	  "roles":null}
   [junit4]   2> 1057770 T8763 n:127.0.0.1:32771_ oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 1057770 T8775 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 1057770 T8792 n:127.0.0.1:33237_ oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
   [junit4]   2> 1058589 T8735 n:127.0.0.1:33237_ oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33237_
   [junit4]   2> 1058590 T8735 n:127.0.0.1:33237_ oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:33237_
   [junit4]   2> 1058591 T8735 n:127.0.0.1:33237_ oasc.Overseer.close Overseer (id=null) closing
   [junit4]   2> 1058592 T8735 n:127.0.0.1:33237_ oasc.CoreContainer.intializeAuthorizationPlugin Security conf doesn't exist. Skipping setup for authorization module.
   [junit4]   2> 1058592 T8735 n:127.0.0.1:33237_ oasc.CorePropertiesLocator.discover Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/cores
   [junit4]   2> 1058593 T8735 n:127.0.0.1:33237_ oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/cores/collection1/, schema=schema.xml, coreNodeName=, collection=collection1, name=collection1, dataDir=data/, shard=, loadOnStartup=true, config=solrconfig.xml, instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/cores/collection1, transient=false}
   [junit4]   2> 1058593 T8735 n:127.0.0.1:33237_ oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.HttpPartitionTest 5B3FCB46275D3B2C-001/shard-1-001/cores/collection1/
   [junit4]   2> 1058593 T8735 n:127.0.0.1:33237_ oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 1058594 T8793 n:127.0.0.1:33237_ c:collection1 x:collection1 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1
   [junit4]   2> 1058594 T8793 n:127.0.0.1:33237_ c:collection1 x:collection1 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
   [junit4]   2> 1058594 T8793 n:127.0.0.1:33237_ oasc.ZkController.waitForCoreNodeName look for our core node name
   [junit4]   2> 1058594 T8763 n:127.0.0.1:32771_ oasc.DistributedQueue$LatchWatcher.process NodeChildrenChanged fired on path /overseer/queue state SyncConnected
   [junit4]   2> 1058595 T8764 n:127.0.0.1:32771_ oasc.Overseer$ClusterStateUpdater.run processMessage: queueSize: 1, message = {
   [junit4]   2> 	  "shard":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:33237_",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:33237",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "collection":"collection1",
   [junit4]   2> 	  "roles":null} current state version: 3
   [junit4]   2> 1058595 T8764 n:127.0.0.1:32771_ oasco.ReplicaMutator.updateState Update state numShards=2 message={
   [junit4]   2> 	  "shard":null,
   [junit4]   2> 	  "node_name":"127.0.0.1:33237_",
   [junit4]   2> 	  "operation":"state",
   [junit4]   2> 	  "core":"collection1",
   [junit4]   2> 	  "base_url":"http://127.0.0.1:33237",
   [junit4]   2> 	  "state":"down",
   [junit4]   2> 	  "numShards":"2",
   [junit4]   2> 	  "collection":"collection1",
   [junit4]   2> 	  "roles":null}
   [junit4]   2> 1058595 T8764 n:127.0.0.1:32771_ oasco.ClusterStateMutator.createCollection building a new cName: collection1
   [junit4]   2> 1058596 T8764 n:127.0.0.1:32771_ oasco.ReplicaMutator.updateState Assigning new node to shard shard=shard1
   [junit4]   2> 1058699 T8775 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1058699 T8763 n:127.0.0.1:32771_ oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2)
   [junit4]   2> 1058699 T8792 n:127.0.0.1:

[...truncated too long message...]

cessAdd(LogUpdateProcessorFactory.java:104)
   [junit4]   2> 	at org.apache.solr.handler.loader.JavabinLoader$1.update(JavabinLoader.java:96)
   [junit4]   2> 	at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readOuterMostDocIterator(JavaBinUpdateRequestCodec.java:166)
   [junit4]   2> 	at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readIterator(JavaBinUpdateRequestCodec.java:136)
   [junit4]   2> 	at org.apache.solr.common.util.JavaBinCodec.readVal(JavaBinCodec.java:241)
   [junit4]   2> 	at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec$1.readNamedList(JavaBinUpdateRequestCodec.java:121)
   [junit4]   2> 	at org.apache.solr.common.util.JavaBinCodec.readVal(JavaBinCodec.java:206)
   [junit4]   2> 	at org.apache.solr.common.util.JavaBinCodec.unmarshal(JavaBinCodec.java:126)
   [junit4]   2> 	at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec.unmarshal(JavaBinUpdateRequestCodec.java:173)
   [junit4]   2> 	at org.apache.solr.handler.loader.JavabinLoader.parseAndLoadDocs(JavabinLoader.java:106)
   [junit4]   2> 	at org.apache.solr.handler.loader.JavabinLoader.load(JavabinLoader.java:58)
   [junit4]   2> 	at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98)
   [junit4]   2> 	at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74)
   [junit4]   2> 	at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143)
   [junit4]   2> 	at org.apache.solr.core.SolrCore.execute(SolrCore.java:2047)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:636)
   [junit4]   2> 	at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:436)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:198)
   [junit4]   2> 	at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:178)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
   [junit4]   2> 	at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:105)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
   [junit4]   2> 	at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
   [junit4]   2> 	at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:300)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
   [junit4]   2> 	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
   [junit4]   2> 	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2> 	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
   [junit4]   2> 	at org.eclipse.jetty.server.Server.handle(Server.java:497)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
   [junit4]   2> 	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
   [junit4]   2> 	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
   [junit4]   2> 	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 
   [junit4]   2> 141052 T8734 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): {_version_=Lucene50(blocksize=128), multiDefault=PostingsFormat(name=MockRandom), range_facet_l_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), timestamp=Lucene50(blocksize=128), range_facet_i_dv=Lucene50(blocksize=128), a_t=Lucene50(blocksize=128), intDefault=Lucene50(blocksize=128), text=FSTOrd50, range_facet_l=Lucene50(blocksize=128), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))}, docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), timestamp=DocValuesFormat(name=Asserting), range_facet_i_dv=DocValuesFormat(name=Asserting)}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ar_KW, timezone=Europe/Tallinn
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=12,threads=1,free=180038680,total=447741952
   [junit4]   2> NOTE: All tests run in this JVM: [TestDefaultStatsCache, PathHierarchyTokenizerFactoryTest, CachingDirectoryFactoryTest, OverriddenZkACLAndCredentialsProvidersTest, AliasIntegrationTest, TestDefaultSimilarityFactory, AutoCommitTest, RecoveryZkTest, TestSolrJ, TestSolrQueryParser, DirectSolrSpellCheckerTest, HdfsRecoverLeaseTest, TestQuerySenderNoQuery, ExitableDirectoryReaderTest, TestConfigSets, TestSchemaVersionResource, TestPivotHelperCode, DistributedQueryComponentOptimizationTest, CircularListTest, TestPerFieldSimilarity, PolyFieldTest, DistributedExpandComponentTest, HdfsCollectionsAPIDistributedZkTest, OverseerStatusTest, TestRandomMergePolicy, RollingRestartTest, TestDocSet, XsltUpdateRequestHandlerTest, PluginInfoTest, SolrIndexSplitterTest, RegexBoostProcessorTest, SpatialRPTFieldTypeTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestRequestStatusCollectionAPI, TestEmbeddedSolrServerConstructors, TestQueryTypes, BinaryUpdateRequestHandlerTest, TestCollationField, OpenExchangeRatesOrgProviderTest, RulesTest, TestReload, TestIntervalFaceting, TestStressRecovery, DeleteLastCustomShardedReplicaTest, TestDefaultSearchFieldResource, DistributedQueryComponentCustomSortTest, SOLR749Test, TestExceedMaxTermLength, DirectUpdateHandlerTest, DistributedFacetPivotSmallTest, DocValuesTest, TestSort, BadIndexSchemaTest, ConnectionManagerTest, DistributedSuggestComponentTest, TestLuceneMatchVersion, DistributedQueueTest, SearchHandlerTest, TestXIncludeConfig, SolrInfoMBeanTest, TestManagedSchemaFieldTypeResource, PrimUtilsTest, TestSurroundQueryParser, DistributedQueryElevationComponentTest, TestBinaryResponseWriter, HdfsWriteToMultipleCollectionsTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestUtils, BasicDistributedZk2Test, ResponseHeaderTest, TestSerializedLuceneMatchVersion, TestStressReorder, TestExtendedDismaxParser, TestUniqueKeyFieldResource, HdfsDirectoryFactoryTest, TestSearcherReuse, SampleTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, OverseerTest, ShardRoutingTest, TestReplicationHandler, HardAutoCommitTest, DistributedTermsComponentTest, TestSolr4Spatial, PeerSyncTest, TestFiltering, CurrencyFieldXmlFileTest, SuggesterFSTTest, SuggesterTest, TestCSVLoader, SolrCoreCheckLockOnStartupTest, TestAtomicUpdateErrorCases, DirectUpdateHandlerOptimizeTest, TestRemoteStreaming, CacheHeaderTest, TestQueryUtils, TestWriterPerf, FileBasedSpellCheckerTest, TestValueSourceCache, FieldAnalysisRequestHandlerTest, FastVectorHighlighterTest, LoggingHandlerTest, ReturnFieldsTest, TestCSVResponseWriter, TestPartialUpdateDeduplication, TestLFUCache, ResponseLogComponentTest, SolrIndexConfigTest, DirectSolrConnectionTest, TestCharFilters, TestSweetSpotSimilarityFactory, TestBM25SimilarityFactory, TestFastOutputStream, ChaosMonkeyNothingIsSafeTest, DeleteReplicaTest, ExternalCollectionsTest, HttpPartitionTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=HttpPartitionTest -Dtests.seed=5B3FCB46275D3B2C -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_KW -Dtests.timezone=Europe/Tallinn -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J2 | HttpPartitionTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: Some resources were not closed, shutdown, or released.
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([5B3FCB46275D3B2C]:0)
   [junit4]    > 	at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:234)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [391/490] on J2 in 141.84s, 1 test, 1 failure <<< FAILURES!

[...truncated 329 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:536: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:484: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:229: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:511: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1433: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:991: There were test failures: 490 suites, 1960 tests, 2 suite-level errors, 57 ignored (25 assumptions)

Total time: 48 minutes 52 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



[JENKINS] Lucene-Solr-5.x-Linux (64bit/jdk1.9.0-ea-b60) - Build # 12544 - Still Failing!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/12544/
Java: 64bit/jdk1.9.0-ea-b60 -XX:-UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.search.QueryEqualityTest

Error Message:
testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll

Stack Trace:
java.lang.AssertionError: testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
	at __randomizedtesting.SeedInfo.seed([F2E3AB3EB9BD8A67]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.assertTrue(Assert.java:43)
	at org.apache.solr.search.QueryEqualityTest.afterClassParserCoverageTest(QueryEqualityTest.java:63)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:502)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
	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:365)
	at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10444 lines...]
   [junit4] Suite: org.apache.solr.search.QueryEqualityTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001
   [junit4]   2> 930671 T5801 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 930671 T5801 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 930672 T5801 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 930672 T5801 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 930672 T5801 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 930691 T5801 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 930702 T5801 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 930725 T5801 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 930725 T5801 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 930728 T5801 oass.IndexSchema.readSchema [null] Schema name=test
   [junit4]   2> 930798 T5801 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 930799 T5801 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 930800 T5801 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 930801 T5801 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 930805 T5801 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 930805 T5801 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
   [junit4]   2> 930805 T5801 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/'
   [junit4]   2> 930823 T5801 oasc.CoreContainer.<init> New CoreContainer 1009621809
   [junit4]   2> 930824 T5801 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/]
   [junit4]   2> 930824 T5801 oasc.CoreContainer.load loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
   [junit4]   2> 930824 T5801 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib).
   [junit4]   2> 930827 T5801 oashc.HttpShardHandlerFactory.init created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 930828 T5801 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 930829 T5801 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 930829 T5801 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 930829 T5801 oasc.CoreContainer.load Node Name: testNode
   [junit4]   2> 930830 T5801 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema15.xml, loadOnStartup=true, instanceDir=collection1, collection=collection1, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001, shard=shard1}
   [junit4]   2> 930830 T5802 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 930830 T5802 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
   [junit4]   2> 930830 T5802 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
   [junit4]   2> 930842 T5802 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 930848 T5802 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 930862 T5802 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 930863 T5802 oass.IndexSchema.readSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 930865 T5802 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 930922 T5802 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 930923 T5802 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 930923 T5802 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 930925 T5802 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 930928 T5802 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 930928 T5802 x:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 930928 T5802 x:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/], dataDir=[null]
   [junit4]   2> 930928 T5802 x:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@22195ed1
   [junit4]   2> 930929 T5802 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001
   [junit4]   2> 930937 T5802 x:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001/index/
   [junit4]   2> 930937 T5802 x:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001/index' doesn't exist. Creating new index...
   [junit4]   2> 930938 T5802 x:collection1 oasc.CachingDirectoryFactory.get return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001/index
   [junit4]   2> 930938 T5802 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=50, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=57.9716796875, floorSegmentMB=1.470703125, forceMergeDeletesPctAllowed=12.018580029776421, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 930938 T5802 x:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@c224969 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e8c473),segFN=segments_1,generation=1}
   [junit4]   2> 930938 T5802 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 930941 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 930942 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 930942 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 930942 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 930942 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 930942 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 930942 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 930942 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 930942 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 930943 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 930943 T5802 x:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 930943 T5802 x:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 930944 T5802 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 930944 T5802 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 930945 T5802 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 930945 T5802 x:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 930947 T5802 x:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 930948 T5802 x:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
   [junit4]   2> 930948 T5802 x:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 930949 T5802 x:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 930950 T5802 x:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 930950 T5802 x:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 930951 T5802 x:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 930951 T5802 x:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 930951 T5802 x:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 930952 T5802 x:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@c224969 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e8c473),segFN=segments_1,generation=1}
   [junit4]   2> 930952 T5802 x:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 930952 T5802 x:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@549a56d[collection1] main
   [junit4]   2> 930952 T5802 x:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 930952 T5802 x:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 930952 T5802 x:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 930953 T5802 x:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 930967 T5802 x:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 931037 T5802 x:collection1 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 931038 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
   [junit4]   2> 931038 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct
   [junit4]   2> 931038 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
   [junit4]   2> 931039 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields
   [junit4]   2> 931038 T5802 x:collection1 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 931039 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 931039 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external
   [junit4]   2> 931040 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq
   [junit4]   2> 931040 T5801 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 931040 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn
   [junit4]   2> 931042 T5803 x:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict
   [junit4]   2> 931043 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryFunc
   [junit4]   2> 931050 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryFunc
   [junit4]   2> 931052 T5803 x:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@549a56d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 931058 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncTerms
   [junit4]   2> 931064 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTerms
   [junit4]   2> 931086 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryDismax
   [junit4]   2> 931097 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryDismax
   [junit4]   2> 931115 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncSum
   [junit4]   2> 931125 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSum
   [junit4]   2> 931128 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryNested
   [junit4]   2> 931129 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryNested
   [junit4]   2> 931132 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncProduct
   [junit4]   2> 931133 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncProduct
   [junit4]   2> 931136 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncMaxdoc
   [junit4]   2> 931137 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMaxdoc
   [junit4]   2> 931140 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncGeohash
   [junit4]   2> 931140 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGeohash
   [junit4]   2> 931143 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncRecip
   [junit4]   2> 931144 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncRecip
   [junit4]   2> 931147 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncCurrency
   [junit4]   2> 931147 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncCurrency
   [junit4]   2> 931151 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncBools
   [junit4]   2> 931151 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncBools
   [junit4]   2> 931154 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryFrange
   [junit4]   2> 931155 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryFrange
   [junit4]   2> 931158 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncMap
   [junit4]   2> 931159 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMap
   [junit4]   2> 931162 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncDiv
   [junit4]   2> 931162 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDiv
   [junit4]   2> 931165 T5801 oas.SolrTestCaseJ4.setUp ###Starting testExportQuery
   [junit4]   2> 931178 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testExportQuery
   [junit4]   2> 931182 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncGeodist
   [junit4]   2> 931183 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGeodist
   [junit4]   2> 931186 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncNorm
   [junit4]   2> 931186 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNorm
   [junit4]   2> 931188 T5801 oas.SolrTestCaseJ4.setUp ###Starting testDateMathParsingEquality
   [junit4]   2> 931189 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testDateMathParsingEquality
   [junit4]   2> 931195 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryLucene
   [junit4]   2> 931196 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryLucene
   [junit4]   2> 931199 T5801 oas.SolrTestCaseJ4.setUp ###Starting testField
   [junit4]   2> 931200 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testField
   [junit4]   2> 931203 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncVector
   [junit4]   2> 931204 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncVector
   [junit4]   2> 931207 T5801 oas.SolrTestCaseJ4.setUp ###Starting testReRankQuery
   [junit4]   2> 931212 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testReRankQuery
   [junit4]   2> 931215 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryPrefix
   [junit4]   2> 931216 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryPrefix
   [junit4]   2> 931219 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncSingleValueMathFuncs
   [junit4]   2> 931223 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSingleValueMathFuncs
   [junit4]   2> 931226 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryBoost
   [junit4]   2> 931230 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryBoost
   [junit4]   2> 931233 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncDoubleValueBools
   [junit4]   2> 931235 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDoubleValueBools
   [junit4]   2> 931238 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncTestfunc
   [junit4]   2> 931239 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTestfunc
   [junit4]   2> 931242 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncDef
   [junit4]   2> 931243 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDef
   [junit4]   2> 931246 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryJoin
   [junit4]   2> 931250 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryJoin
   [junit4]   2> 931253 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncMin
   [junit4]   2> 931254 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMin
   [junit4]   2> 931256 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryComplexPhrase
   [junit4]   2> 931282 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryComplexPhrase
   [junit4]   2> 931284 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryGeofilt
   [junit4]   2> 931287 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryGeofilt
   [junit4]   2> 931291 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncMs
   [junit4]   2> 931292 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMs
   [junit4]   2> 931295 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncQuery
   [junit4]   2> 931296 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncQuery
   [junit4]   2> 931299 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryMaxScore
   [junit4]   2> 931302 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryMaxScore
   [junit4]   2> 931308 T5801 oas.SolrTestCaseJ4.setUp ###Starting testParserCoverage
   [junit4]   2> 931308 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testParserCoverage
   [junit4]   2> 931311 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryMLT
   [junit4]   2> ASYNC  NEW_CORE C1467 name=collection1 org.apache.solr.core.SolrCore@63b965af
   [junit4]   2> 931313 T5801 C1467 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1 (1501445668247437312)]} 0 2
   [junit4]   2> 931315 T5801 C1467 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 931318 T5801 C1467 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@c224969 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e8c473),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(RAMDirectory@c224969 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@71e8c473),segFN=segments_2,generation=2}
   [junit4]   2> 931319 T5801 C1467 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 931321 T5801 C1467 oass.SolrIndexSearcher.<init> Opening Searcher@25f22cec[collection1] main
   [junit4]   2> 931324 T5801 C1467 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 931325 T5803 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@25f22cec[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C1)))}
   [junit4]   2> ASYNC  NEW_CORE C1468 name=collection1 org.apache.solr.core.SolrCore@63b965af
   [junit4]   2> 931341 T5801 C1468 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 26
   [junit4]   2> 931350 T5801 C1468 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 931351 T5801 C1468 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 931351 T5801 C1468 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 931351 T5801 C1468 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 931352 T5801 C1468 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2
   [junit4]   2> 931352 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryMLT
   [junit4]   2> 931355 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncSqedist
   [junit4]   2> 931356 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSqedist
   [junit4]   2> 931359 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncNumdocs
   [junit4]   2> 931359 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNumdocs
   [junit4]   2> 931362 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncTop
   [junit4]   2> 931362 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncTop
   [junit4]   2> 931365 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncMathConsts
   [junit4]   2> 931366 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMathConsts
   [junit4]   2> 931368 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncLiteral
   [junit4]   2> 931369 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncLiteral
   [junit4]   2> 931372 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncJoindf
   [junit4]   2> 931374 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncJoindf
   [junit4]   2> 931377 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQuerySurround
   [junit4]   2> 931426 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySurround
   [junit4]   2> 931429 T5801 oas.SolrTestCaseJ4.setUp ###Starting testHash
   [junit4]   2> 931433 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testHash
   [junit4]   2> 931435 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncScale
   [junit4]   2> 931439 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncScale
   [junit4]   2> 931443 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryRaw
   [junit4]   2> 931443 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryRaw
   [junit4]   2> 931447 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncRord
   [junit4]   2> 931447 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncRord
   [junit4]   2> 931449 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncGhhsin
   [junit4]   2> 931450 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncGhhsin
   [junit4]   2> 931453 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncSub
   [junit4]   2> 931454 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSub
   [junit4]   2> 931456 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncNot
   [junit4]   2> 931456 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncNot
   [junit4]   2> 931458 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncOrd
   [junit4]   2> 931459 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncOrd
   [junit4]   2> 931460 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncField
   [junit4]   2> 931461 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncField
   [junit4]   2> 931463 T5801 oas.SolrTestCaseJ4.setUp ###Starting testTerms
   [junit4]   2> 931469 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testTerms
   [junit4]   2> 931471 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncDist
   [junit4]   2> 931472 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDist
   [junit4]   2> 931474 T5801 oas.SolrTestCaseJ4.setUp ###Starting testAggs
   [junit4]   2> 931488 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testAggs
   [junit4]   2> 931491 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryBbox
   [junit4]   2> 931492 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryBbox
   [junit4]   2> 931495 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncMax
   [junit4]   2> 931496 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMax
   [junit4]   2> 931498 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncMod
   [junit4]   2> 931499 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncMod
   [junit4]   2> 931500 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryCollapse
   [junit4]   2> 931502 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryCollapse
   [junit4]   2> 931505 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryTerm
   [junit4]   2> 931505 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryTerm
   [junit4]   2> 931507 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncSttf
   [junit4]   2> 931507 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncSttf
   [junit4]   2> 931509 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncLinear
   [junit4]   2> 931510 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncLinear
   [junit4]   2> 931513 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncBoost
   [junit4]   2> 931514 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncBoost
   [junit4]   2> 931517 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncIf
   [junit4]   2> 931518 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncIf
   [junit4]   2> 931520 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncDoubleValueMathFuncs
   [junit4]   2> 931521 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncDoubleValueMathFuncs
   [junit4]   2> 931527 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQueryLucenePlusSort
   [junit4]   2> 931529 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQueryLucenePlusSort
   [junit4]   2> 931531 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncCscore
   [junit4]   2> 931533 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncCscore
   [junit4]   2> 931535 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncStrdist
   [junit4]   2> 931536 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncStrdist
   [junit4]   2> 931540 T5801 oas.SolrTestCaseJ4.setUp ###Starting testBlockJoin
   [junit4]   2> 931545 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testBlockJoin
   [junit4]   2> 931548 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncExists
   [junit4]   2> 931550 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncExists
   [junit4]   2> 931552 T5801 oas.SolrTestCaseJ4.setUp ###Starting testTestFuncs
   [junit4]   2> 931555 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testTestFuncs
   [junit4]   2> 931558 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQuerySimple
   [junit4]   2> 931564 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySimple
   [junit4]   2> 931567 T5801 oas.SolrTestCaseJ4.setUp ###Starting testFuncHsin
   [junit4]   2> 931568 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testFuncHsin
   [junit4]   2> 931571 T5801 oas.SolrTestCaseJ4.setUp ###Starting testQuerySwitch
   [junit4]   2> 931572 T5801 oas.SolrTestCaseJ4.tearDown ###Ending testQuerySwitch
   [junit4]   2> 931575 T5801 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> 931575 T5801 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1009621809
   [junit4]   2> 931575 T5801 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@63b965af
   [junit4]   2> 931576 T5801 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=119,transaction_logs_total_number=1}
   [junit4]   2> 931576 T5801 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 931576 T5801 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 931576 T5801 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 931577 T5801 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 931586 T5801 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 931586 T5801 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001;done=false>>]
   [junit4]   2> 931586 T5801 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001
   [junit4]   2> 931586 T5801 oasc.CachingDirectoryFactory.closeCacheValue looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001/index;done=false>>]
   [junit4]   2> 931586 T5801 oasc.CachingDirectoryFactory.close Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.search.QueryEqualityTest F2E3AB3EB9BD8A67-001/init-core-data-001/index
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene50): {_version_=PostingsFormat(name=MockRandom), lowerfilt=FSTOrd50, id=PostingsFormat(name=Asserting)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=cs, timezone=Atlantic/Reykjavik
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.9.0-ea (64-bit)/cpus=12,threads=1,free=163956992,total=509280256
   [junit4]   2> NOTE: All tests run in this JVM: [ChangedSchemaMergeTest, DisMaxRequestHandlerTest, SolrPluginUtilsTest, TestFuzzyAnalyzedSuggestions, TestLRUCache, DirectSolrConnectionTest, TestSolrDeletionPolicy2, ReturnFieldsTest, ConcurrentDeleteAndCreateCollectionTest, TestSolr4Spatial2, IndexSchemaRuntimeFieldTest, CopyFieldTest, TestAnalyzedSuggestions, TestSolrConfigHandler, HdfsRecoveryZkTest, ZkControllerTest, VMParamsZkACLAndCredentialsProvidersTest, DistanceFunctionTest, TestCloudPivotFacet, TestHashPartitioner, RequiredFieldsTest, TestCollectionAPI, TestReplicaProperties, UpdateParamsTest, TestMacros, TestReplicationHandlerBackup, TestConfigOverlay, DocValuesMultiTest, OverseerStatusTest, CollectionsAPIDistributedZkTest, TestLMJelinekMercerSimilarityFactory, TestBlobHandler, SuggesterTSTTest, JsonLoaderTest, TestRemoveLastDynamicCopyField, TestInitQParser, NoCacheHeaderTest, HttpPartitionTest, ShardSplitTest, TestStressUserVersions, CurrencyFieldOpenExchangeTest, CachingDirectoryFactoryTest, TestMiniSolrCloudClusterSSL, TestCoreDiscovery, TestSolrConfigHandlerCloud, ZkSolrClientTest, DistributedFacetPivotWhiteBoxTest, TestManagedResourceStorage, TestManagedSchemaDynamicFieldResource, OutOfBoxZkACLAndCredentialsProvidersTest, ClusterStateUpdateTest, TestNRTOpen, EchoParamsTest, SliceStateTest, TestFastLRUCache, TestSolrQueryParserDefaultOperatorResource, SpellCheckComponentTest, HighlighterMaxOffsetTest, ShardRoutingTest, TestLMDirichletSimilarityFactory, StatelessScriptUpdateProcessorFactoryTest, CacheHeaderTest, TestMissingGroups, JSONWriterTest, DocValuesMissingTest, TestDistribDocBasedVersion, ZkStateWriterTest, DistributedTermsComponentTest, SolrTestCaseJ4Test, HdfsUnloadDistributedZkTest, TestCloudInspectUtil, TestCoreContainer, TestRandomMergePolicy, TestSchemaNameResource, DistributedIntervalFacetingTest, TestSchemaVersionResource, TestSolrCoreProperties, FacetPivotSmallTest, RAMDirectoryFactoryTest, BadComponentTest, TestFunctionQuery, BasicFunctionalityTest, ShowFileRequestHandlerTest, AnalysisAfterCoreReloadTest, SuggesterFSTTest, TestFoldingMultitermQuery, SuggesterTest, TestTrie, SpatialFilterTest, WordBreakSolrSpellCheckerTest, TestUpdate, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, QueryEqualityTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=QueryEqualityTest -Dtests.seed=F2E3AB3EB9BD8A67 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=cs -Dtests.timezone=Atlantic/Reykjavik -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J1 | QueryEqualityTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: testParserCoverage was run w/o any other method explicitly testing val parser: agg_hll
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([F2E3AB3EB9BD8A67]:0)
   [junit4]    > 	at org.apache.solr.search.QueryEqualityTest.afterClassParserCoverageTest(QueryEqualityTest.java:63)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [294/490] on J1 in 0.95s, 75 tests, 1 failure <<< FAILURES!

[...truncated 606 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:536: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:484: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:61: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/extra-targets.xml:39: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:229: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:511: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1433: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:991: There were test failures: 490 suites, 1960 tests, 1 suite-level error, 57 ignored (25 assumptions)

Total time: 44 minutes 11 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any