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/04/26 06:40:01 UTC

[JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.7.0) - Build # 2180 - Failure!

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2180/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.handler.component.DistributedDebugComponentTest

Error Message:
IOException occured when talking to server at: https://127.0.0.1:56240/solr/collection1

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:56240/solr/collection1
	at __randomizedtesting.SeedInfo.seed([A2B3DE4E97CD5889]:0)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:574)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
	at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:483)
	at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:464)
	at org.apache.solr.handler.component.DistributedDebugComponentTest.createThings(DistributedDebugComponentTest.java:90)
	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$4.evaluate(RandomizedRunner.java:776)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
	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)
Caused by: org.apache.http.NoHttpResponseException: 127.0.0.1:56240 failed to respond
	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143)
	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
	at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
	at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
	at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
	at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
	at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
	at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
	at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:466)
	... 30 more




Build Log:
[...truncated 10189 lines...]
   [junit4] Suite: org.apache.solr.handler.component.DistributedDebugComponentTest
   [junit4]   2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/init-core-data-001
   [junit4]   2> 1014844 T5058 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false)
   [junit4]   2> 1014890 T5058 oas.SolrTestCaseJ4.initCore ####initCore
   [junit4]   2> 1014890 T5058 oas.SolrTestCaseJ4.initCore ####initCore end
   [junit4]   2> 1014891 T5058 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core
   [junit4]   2> 1014894 T5058 oejs.Server.doStart jetty-8.1.10.v20130312
   [junit4]   2> 1014902 T5058 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
   [junit4]   2> 1014906 T5058 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:56240
   [junit4]   2> 1014906 T5058 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostPort=56240, hostContext=/solr, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores, configSetBaseDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001}
   [junit4]   2> 1014910 T5058 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@321ea24
   [junit4]   2> 1014910 T5058 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/'
   [junit4]   2> 1014950 T5058 oasc.SolrXmlConfig.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/solr.xml
   [junit4]   2> 1014998 T5058 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores
   [junit4]   2> 1014999 T5058 oasc.CoreContainer.<init> New CoreContainer 1384712808
   [junit4]   2> 1014999 T5058 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/]
   [junit4]   2> 1014999 T5058 oasc.CoreContainer.load loading shared library: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/lib
   [junit4]   2> 1015000 T5058 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/lib).
   [junit4]   2> 1015010 T5058 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1015016 T5058 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1015019 T5058 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1015019 T5058 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1015019 T5058 oasc.CoreContainer.load Node Name: 127.0.0.1
   [junit4]   2> 1015022 T5058 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores
   [junit4]   2> 1015024 T5058 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {transient=false, instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core, dataDir=data/, configSet=collection1, schema=schema.xml, loadOnStartup=true, name=collection1, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/, config=solrconfig.xml}
   [junit4]   2> 1015025 T5058 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/
   [junit4]   2> 1015025 T5058 oasc.CorePropertiesLocator.discover Found 1 core definitions
   [junit4]   2> 1015026 T5068 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/collection1/'
   [junit4]   2> 1015061 T5068 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 1015097 T5068 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 1015190 T5068 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1015191 T5068 oass.IndexSchema.readSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/collection1/conf/schema.xml
   [junit4]   2> 1015207 T5068 oass.IndexSchema.readSchema [collection1] Schema name=test
   [junit4]   2> 1015577 T5068 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1015587 T5068 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1015589 T5068 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1015598 T5068 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1015604 T5068 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1015607 T5068 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1015608 T5068 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1015608 T5068 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1015609 T5068 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1015609 T5068 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1015610 T5068 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1015610 T5068 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/collection1
   [junit4]   2> 1015610 T5068 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1015610 T5068 c:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/collection1/], dataDir=[null]
   [junit4]   2> 1015610 T5068 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@458222d2
   [junit4]   2> 1015612 T5068 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data
   [junit4]   2> 1015612 T5068 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data/index/
   [junit4]   2> 1015612 T5068 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1015612 T5068 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data/index
   [junit4]   2> 1015612 T5068 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4907278794595129]
   [junit4]   2> 1015613 T5068 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@610925f8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f9bee8d; maxCacheMB=0.412109375 maxMergeSizeMB=0.65625)),segFN=segments_1,generation=1}
   [junit4]   2> 1015613 T5068 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1015619 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1015619 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1015619 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1015620 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1015620 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1015620 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1015620 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1015620 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1015620 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1015621 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1015621 T5068 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1015621 T5068 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1015633 T5068 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1015636 T5068 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1015638 T5068 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1015639 T5068 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1015645 T5068 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1015647 T5068 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: mltrh,/search-facet-def,/search-facet-invariants,spellCheckWithWordbreak_Direct,spellCheckWithWordbreak,/admin/file,/get,/replication,dismax,spellCheckCompRH1,/update/json/docs,/update/csv,/admin/threads,spellCheckCompRH_Direct,mock,/config,/admin/logging,/update/json,/mlt,/admin/mbeans,tvrh,defaults,/admin/segments,/debug/dump,/admin/system,/terms,/update,lazy,/admin/properties,/admin/luke,spellCheckCompRH,/admin/plugins,standard,/admin/ping,/schema
   [junit4]   2> 1015648 T5068 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 1015649 T5068 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1015651 T5068 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1015651 T5068 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 1015653 T5068 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1015653 T5068 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1015653 T5068 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=93.044921875, floorSegmentMB=0.9921875, forceMergeDeletesPctAllowed=8.282808772030538, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1015654 T5068 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@610925f8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f9bee8d; maxCacheMB=0.412109375 maxMergeSizeMB=0.65625)),segFN=segments_1,generation=1}
   [junit4]   2> 1015654 T5068 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1015654 T5068 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@48e09d7c[collection1] main
   [junit4]   2> 1015655 T5068 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 1015655 T5068 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1015655 T5068 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 1015655 T5068 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 1015663 T5068 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1015697 T5068 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 1015698 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
   [junit4]   2> 1015701 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct
   [junit4]   2> 1015701 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1015702 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1015704 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1015704 T5068 c:collection1 oasc.CoreContainer.registerCore registering core: collection1
   [junit4]   2> 1015705 T5058 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0
   [junit4]   2> 1015705 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external
   [junit4]   2> 1015705 T5058 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
   [junit4]   2> 1015706 T5058 oas.SolrJettyTestBase.createJetty Jetty Assigned Port#56240
   [junit4]   2> 1015707 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq
   [junit4]   2> 1015709 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn
   [junit4]   2> 1015710 T5069 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict
   [junit4]   2> 1015712 T5069 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@48e09d7c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1015758 T5067 oasha.CoreAdminHandler.handleCreateAction core create command action=CREATE&wt=javabin&configSet=collection1&version=2&name=collection2
   [junit4]   2> 1015759 T5067 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {schema=schema.xml, transient=false, configSet=collection1, loadOnStartup=true, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/, dataDir=data/, name=collection2, config=solrconfig.xml, instanceDir=collection2}
   [junit4]   2> 1015759 T5067 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/collection1/'
   [junit4]   2> 1015825 T5067 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1
   [junit4]   2> 1015870 T5067 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0
   [junit4]   2> 1015917 T5067 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1015918 T5067 oass.IndexSchema.readSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/collection1/conf/schema.xml
   [junit4]   2> 1015926 T5067 oass.IndexSchema.readSchema [collection2] Schema name=test
   [junit4]   2> 1016295 T5067 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 1016305 T5067 oass.IndexSchema.readSchema default search field in schema is text
   [junit4]   2> 1016309 T5067 oass.IndexSchema.readSchema unique key field: id
   [junit4]   2> 1016323 T5067 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1016327 T5067 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
   [junit4]   2> 1016329 T5067 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1016330 T5067 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1016330 T5067 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1016330 T5067 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
   [junit4]   2> 1016331 T5067 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
   [junit4]   2> 1016331 T5067 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
   [junit4]   2> 1016332 T5067 oasc.CoreContainer.create Creating SolrCore 'collection2' using configuration from configset /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/collection1
   [junit4]   2> 1016332 T5067 c:collection2 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1016332 T5067 c:collection2 oasc.SolrCore.<init> [[collection2] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-001/collection1/], dataDir=[null]
   [junit4]   2> 1016333 T5067 c:collection2 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@458222d2
   [junit4]   2> 1016334 T5067 c:collection2 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data
   [junit4]   2> 1016334 T5067 c:collection2 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data/index/
   [junit4]   2> 1016334 T5067 c:collection2 oasc.SolrCore.initIndex WARN [collection2] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data/index' doesn't exist. Creating new index...
   [junit4]   2> 1016335 T5067 c:collection2 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data/index
   [junit4]   2> 1016335 T5067 c:collection2 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=13, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4907278794595129]
   [junit4]   2> 1016336 T5067 c:collection2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@3051a29 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@43f87b4b; maxCacheMB=0.412109375 maxMergeSizeMB=0.65625)),segFN=segments_1,generation=1}
   [junit4]   2> 1016336 T5067 c:collection2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1016341 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe"
   [junit4]   2> 1016342 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 1016342 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1016343 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
   [junit4]   2> 1016343 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1016343 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 1016343 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1016344 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
   [junit4]   2> 1016357 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 1016357 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1016358 T5067 c:collection2 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 1016358 T5067 c:collection2 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
   [junit4]   2> 1016378 T5067 c:collection2 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1016381 T5067 c:collection2 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1016383 T5067 c:collection2 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1016387 T5067 c:collection2 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
   [junit4]   2> 1016395 T5067 c:collection2 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy 
   [junit4]   2> 1016402 T5067 c:collection2 oasc.RequestHandlers.initHandlersFromConfig Registered paths: mltrh,/search-facet-def,/search-facet-invariants,spellCheckWithWordbreak_Direct,spellCheckWithWordbreak,/admin/file,/get,/replication,dismax,spellCheckCompRH1,/update/json/docs,/update/csv,/admin/threads,spellCheckCompRH_Direct,mock,/config,/admin/logging,/update/json,/mlt,/admin/mbeans,tvrh,defaults,/admin/segments,/debug/dump,/admin/system,/terms,/update,lazy,/admin/properties,/admin/luke,spellCheckCompRH,/admin/plugins,standard,/admin/ping,/schema
   [junit4]   2> 1016404 T5067 c:collection2 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
   [junit4]   2> 1016405 T5067 c:collection2 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1016407 T5067 c:collection2 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1016407 T5067 c:collection2 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
   [junit4]   2> 1016409 T5067 c:collection2 oasu.CommitTracker.<init> Hard AutoCommit: disabled
   [junit4]   2> 1016410 T5067 c:collection2 oasu.CommitTracker.<init> Soft AutoCommit: disabled
   [junit4]   2> 1016410 T5067 c:collection2 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=93.044921875, floorSegmentMB=0.9921875, forceMergeDeletesPctAllowed=8.282808772030538, segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1016412 T5067 c:collection2 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@3051a29 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@43f87b4b; maxCacheMB=0.412109375 maxMergeSizeMB=0.65625)),segFN=segments_1,generation=1}
   [junit4]   2> 1016412 T5067 c:collection2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
   [junit4]   2> 1016413 T5067 c:collection2 oass.SolrIndexSearcher.<init> Opening Searcher@27dbf606[collection2] main
   [junit4]   2> 1016413 T5067 c:collection2 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
   [junit4]   2> 1016414 T5067 c:collection2 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage
   [junit4]   2> 1016414 T5067 c:collection2 oasr.RestManager.init Initializing 0 registered ManagedResources
   [junit4]   2> 1016415 T5067 c:collection2 oashc.SpellCheckComponent.inform Initializing spell checkers
   [junit4]   2> 1016423 T5067 c:collection2 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1016460 T5067 c:collection2 oash.ReplicationHandler.inform Commits will be reserved for  10000
   [junit4]   2> 1016461 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
   [junit4]   2> 1016461 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct
   [junit4]   2> 1016462 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1016462 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1016463 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1016463 T5067 c:collection2 oasc.CoreContainer.registerCore registering core: collection2
   [junit4]   2> 1016464 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external
   [junit4]   2> 1016465 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq
   [junit4]   2> 1016465 T5067 c:collection2 oass.SolrDispatchFilter.handleAdminRequest [admin] webapp=null path=/admin/cores params={wt=javabin&action=CREATE&version=2&configSet=collection1&name=collection2} status=0 QTime=707 
   [junit4]   2> 1016466 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn
   [junit4]   2> 1016467 T5071 c:collection2 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict
   [junit4]   2> 1016468 T5071 c:collection2 oasc.SolrCore.registerSearcher [collection2] Registered new searcher Searcher@27dbf606[collection2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> ASYNC  NEW_CORE C2539 name=collection1 org.apache.solr.core.SolrCore@4088e2ed
   [junit4]   2> 1016517 T5065 c:collection1 C2539 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 (1499485483429789696)]} 0 6
   [junit4]   2> 1216852 T5065 c:collection1 C2539 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1216857 T5065 c:collection1 C2539 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@610925f8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f9bee8d; maxCacheMB=0.412109375 maxMergeSizeMB=0.65625)),segFN=segments_1,generation=1}
   [junit4]   2> 		commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@610925f8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f9bee8d; maxCacheMB=0.412109375 maxMergeSizeMB=0.65625)),segFN=segments_2,generation=2}
   [junit4]   2> 1216858 T5065 c:collection1 C2539 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
   [junit4]   2> 1216859 T5065 c:collection1 C2539 oass.SolrIndexSearcher.<init> Opening Searcher@7ad7cc7e[collection1] main
   [junit4]   2> 1216860 T5065 c:collection1 C2539 oasu.DirectUpdateHandler2.commit end_commit_flush
   [junit4]   2> 1216862 T5069 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7ad7cc7e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):c1)))}
   [junit4]   2> 1216862 T5065 c:collection1 C2539 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2&waitSearcher=true&commit=true&softCommit=false} {commit=} 0 10
   [junit4]   2> 1216865 T5058 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1384712808
   [junit4]   2> 1216866 T5058 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@4088e2ed
   [junit4]   2> 1216866 T5058 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,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=109,transaction_logs_total_number=1}
   [junit4]   2> 1216867 T5058 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 1216867 T5058 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1216867 T5058 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1216868 T5058 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 1216894 T5058 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1216895 T5058 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data/index;done=false>>]
   [junit4]   2> 1216896 T5058 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data/index
   [junit4]   2> 1216896 T5058 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data;done=false>>]
   [junit4]   2> 1216896 T5058 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/core/data
   [junit4]   2> 1216896 T5058 oasc.SolrCore.close [collection2]  CLOSING SolrCore org.apache.solr.core.SolrCore@7556b6f8
   [junit4]   2> 1216897 T5058 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
   [junit4]   2> 1216897 T5058 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
   [junit4]   2> 1216897 T5058 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
   [junit4]   2> 1216897 T5058 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
   [junit4]   2> 1216898 T5058 oasc.SolrCore.closeSearcher [collection2] Closing main searcher on request.
   [junit4]   2> 1216913 T5058 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 1216913 T5058 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data/index;done=false>>]
   [junit4]   2> 1216913 T5058 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data/index
   [junit4]   2> 1216914 T5058 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data;done=false>>]
   [junit4]   2> 1216914 T5058 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.component.DistributedDebugComponentTest A2B3DE4E97CD5889-001/tempDir-002/cores/collection2/data
   [junit4]   2> 1216914 T5058 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 1217064 T5058 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: test params are: codec=CheapBastard, sim=DefaultSimilarity, locale=th, timezone=BET
   [junit4]   2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_80 (64-bit)/cpus=3,threads=1,free=105581832,total=280780800
   [junit4]   2> NOTE: All tests run in this JVM: [OverseerRolesTest, NoCacheHeaderTest, TestComponentsName, DistanceUnitsTest, TestAddFieldRealTimeGet, LeaderElectionTest, TestComplexPhraseQParserPlugin, TestSearcherReuse, TestAtomicUpdateErrorCases, TestDefaultSearchFieldResource, SuggesterTest, TestHighlightDedupGrouping, SuggesterWFSTTest, SharedFSAutoReplicaFailoverUtilsTest, SolrCoreTest, DistanceFunctionTest, TestBinaryField, UniqFieldsUpdateProcessorFactoryTest, TestExpandComponent, MigrateRouteKeyTest, TestHdfsUpdateLog, TestManagedResourceStorage, TestSerializedLuceneMatchVersion, HdfsRecoveryZkTest, TestIndexSearcher, TestRequestStatusCollectionAPI, TestClusterStateMutator, URLClassifyProcessorTest, TestGroupingSearch, TestCollapseQParserPlugin, ZkControllerTest, TestUniqueKeyFieldResource, TestAnalyzedSuggestions, SynonymTokenizerTest, DistribDocExpirationUpdateProcessorTest, TestInitParams, SampleTest, TestNamedUpdateProcessors, TestArbitraryIndexDir, RankQueryTest, TestDocBasedVersionConstraints, RemoteQueryErrorTest, TestPerFieldSimilarity, TestSolrDynamicMBean, TestStressReorder, AnalyticsQueryTest, ExternalCollectionsTest, OverseerTest, TestJmxMonitoredMap, CloudMLTQParserTest, TestReplicaProperties, TestCustomSort, TestFieldCollectionResource, OverriddenZkACLAndCredentialsProvidersTest, TestRandomDVFaceting, DefaultValueUpdateProcessorTest, UUIDFieldTest, PeerSyncTest, TestPhraseSuggestions, TestFaceting, SystemInfoHandlerTest, ClusterStateTest, TestSweetSpotSimilarityFactory, TestElisionMultitermQuery, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestInfoStreamLogging, TestMiniSolrCloudClusterSSL, SolrPluginUtilsTest, TestCSVResponseWriter, TestWriterPerf, SolrTestCaseJ4Test, TestUpdate, SimpleFacetsTest, ResponseLogComponentTest, TestPostingsSolrHighlighter, DirectUpdateHandlerTest, AnalysisAfterCoreReloadTest, DistribJoinFromCollectionTest, TestLFUCache, TestWordDelimiterFilterFactory, TestReplicationHandler, SuggesterFSTTest, TestIntervalFaceting, SuggestComponentTest, DocumentAnalysisRequestHandlerTest, TestNoOpRegenerator, DistributedDebugComponentTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=DistributedDebugComponentTest -Dtests.seed=A2B3DE4E97CD5889 -Dtests.slow=true -Dtests.locale=th -Dtests.timezone=BET -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J0 | DistributedDebugComponentTest (suite) <<<
   [junit4]    > Throwable #1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:56240/solr/collection1
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([A2B3DE4E97CD5889]:0)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:574)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:483)
   [junit4]    > 	at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:464)
   [junit4]    > 	at org.apache.solr.handler.component.DistributedDebugComponentTest.createThings(DistributedDebugComponentTest.java:90)
   [junit4]    > 	at java.lang.Thread.run(Thread.java:745)
   [junit4]    > Caused by: org.apache.http.NoHttpResponseException: 127.0.0.1:56240 failed to respond
   [junit4]    > 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143)
   [junit4]    > 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
   [junit4]    > 	at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
   [junit4]    > 	at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
   [junit4]    > 	at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
   [junit4]    > 	at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
   [junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
   [junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
   [junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
   [junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
   [junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
   [junit4]    > 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]    > 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
   [junit4]    > 	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:466)
   [junit4]    > 	... 30 more
   [junit4] Completed [193/484] on J0 in 202.35s, 0 tests, 1 error <<< FAILURES!

[...truncated 916 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:536: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:484: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:229: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:511: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1434: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:991: There were test failures: 484 suites, 1941 tests, 1 suite-level error, 59 ignored (24 assumptions)

Total time: 87 minutes 18 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
ERROR: Failed to archive artifacts: **/*.events,heapdumps/**,**/hs_err_pid*
java.io.IOException: Failed to extract /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/transfer of 2 files
	at hudson.FilePath.readFromTar(FilePath.java:2299)
	at hudson.FilePath.copyRecursiveTo(FilePath.java:2208)
	at jenkins.model.StandardArtifactManager.archive(StandardArtifactManager.java:61)
	at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:219)
	at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:74)
	at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
	at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:761)
	at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:721)
	at hudson.model.Build$BuildExecution.post2(Build.java:183)
	at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:670)
	at hudson.model.Run.execute(Run.java:1766)
	at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
	at hudson.model.ResourceController.execute(ResourceController.java:98)
	at hudson.model.Executor.run(Executor.java:374)
Caused by: java.io.IOException: Truncated TAR archive
	at org.apache.commons.compress.archivers.tar.TarArchiveInputStream.read(TarArchiveInputStream.java:614)
	at java.io.InputStream.read(InputStream.java:101)
	at org.apache.commons.io.IOUtils.copyLarge(IOUtils.java:1792)
	at org.apache.commons.io.IOUtils.copyLarge(IOUtils.java:1769)
	at org.apache.commons.io.IOUtils.copy(IOUtils.java:1744)
	at hudson.util.IOUtils.copy(IOUtils.java:40)
	at hudson.FilePath.readFromTar(FilePath.java:2289)
	... 13 more
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any