Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4606/ Java: 32bit/jdk1.8.0_40 -client -XX:+UseParallelGC
1 tests failed. FAILED: org.apache.solr.search.stats.TestDefaultStatsCache.test Error Message: Timeout occured while waiting response from server at: https://127.0.0.1:51126/l_/collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:51126/l_/collection1 at __randomizedtesting.SeedInfo.seed([25670BDEF88252D:8A024F67417448D5]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:572) 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.add(SolrClient.java:174) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:139) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:153) at org.apache.solr.BaseDistributedSearchTestCase.index_specific(BaseDistributedSearchTestCase.java:534) at org.apache.solr.search.stats.TestDefaultStatsCache.test(TestDefaultStatsCache.java:62) 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:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:982) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) 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: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) at java.net.SocketInputStream.read(SocketInputStream.java:170) at java.net.SocketInputStream.read(SocketInputStream.java:141) at sun.security.ssl.InputRecord.readFully(InputRecord.java:465) at sun.security.ssl.InputRecord.read(InputRecord.java:503) at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:961) at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:918) at sun.security.ssl.AppInputStream.read(AppInputStream.java:105) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) 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) ... 49 more Build Log: [...truncated 11044 lines...] [junit4] Suite: org.apache.solr.search.stats.TestDefaultStatsCache [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\init-core-data-001 [junit4] 2> 2419794 T14245 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 2419794 T14245 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /l_/ [junit4] 2> 2420295 T14245 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1 [junit4] 2> 2420299 T14245 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2420318 T14245 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2420322 T14245 oejs.AbstractConnector.doStart Started [email protected]:51117 [junit4] 2> 2420322 T14245 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/l_, hostPort=51117, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores} [junit4] 2> 2420332 T14245 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a [junit4] 2> 2420332 T14245 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\' [junit4] 2> 2420377 T14245 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\solr.xml [junit4] 2> 2420391 T14245 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores [junit4] 2> 2420392 T14245 oasc.CoreContainer.<init> New CoreContainer 20145653 [junit4] 2> 2420393 T14245 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\] [junit4] 2> 2420393 T14245 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\lib [junit4] 2> 2420393 T14245 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\lib). [junit4] 2> 2420403 T14245 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> 2420413 T14245 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2420419 T14245 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2420419 T14245 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2420420 T14245 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 2420422 T14245 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores [junit4] 2> 2420424 T14245 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\, configSet=collection1, dataDir=data\} [junit4] 2> 2420424 T14245 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\ [junit4] 2> 2420426 T14245 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2420426 T14255 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 2420428 T14255 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 2420428 T14255 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 2420494 T14255 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 2420507 T14255 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 2420543 T14255 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2420544 T14255 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml [junit4] 2> 2420572 T14255 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 2420808 T14255 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2420831 T14255 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2420834 T14255 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2420874 T14255 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2420879 T14255 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2420884 T14255 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2420885 T14255 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2420885 T14255 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2420886 T14255 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2420886 T14255 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2420887 T14255 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2420887 T14255 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1 [junit4] 2> 2420887 T14255 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2420888 T14255 c:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\], dataDir=[null] [junit4] 2> 2420888 T14255 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@15a831 [junit4] 2> 2420890 T14255 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\ [junit4] 2> 2420890 T14255 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index/ [junit4] 2> 2420890 T14255 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 2420891 T14255 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index [junit4] 2> 2420891 T14255 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=84.9765625, floorSegmentMB=1.482421875, forceMergeDeletesPctAllowed=4.42548809326272, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 2420892 T14255 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@21e91f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@32ca53),segFN=segments_1,generation=1} [junit4] 2> 2420892 T14255 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2420903 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2420904 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2420905 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2420906 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2420907 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2420907 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2420908 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 2420908 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 2420909 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2420909 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2420910 T14255 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2420910 T14255 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2420917 T14255 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2420927 T14255 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2420930 T14255 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2420934 T14255 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2420949 T14255 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2420956 T14255 c: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> 2420958 T14255 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 2420960 T14255 c:collection1 oasc.SolrCore.initStatsCache Using statsCache impl: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2420963 T14255 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2420963 T14255 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 2420966 T14255 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2420966 T14255 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2420968 T14255 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7766536415391114] [junit4] 2> 2420970 T14255 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@21e91f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@32ca53),segFN=segments_1,generation=1} [junit4] 2> 2420970 T14255 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2420972 T14255 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@1037485[collection1] main [junit4] 2> 2420972 T14255 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 2420972 T14255 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 2420973 T14255 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2420973 T14255 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 2421007 T14255 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2421184 T14255 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 2421185 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 2421185 T14255 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 2421185 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 2421186 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 2421186 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 2421187 T14245 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2421188 T14245 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2421188 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 2421191 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 2421191 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 2421192 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 2421193 T14256 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 2421195 T14256 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1037485[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2421735 T14245 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1 [junit4] 2> 2421739 T14245 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2421810 T14245 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2421823 T14245 oejs.AbstractConnector.doStart Started [email protected]:51120 [junit4] 2> 2421830 T14245 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/l_, hostPort=51120, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores} [junit4] 2> 2421837 T14245 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a [junit4] 2> 2421837 T14245 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\' [junit4] 2> 2421885 T14245 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\solr.xml [junit4] 2> 2421897 T14245 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores [junit4] 2> 2421897 T14245 oasc.CoreContainer.<init> New CoreContainer 18895036 [junit4] 2> 2421898 T14245 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\] [junit4] 2> 2421898 T14245 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\lib [junit4] 2> 2421899 T14245 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\lib). [junit4] 2> 2421913 T14245 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> 2421922 T14245 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2421929 T14245 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2421930 T14245 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2421930 T14245 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 2421946 T14245 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores [junit4] 2> 2421949 T14245 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\, configSet=collection1, dataDir=data\} [junit4] 2> 2421949 T14245 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\ [junit4] 2> 2421950 T14245 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2421954 T14267 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 2421956 T14267 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 2421956 T14267 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 2422022 T14267 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 2422037 T14267 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 2422078 T14267 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2422079 T14267 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml [junit4] 2> 2422092 T14267 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 2422303 T14267 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2422318 T14267 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2422321 T14267 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2422338 T14267 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2422343 T14267 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2422346 T14267 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2422348 T14267 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2422348 T14267 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2422348 T14267 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2422348 T14267 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2422348 T14267 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2422348 T14267 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1 [junit4] 2> 2422348 T14267 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2422349 T14267 c:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\], dataDir=[null] [junit4] 2> 2422349 T14267 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@15a831 [junit4] 2> 2422350 T14267 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\ [junit4] 2> 2422350 T14267 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index/ [junit4] 2> 2422350 T14267 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 2422351 T14267 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index [junit4] 2> 2422352 T14267 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=84.9765625, floorSegmentMB=1.482421875, forceMergeDeletesPctAllowed=4.42548809326272, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 2422354 T14267 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@404420 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@13ca96e),segFN=segments_1,generation=1} [junit4] 2> 2422354 T14267 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2422363 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2422364 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2422364 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2422364 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2422365 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2422365 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2422365 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 2422365 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 2422367 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2422367 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2422367 T14267 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2422367 T14267 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2422368 T14267 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2422368 T14267 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2422369 T14267 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2422372 T14267 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2422390 T14267 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2422401 T14267 c: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> 2422402 T14267 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 2422404 T14267 c:collection1 oasc.SolrCore.initStatsCache Using statsCache impl: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2422406 T14267 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2422407 T14267 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 2422407 T14267 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2422407 T14267 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2422408 T14267 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7766536415391114] [junit4] 2> 2422410 T14267 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@404420 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@13ca96e),segFN=segments_1,generation=1} [junit4] 2> 2422410 T14267 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2422411 T14267 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@1a24a54[collection1] main [junit4] 2> 2422411 T14267 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 2422412 T14267 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 2422412 T14267 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2422412 T14267 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 2422465 T14267 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2422659 T14267 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 2422663 T14267 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 2422666 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 2422669 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 2422669 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 2422669 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 2422675 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 2422677 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 2422680 T14245 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2422682 T14245 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2422682 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 2422684 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 2422687 T14268 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 2422691 T14268 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a24a54[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2422697 T14245 oas.SolrTestCaseJ4.setUp ###Starting test [junit4] 2> ASYNC NEW_CORE C2478 name=collection1 org.apache.solr.core.SolrCore@13b8ef0 [junit4] 2> 2422867 T14250 c:collection1 C2478 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1499421300966293504)} 0 5 [junit4] 2> ASYNC NEW_CORE C2479 name=collection1 org.apache.solr.core.SolrCore@e43d0 [junit4] 2> 2422997 T14266 c:collection1 C2479 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1499421301103656960)} 0 5 [junit4] 2> 2423017 T14249 c:collection1 C2478 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={wt=javabin&version=2} {add=[0 (1499421301117288448)]} 0 15 [junit4] 2> 2423029 T14262 c:collection1 C2479 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={wt=javabin&version=2} {add=[0 (1499421301136162816)]} 0 5 [junit4] 2> 2423037 T14252 c:collection1 C2478 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2423062 T14252 c:collection1 C2478 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@21e91f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@32ca53),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@21e91f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@32ca53),segFN=segments_2,generation=2} [junit4] 2> 2423063 T14252 c:collection1 C2478 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 2423071 T14252 c:collection1 C2478 oass.SolrIndexSearcher.<init> Opening Searcher@104e5c7[collection1] main [junit4] 2> 2423073 T14252 c:collection1 C2478 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 2423082 T14256 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@104e5c7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):c1)))} [junit4] 2> 2423102 T14252 c:collection1 C2478 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 66 [junit4] 2> 2423108 T14261 c:collection1 C2479 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2423147 T14261 c:collection1 C2479 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@404420 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@13ca96e),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@404420 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@13ca96e),segFN=segments_2,generation=2} [junit4] 2> 2423148 T14261 c:collection1 C2479 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 2423150 T14261 c:collection1 C2479 oass.SolrIndexSearcher.<init> Opening Searcher@11abf95[collection1] main [junit4] 2> 2423153 T14261 c:collection1 C2479 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 2423159 T14268 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@11abf95[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):c1)))} [junit4] 2> 2423161 T14261 c:collection1 C2479 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 53 [junit4] 2> 2423181 T14249 c:collection1 C2478 oasc.SolrCore.execute [collection1] webapp=/l_ path=/select params={q=a_t:one&fl=*,score&wt=javabin&version=2&debugQuery=true} hits=1 status=0 QTime=15 [junit4] 2> 2423283 T14261 c:collection1 C2479 oasc.SolrCore.execute [collection1] webapp=/l_ path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=https://127.0.0.1:51120/l_/collection1&rid=127.0.0.1-collection1-1429959584530-35&rows=10&version=2&q=a_t:one&requestPurpose=GET_TOP_IDS&NOW=1429959584529&isShard=true&wt=javabin&debugQuery=false} hits=1 status=0 QTime=1 [junit4] 2> 2423311 T14266 c:collection1 C2479 oasc.SolrCore.execute [collection1] webapp=/l_ path=/select params={distrib=false&debug=timing&debug=track&fl=*,score&shards.purpose=320&shard.url=https://127.0.0.1:51120/l_/collection1&rid=127.0.0.1-collection1-1429959584530-35&version=2&q=a_t:one&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1429959584529&ids=0&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=2 [junit4] 2> 2423319 T14264 c:collection1 C2479 oasc.SolrCore.execute [collection1] webapp=/l_ path=/select params={q=a_t:one&shards=https://127.0.0.1:51120/l_/collection1&fl=*,score&wt=javabin&version=2&debugQuery=true} rid=127.0.0.1-collection1-1429959584530-35 hits=1 status=0 QTime=132 [junit4] 2> 2423332 T14249 c:collection1 C2478 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={wt=javabin&version=2} {add=[1 (1499421301454929920)]} 0 5 [junit4] 2> 2423343 T14265 c:collection1 C2479 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={wt=javabin&version=2} {add=[1 (1499421301465415680)]} 0 5 [junit4] 2> 2423348 T14251 c:collection1 C2478 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2423360 T14251 c:collection1 C2478 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@21e91f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@32ca53),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@21e91f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@32ca53),segFN=segments_3,generation=3} [junit4] 2> 2423361 T14251 c:collection1 C2478 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 2423362 T14251 c:collection1 C2478 oass.SolrIndexSearcher.<init> Opening Searcher@63fd16[collection1] main [junit4] 2> 2423363 T14251 c:collection1 C2478 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 2423372 T14256 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@63fd16[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):c1) Uninverting(_1(5.2.0):c1)))} [junit4] 2> 2423374 T14251 c:collection1 C2478 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 27 [junit4] 2> 2423380 T14262 c:collection1 C2479 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2423398 T14262 c:collection1 C2479 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@404420 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@13ca96e),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@404420 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@13ca96e),segFN=segments_3,generation=3} [junit4] 2> 2423399 T14262 c:collection1 C2479 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 2423400 T14262 c:collection1 C2479 oass.SolrIndexSearcher.<init> Opening Searcher@e1d092[collection1] main [junit4] 2> 2423403 T14262 c:collection1 C2479 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 2423407 T14268 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e1d092[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):c1) Uninverting(_1(5.2.0):c1)))} [junit4] 2> 2423420 T14262 c:collection1 C2479 oasup.LogUpdateProcessor.finish [collection1] webapp=/l_ path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 41 [junit4] 2> 2423435 T14254 c:collection1 C2478 oasc.SolrCore.execute [collection1] webapp=/l_ path=/select params={q=a_t:one+a_t:four&fl=*,score&wt=javabin&version=2&debugQuery=true} hits=2 status=0 QTime=5 [junit4] 2> 2423453 T14266 c:collection1 C2479 oasc.SolrCore.execute [collection1] webapp=/l_ path=/select params={distrib=false&debug=false&debug=timing&debug=track&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=https://127.0.0.1:51120/l_/collection1&rid=127.0.0.1-collection1-1429959584788-36&rows=10&version=2&q=a_t:one+a_t:four&requestPurpose=GET_TOP_IDS&NOW=1429959584787&isShard=true&wt=javabin&debugQuery=false} hits=2 status=0 QTime=2 [junit4] 2> 2423468 T14264 c:collection1 C2479 oasc.SolrCore.execute [collection1] webapp=/l_ path=/select params={distrib=false&debug=timing&debug=track&fl=*,score&shards.purpose=320&shard.url=https://127.0.0.1:51120/l_/collection1&rid=127.0.0.1-collection1-1429959584788-36&version=2&q=a_t:one+a_t:four&requestPurpose=GET_FIELDS,GET_DEBUG&NOW=1429959584787&ids=0,1&isShard=true&wt=javabin&debugQuery=true} status=0 QTime=3 [junit4] 2> 2423485 T14261 c:collection1 C2479 oasc.SolrCore.execute [collection1] webapp=/l_ path=/select params={q=a_t:one+a_t:four&shards=https://127.0.0.1:51120/l_/collection1&fl=*,score&wt=javabin&version=2&debugQuery=true} rid=127.0.0.1-collection1-1429959584788-36 hits=2 status=0 QTime=40 [junit4] 2> 2423487 T14245 oas.SolrTestCaseJ4.tearDown ###Ending test [junit4] 2> 2423502 T14245 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=20145653 [junit4] 2> 2423505 T14245 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@13b8ef0 [junit4] 2> 2423506 T14245 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=2,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=277,transaction_logs_total_number=2} [junit4] 2> 2423507 T14245 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 2423507 T14245 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 2423508 T14245 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 2423510 T14245 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 2423548 T14245 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 2423549 T14245 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\;done=false>>] [junit4] 2> 2423550 T14245 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\ [junit4] 2> 2423551 T14245 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index;done=false>>] [junit4] 2> 2423566 T14245 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index [junit4] 2> 2423567 T14245 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/l_,null} [junit4] 2> 2423753 T14245 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=18895036 [junit4] 2> 2423755 T14245 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@e43d0 [junit4] 2> 2423756 T14245 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=2,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=277,transaction_logs_total_number=2} [junit4] 2> 2423756 T14245 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 2423756 T14245 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 2423757 T14245 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 2423761 T14245 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 2423870 T14245 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 2423870 T14245 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\;done=false>>] [junit4] 2> 2423871 T14245 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\ [junit4] 2> 2423871 T14245 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index;done=false>>] [junit4] 2> 2423871 T14245 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index [junit4] 2> 2423873 T14245 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/l_,null} [junit4] 2> 2424422 T14245 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2424449 T14245 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2424475 T14245 oejs.AbstractConnector.doStart Started [email protected]:51126 [junit4] 2> 2424476 T14245 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/l_, hostPort=51126, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores} [junit4] 2> 2424485 T14245 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a [junit4] 2> 2424487 T14245 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\' [junit4] 2> 2424551 T14245 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\solr.xml [junit4] 2> 2424563 T14245 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores [junit4] 2> 2424565 T14245 oasc.CoreContainer.<init> New CoreContainer 20529359 [junit4] 2> 2424565 T14245 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\] [junit4] 2> 2424566 T14245 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\lib [junit4] 2> 2424566 T14245 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\lib). [junit4] 2> 2424585 T14245 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> 2424593 T14245 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2424631 T14245 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2424632 T14245 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2424632 T14245 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 2424637 T14245 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores [junit4] 2> 2424639 T14245 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\, configSet=collection1, dataDir=data\} [junit4] 2> 2424640 T14245 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\ [junit4] 2> 2424641 T14245 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2424667 T14280 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 2424668 T14280 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 2424669 T14280 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 2424734 T14280 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 2424753 T14280 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 2424795 T14280 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2424796 T14280 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml [junit4] 2> 2424810 T14280 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 2425119 T14280 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2425136 T14280 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2425138 T14280 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2425155 T14280 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2425159 T14280 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2425163 T14280 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2425164 T14280 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2425165 T14280 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2425165 T14280 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2425166 T14280 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2425166 T14280 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2425166 T14280 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1 [junit4] 2> 2425167 T14280 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2425168 T14280 c:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\], dataDir=[null] [junit4] 2> 2425168 T14280 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@15a831 [junit4] 2> 2425169 T14280 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\ [junit4] 2> 2425170 T14280 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index/ [junit4] 2> 2425171 T14280 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 2425172 T14280 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\control\cores\collection1\data\index [junit4] 2> 2425173 T14280 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=84.9765625, floorSegmentMB=1.482421875, forceMergeDeletesPctAllowed=4.42548809326272, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 2425186 T14280 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@b82484 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c2262c),segFN=segments_1,generation=1} [junit4] 2> 2425188 T14280 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2425199 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2425200 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2425200 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2425201 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2425201 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2425201 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2425202 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 2425202 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 2425202 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2425202 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2425203 T14280 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2425203 T14280 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2425240 T14280 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2425243 T14280 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2425247 T14280 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2425250 T14280 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2425260 T14280 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2425265 T14280 c: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> 2425265 T14280 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 2425267 T14280 c:collection1 oasc.SolrCore.initStatsCache Using statsCache impl: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2425270 T14280 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2425270 T14280 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 2425271 T14280 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2425271 T14280 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2425272 T14280 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7766536415391114] [junit4] 2> 2425273 T14280 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@b82484 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c2262c),segFN=segments_1,generation=1} [junit4] 2> 2425274 T14280 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2425274 T14280 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@126557a[collection1] main [junit4] 2> 2425275 T14280 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 2425275 T14280 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 2425275 T14280 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2425275 T14280 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 2425281 T14280 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2425302 T14280 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 2425303 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 2425304 T14280 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 2425305 T14245 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0 [junit4] 2> 2425306 T14245 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2425305 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 2425354 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 2425355 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 2425356 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 2425356 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 2425357 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 2425358 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 2425360 T14281 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 2425363 T14281 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@126557a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2425598 T14245 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2425606 T14245 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 2425609 T14245 oejs.AbstractConnector.doStart Started [email protected]:51129 [junit4] 2> 2425610 T14245 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/l_, hostPort=51129, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores} [junit4] 2> 2425638 T14245 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@e2f2a [junit4] 2> 2425639 T14245 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\' [junit4] 2> 2425684 T14245 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\solr.xml [junit4] 2> 2425694 T14245 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores [junit4] 2> 2425696 T14245 oasc.CoreContainer.<init> New CoreContainer 20152430 [junit4] 2> 2425696 T14245 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\] [junit4] 2> 2425696 T14245 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\lib [junit4] 2> 2425697 T14245 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\lib). [junit4] 2> 2425709 T14245 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> 2425714 T14245 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2425718 T14245 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2425719 T14245 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2425719 T14245 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 2425724 T14245 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores [junit4] 2> 2425726 T14245 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\, configSet=collection1, dataDir=data\} [junit4] 2> 2425726 T14245 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\ [junit4] 2> 2425727 T14245 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2425728 T14292 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 2425730 T14292 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 2425730 T14292 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-5.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 2425783 T14292 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 2425800 T14292 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 2425832 T14292 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2425832 T14292 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\conf\schema.xml [junit4] 2> 2425839 T14292 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 2426053 T14292 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2426067 T14292 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2426071 T14292 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2426084 T14292 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2426088 T14292 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2426093 T14292 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2426093 T14292 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2426095 T14292 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2426096 T14292 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2426097 T14292 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2426097 T14292 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2426100 T14292 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1 [junit4] 2> 2426100 T14292 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2426101 T14292 c:collection1 oasc.SolrCore.<init> [[collection1] ] Opening new SolrCore at [C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\core\src\test-files\solr\collection1\], dataDir=[null] [junit4] 2> 2426101 T14292 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@15a831 [junit4] 2> 2426103 T14292 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\ [junit4] 2> 2426103 T14292 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index/ [junit4] 2> 2426104 T14292 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 2426105 T14292 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001\tempDir-001\shard0\cores\collection1\data\index [junit4] 2> 2426108 T14292 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=15, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=84.9765625, floorSegmentMB=1.482421875, forceMergeDeletesPctAllowed=4.42548809326272, segmentsPerTier=23.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 2426109 T14292 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@8db9f5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@483b28),segFN=segments_1,generation=1} [junit4] 2> 2426110 T14292 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2426160 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2426161 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2426162 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2426162 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2426162 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2426163 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2426163 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 2426163 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 2426163 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2426164 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2426164 T14292 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2426164 T14292 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2426171 T14292 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2426175 T14292 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=6 [...truncated too long message...] t4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.stats.TestDefaultStatsCache 25670BDEF88252D-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {range_facet_l_dv=Lucene50(blocksize=128), _version_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), multiDefault=FSTOrd50, a_t=FSTOrd50, shard_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), intDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), id=Lucene50(blocksize=128), range_facet_i_dv=FSTOrd50, text=PostingsFormat(name=Asserting), range_facet_l=FSTOrd50, timestamp=FSTOrd50}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene50), range_facet_i_dv=DocValuesFormat(name=Memory), timestamp=DocValuesFormat(name=Memory)}, sim=DefaultSimilarity, locale=uk_UA, timezone=America/Belize [junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_40 (32-bit)/cpus=3,threads=1,free=137320688,total=382730240 [junit4] 2> NOTE: All tests run in this JVM: [TestFunctionQuery, OverriddenZkACLAndCredentialsProvidersTest, TestXIncludeConfig, TestManagedSchemaFieldResource, TestSortingResponseWriter, ReplicationFactorTest, TestSolrDynamicMBean, TestSchemaResource, TestDynamicFieldResource, TestStressLucene, VMParamsZkACLAndCredentialsProvidersTest, TestCoreContainer, AlternateDirectoryTest, XmlUpdateRequestHandlerTest, TestAddFieldRealTimeGet, JSONWriterTest, TestIndexSearcher, TestMacros, TestHashPartitioner, TestUniqueKeyFieldResource, StressHdfsTest, TestSurroundQueryParser, TestTrackingShardHandlerFactory, TestFastLRUCache, ShardRoutingTest, TestChildDocTransformer, BadComponentTest, AliasIntegrationTest, CoreAdminRequestStatusTest, TestManagedSynonymFilterFactory, TestNRTOpen, CoreMergeIndexesAdminHandlerTest, AssignTest, TestFaceting, SimpleMLTQParserTest, TestComplexPhraseQParserPlugin, AddSchemaFieldsUpdateProcessorFactoryTest, TestTolerantSearch, SuggesterWFSTTest, CollectionReloadTest, TestLRUStatsCache, TestHighFrequencyDictionaryFactory, FieldAnalysisRequestHandlerTest, TestLazyCores, TestWordDelimiterFilterFactory, TestFileDictionaryLookup, TestFieldSortValues, TestStressRecovery, FacetPivotSmallTest, SuggesterTest, TestUpdate, ChaosMonkeyNothingIsSafeTest, TestQueryUtils, TestAtomicUpdateErrorCases, ZkControllerTest, DocValuesMissingTest, TestRecoveryHdfs, ClusterStateTest, HdfsThreadLeakTest, DefaultValueUpdateProcessorTest, DistributedFacetPivotWhiteBoxTest, RequestLoggingTest, AnalyticsQueryTest, ClusterStateUpdateTest, TestSchemaVersionResource, MultiTermTest, TestSolrIndexConfig, DistanceUnitsTest, DistribCursorPagingTest, OverseerRolesTest, TestHashQParserPlugin, TestManagedSchema, SharedFSAutoReplicaFailoverUtilsTest, SolrInfoMBeanTest, TestConfigOverlay, MultiThreadedOCPTest, TestSolrQueryParserResource, TestWriterPerf, TestFieldCollectionResource, ResponseLogComponentTest, SolrIndexSplitterTest, TestReplicaProperties, TestCharFilters, BasicDistributedZkTest, TestAnalyzedSuggestions, TestShortCircuitedRequests, TestJmxIntegration, TestStandardQParsers, ShowFileRequestHandlerTest, TestPerFieldSimilarity, TestDocumentBuilder, HardAutoCommitTest, PeerSyncTest, SampleTest, RequiredFieldsTest, TestExactSharedStatsCache, TestCollationFieldDocValues, TestQueryTypes, TestLRUCache, PingRequestHandlerTest, TestNoOpRegenerator, RollingRestartTest, TestHighlightDedupGrouping, DistributedQueryComponentOptimizationTest, TestFieldResource, DirectUpdateHandlerTest, DirectSolrConnectionTest, TestGroupingSearch, AtomicUpdatesTest, TestIndexingPerformance, HdfsBasicDistributedZkTest, TestFreeTextSuggestions, TestCollationField, TestBinaryResponseWriter, TestSort, SolrTestCaseJ4Test, NoCacheHeaderTest, SolrCoreTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, LeaderElectionIntegrationTest, FullSolrCloudDistribCmdsTest, TestRandomFaceting, LeaderElectionTest, TestRandomDVFaceting, ZkCLITest, DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, TestStressReorder, TestStressVersions, DistributedTermsComponentTest, TestRangeQuery, SimpleFacetsTest, StatsComponentTest, SolrCmdDistributorTest, QueryElevationComponentTest, ConvertedLegacyTest, BasicFunctionalityTest, SoftAutoCommitTest, DistributedQueryElevationComponentTest, TestExtendedDismaxParser, SpellCheckCollatorTest, CoreAdminHandlerTest, TestTrie, TestCSVLoader, SchemaVersionSpecificBehaviorTest, TestPseudoReturnFields, QueryEqualityTest, DistanceFunctionTest, IndexBasedSpellCheckerTest, DirectSolrSpellCheckerTest, PrimitiveFieldTypeTest, TestOmitPositions, RequestHandlersTest, TestValueSourceCache, TestArbitraryIndexDir, SolrPluginUtilsTest, UpdateRequestProcessorFactoryTest, UniqFieldsUpdateProcessorFactoryTest, TestPHPSerializedResponseWriter, TestComponentsName, TestLFUCache, TestMergePolicyConfig, TestDocSet, TestSearchPerf, TestElisionMultitermQuery, ExternalFileFieldSortTest, TestPhraseSuggestions, SynonymTokenizerTest, TestSweetSpotSimilarityFactory, TestIBSimilarityFactory, TestFastWriter, TimeZoneUtilsTest, TestFastOutputStream, OpenExchangeRatesOrgProviderTest, PluginInfoTest, DateMathParserTest, PreAnalyzedFieldTest, TestSystemIdResolver, PrimUtilsTest, DateFieldTest, SpellingQueryConverterTest, DOMUtilTest, TestSolrJ, TestUtils, SliceStateTest, SystemInfoHandlerTest, UUIDFieldTest, FileUtilsTest, CircularListTest, TestRTGBase, TestDistributedMissingSort, ConcurrentDeleteAndCreateCollectionTest, ConnectionManagerTest, CustomCollectionTest, DistribJoinFromCollectionTest, HttpPartitionTest, RecoveryAfterSoftCommitTest, SSLMigrationTest, SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, SimpleCollectionCreateDeleteTest, SolrXmlInZkTest, TestCloudInspectUtil, TestCollectionAPI, TestCryptoKeys, TriLevelCompositeIdRoutingTest, HdfsDirectoryFactoryTest, QueryResultKeyTest, TestConfigSets, TestDynamicLoading, TestReplicationHandlerBackup, TestRestoreCore, TestSolrConfigHandlerCloud, DistributedFacetPivotSmallAdvancedTest, DistributedFacetPivotSmallTest, DistributedSuggestComponentTest, TestExpandComponent, TestPivotHelperCode, HighlighterMaxOffsetTest, TestManagedResourceStorage, TestRestManager, TestBulkSchemaAPI, TestClassNameShortening, TestFieldTypeCollectionResource, TestFieldTypeResource, TestManagedSchemaDynamicFieldResource, ChangedSchemaMergeTest, DateRangeFieldTest, TestCloudManagedSchema, TestSchemaManager, AnalyticsMergeStrategyTest, CursorMarkTest, MergeStrategyTest, TestCollapseQParserPlugin, TestCustomSort, TestInitQParser, TestMaxScoreQueryParser, TestOverriddenPrefixQueryForCustomFieldType, TestSimpleQParserPlugin, TestSolr4Spatial2, TestOrdValues, BJQParserTest, TestJsonRequest, TestNonDefinedSimilarityFactory, TestDefaultStatsCache] [junit4] Completed [484/484] on J0 in 96.26s, 1 test, 1 error <<< FAILURES! [...truncated 10 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:536: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:484: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:229: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:511: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1434: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:991: There were test failures: 484 suites, 1946 tests, 1 error, 63 ignored (34 assumptions) Total time: 60 minutes 29 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 C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows/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
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
