Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4531/ Java: 64bit/jdk1.8.0_40 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed. FAILED: org.apache.solr.TestHighlightDedupGrouping.test Error Message: Timeout occured while waiting response from server at: https://127.0.0.1:56791/n_r/s/collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:56791/n_r/s/collection1 at __randomizedtesting.SeedInfo.seed([891A7A857EFF9899:14E455FD003F561]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:568) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:233) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:225) 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.TestHighlightDedupGrouping.addDoc(TestHighlightDedupGrouping.java:122) at org.apache.solr.TestHighlightDedupGrouping.randomizedTest(TestHighlightDedupGrouping.java:96) at org.apache.solr.TestHighlightDedupGrouping.test(TestHighlightDedupGrouping.java:42) 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$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.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:53) 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:462) ... 50 more Build Log: [...truncated 10016 lines...] [junit4] Suite: org.apache.solr.TestHighlightDedupGrouping [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\init-core-data-001 [junit4] 2> 829120 T5237 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 829120 T5237 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /n_r/s [junit4] 2> 829440 T5237 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1 [junit4] 2> 829443 T5237 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 829450 T5237 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 829453 T5237 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:56785 [junit4] 2> 829454 T5237 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/n_r/s, hostPort=56785, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores} [junit4] 2> 829457 T5237 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 829457 T5237 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\' [junit4] 2> 829485 T5237 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\solr.xml [junit4] 2> 829496 T5237 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores [junit4] 2> 829496 T5237 oasc.CoreContainer.<init> New CoreContainer 1499400499 [junit4] 2> 829496 T5237 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\] [junit4] 2> 829497 T5237 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\lib [junit4] 2> 829497 T5237 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\lib). [junit4] 2> 829504 T5237 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 829504 T5237 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https [junit4] 2> 829504 T5237 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 829505 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 829505 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 829505 T5237 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 829506 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 829506 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 829506 T5237 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 829506 T5237 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 829507 T5237 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 829512 T5237 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 829514 T5237 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 829514 T5237 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 829515 T5237 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 829516 T5237 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores [junit4] 2> 829517 T5237 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\, configSet=collection1, dataDir=data\} [junit4] 2> 829517 T5237 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\ [junit4] 2> 829518 T5237 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 829518 T5247 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> 829519 T5247 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> 829519 T5247 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> 829542 T5247 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 829554 T5247 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 829577 T5247 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 829577 T5247 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> 829582 T5247 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 829718 T5247 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 829729 T5247 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 829730 T5247 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 829737 T5247 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 829740 T5247 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 829742 T5247 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 829742 T5247 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 829742 T5247 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 829743 T5247 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 829743 T5247 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 829743 T5247 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 829743 T5247 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> 829744 T5247 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 829744 T5247 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=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\ [junit4] 2> 829744 T5247 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5393f8e7 [junit4] 2> 829745 T5247 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\ [junit4] 2> 829745 T5247 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\index/ [junit4] 2> 829745 T5247 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 829745 T5247 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\index [junit4] 2> 829745 T5247 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 829746 T5247 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@d9f5ca2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2850b566),segFN=segments_1,generation=1} [junit4] 2> 829746 T5247 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 829749 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 829749 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 829749 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 829749 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 829750 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 829750 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 829750 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 829750 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 829750 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 829750 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 829751 T5247 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 829751 T5247 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 829755 T5247 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 829756 T5247 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 829757 T5247 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 829758 T5247 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 829761 T5247 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 829762 T5247 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> 829767 T5247 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 829768 T5247 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 829769 T5247 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 829769 T5247 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 829770 T5247 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 829771 T5247 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 829771 T5247 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 829771 T5247 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@d9f5ca2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2850b566),segFN=segments_1,generation=1} [junit4] 2> 829771 T5247 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 829772 T5247 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@2c7b8fcb[collection1] main [junit4] 2> 829772 T5247 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 829772 T5247 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 829772 T5247 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 829772 T5247 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 829779 T5247 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 829807 T5247 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 829808 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 829808 T5247 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 829808 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 829809 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 829809 T5237 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1 [junit4] 2> 829809 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 829810 T5237 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 829810 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 829810 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 829811 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 829811 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 829811 T5248 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 829812 T5248 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2c7b8fcb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 830123 T5237 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1 [junit4] 2> 830126 T5237 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 830133 T5237 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 830135 T5237 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:56788 [junit4] 2> 830136 T5237 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/n_r/s, hostPort=56788, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores} [junit4] 2> 830139 T5237 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 830140 T5237 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\' [junit4] 2> 830166 T5237 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\solr.xml [junit4] 2> 830173 T5237 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores [junit4] 2> 830174 T5237 oasc.CoreContainer.<init> New CoreContainer 1919027628 [junit4] 2> 830174 T5237 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\] [junit4] 2> 830174 T5237 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\lib [junit4] 2> 830174 T5237 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\lib). [junit4] 2> 830183 T5237 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 830183 T5237 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https [junit4] 2> 830183 T5237 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 830183 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 830183 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 830184 T5237 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 830184 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 830184 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 830184 T5237 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 830184 T5237 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 830185 T5237 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 830189 T5237 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 830192 T5237 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 830192 T5237 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 830193 T5237 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 830194 T5237 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores [junit4] 2> 830195 T5237 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\, configSet=collection1, dataDir=data\} [junit4] 2> 830195 T5237 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\ [junit4] 2> 830195 T5237 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 830196 T5259 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> 830197 T5259 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> 830197 T5259 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> 830227 T5259 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 830234 T5259 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 830256 T5259 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 830257 T5259 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> 830261 T5259 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 830369 T5259 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 830375 T5259 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 830376 T5259 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 830381 T5259 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 830386 T5259 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 830387 T5259 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 830388 T5259 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 830388 T5259 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 830388 T5259 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 830388 T5259 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 830388 T5259 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 830389 T5259 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> 830389 T5259 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 830389 T5259 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=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\ [junit4] 2> 830389 T5259 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5393f8e7 [junit4] 2> 830390 T5259 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\ [junit4] 2> 830390 T5259 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\index/ [junit4] 2> 830390 T5259 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 830391 T5259 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\index [junit4] 2> 830391 T5259 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 830391 T5259 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e3b0a95 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a45be),segFN=segments_1,generation=1} [junit4] 2> 830391 T5259 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 830394 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 830395 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 830395 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 830395 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 830395 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 830395 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 830395 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 830395 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 830396 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 830396 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 830396 T5259 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 830396 T5259 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 830401 T5259 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 830402 T5259 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 830403 T5259 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 830404 T5259 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 830407 T5259 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 830409 T5259 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> 830409 T5259 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 830410 T5259 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 830411 T5259 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 830411 T5259 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 830412 T5259 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 830412 T5259 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 830414 T5259 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 830414 T5259 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e3b0a95 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a45be),segFN=segments_1,generation=1} [junit4] 2> 830414 T5259 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 830414 T5259 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@26c31bd0[collection1] main [junit4] 2> 830415 T5259 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 830415 T5259 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 830415 T5259 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 830415 T5259 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 830444 T5259 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 830481 T5259 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 830482 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 830482 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 830482 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 830482 T5259 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 830482 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 830483 T5237 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1 [junit4] 2> 830483 T5237 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 830484 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 830484 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 830485 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 830485 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 830487 T5260 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 830506 T5260 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@26c31bd0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 830772 T5237 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1 [junit4] 2> 830774 T5237 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 830780 T5237 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 830782 T5237 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:56791 [junit4] 2> 830783 T5237 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/n_r/s, hostPort=56791, coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores} [junit4] 2> 830785 T5237 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@4e0e2f2a [junit4] 2> 830785 T5237 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\' [junit4] 2> 830807 T5237 oasc.SolrXmlConfig.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\solr.xml [junit4] 2> 830816 T5237 oasc.CorePropertiesLocator.<init> Config-defined core root directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores [junit4] 2> 830817 T5237 oasc.CoreContainer.<init> New CoreContainer 1965371992 [junit4] 2> 830817 T5237 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\] [junit4] 2> 830817 T5237 oasc.CoreContainer.load loading shared library: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\lib [junit4] 2> 830818 T5237 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\lib). [junit4] 2> 830824 T5237 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 830824 T5237 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: https [junit4] 2> 830825 T5237 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 830825 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 830825 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 830825 T5237 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 830825 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 830825 T5237 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 830826 T5237 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 830826 T5237 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 830826 T5237 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 830831 T5237 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 830833 T5237 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 830834 T5237 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 830835 T5237 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 830840 T5237 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores [junit4] 2> 830840 T5237 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1, absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\, configSet=collection1, dataDir=data\} [junit4] 2> 830841 T5237 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\ [junit4] 2> 830841 T5237 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 830842 T5271 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> 830843 T5271 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> 830843 T5271 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> 830862 T5271 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 830875 T5271 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 830899 T5271 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 830900 T5271 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> 830905 T5271 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 831015 T5271 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 831021 T5271 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 831022 T5271 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 831026 T5271 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 831028 T5271 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 831029 T5271 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 831030 T5271 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 831030 T5271 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 831030 T5271 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 831030 T5271 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 831031 T5271 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 831031 T5271 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> 831031 T5271 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 831031 T5271 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=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\ [junit4] 2> 831031 T5271 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5393f8e7 [junit4] 2> 831032 T5271 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\ [junit4] 2> 831032 T5271 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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\index/ [junit4] 2> 831032 T5271 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 831032 T5271 c:collection1 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\index [junit4] 2> 831032 T5271 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 831033 T5271 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@353b55f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25c2347b),segFN=segments_1,generation=1} [junit4] 2> 831033 T5271 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 831036 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 831037 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 831037 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 831037 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 831037 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 831037 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 831037 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 831038 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 831038 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 831038 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 831039 T5271 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 831039 T5271 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 831045 T5271 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 831046 T5271 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 831047 T5271 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 831049 T5271 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 831057 T5271 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 831059 T5271 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> 831060 T5271 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 831061 T5271 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 831062 T5271 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 831062 T5271 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 831063 T5271 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 831063 T5271 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 831065 T5271 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 831065 T5271 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@353b55f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25c2347b),segFN=segments_1,generation=1} [junit4] 2> 831065 T5271 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 831065 T5271 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@38a705d0[collection1] main [junit4] 2> 831066 T5271 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 831066 T5271 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 831066 T5271 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 831066 T5271 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 831094 T5271 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 831143 T5271 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 831144 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 831144 T5271 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 831144 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 831144 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 831145 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 831145 T5237 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1 [junit4] 2> 831146 T5237 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 831146 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 831146 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 831147 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 831147 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 831148 T5272 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 831148 T5272 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38a705d0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 831154 T5237 oas.SolrTestCaseJ4.setUp ###Starting test [junit4] 2> ASYNC NEW_CORE C1563 name=collection1 org.apache.solr.core.SolrCore@5ee24068 [junit4] 2> 831272 T5242 c:collection1 C1563 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1497867417617956864)} 0 4 [junit4] 2> ASYNC NEW_CORE C1564 name=collection1 org.apache.solr.core.SolrCore@6b70635b [junit4] 2> 831309 T5255 c:collection1 C1564 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1497867417652559872)} 0 7 [junit4] 2> ASYNC NEW_CORE C1565 name=collection1 org.apache.solr.core.SolrCore@f515da2 [junit4] 2> 831356 T5268 c:collection1 C1565 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1497867417706037248)} 0 3 [junit4] 2> ASYNC NEW_CORE C1566 name=collection1 org.apache.solr.core.SolrCore@5ee24068 [junit4] 2> 831362 T5244 c:collection1 C1566 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 831362 T5244 c:collection1 C1566 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit. [junit4] 2> 831364 T5244 c:collection1 C1566 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 831364 T5244 c:collection1 C1566 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 831365 T5244 c:collection1 C1566 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 3 [junit4] 2> 831369 T5258 c:collection1 C1564 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 831369 T5258 c:collection1 C1564 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit. [junit4] 2> 831371 T5258 c:collection1 C1564 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 831371 T5258 c:collection1 C1564 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 831371 T5258 c:collection1 C1564 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2 [junit4] 2> 831375 T5265 c:collection1 C1565 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 831376 T5265 c:collection1 C1565 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit. [junit4] 2> 831376 T5265 c:collection1 C1565 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 831376 T5265 c:collection1 C1565 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 831377 T5265 c:collection1 C1565 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2 [junit4] 2> 831382 T5254 c:collection1 C1564 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[1 (1497867417735397376)]} 0 1 [junit4] 2> 831385 T5256 c:collection1 C1564 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 831390 T5256 c:collection1 C1564 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e3b0a95 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a45be),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e3b0a95 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a45be),segFN=segments_2,generation=2} [junit4] 2> 831391 T5256 c:collection1 C1564 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 831393 T5256 c:collection1 C1564 oass.SolrIndexSearcher.<init> Opening Searcher@3f0516d3[collection1] main [junit4] 2> 831393 T5256 c:collection1 C1564 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 831393 T5260 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3f0516d3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):c1)))} [junit4] 2> 831393 T5256 c:collection1 C1564 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 8 [junit4] 2> 831405 T5269 c:collection1 C1565 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[1 (1497867417759514624)]} 0 2 [junit4] 2> 831412 T5266 c:collection1 C1565 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 831418 T5266 c:collection1 C1565 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@353b55f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25c2347b),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@353b55f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25c2347b),segFN=segments_2,generation=2} [junit4] 2> 831420 T5266 c:collection1 C1565 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 831421 T5266 c:collection1 C1565 oass.SolrIndexSearcher.<init> Opening Searcher@155118ad[collection1] main [junit4] 2> 831421 T5266 c:collection1 C1565 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 831422 T5272 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@155118ad[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):c1)))} [junit4] 2> 831423 T5266 c:collection1 C1565 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 11 [junit4] 2> 831544 T5267 c:collection1 C1565 oasc.SolrCore.execute [collection1] webapp=/n_r/s path=/select params={group.distributed.first=true&distrib=false&hl=false&group.limit=2&fl=id,score&shards.purpose=2048&start=0&shard.url=https://127.0.0.1:56791/n_r/s/collection1&rows=10&version=2&q=id_s1:1&NOW=1428477685724&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1&group=true} status=0 QTime=1 [junit4] 2> 831583 T5255 c:collection1 C1564 oasc.SolrCore.execute [collection1] webapp=/n_r/s path=/select params={group.distributed.first=true&distrib=false&hl=false&group.limit=2&fl=id,score&shards.purpose=2048&start=0&shard.url=https://127.0.0.1:56788/n_r/s/collection1&rows=10&version=2&q=id_s1:1&NOW=1428477685724&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1&group=true} status=0 QTime=0 [junit4] 2> 831597 T5256 c:collection1 C1564 oasc.SolrCore.execute [collection1] webapp=/n_r/s path=/select params={group.topgroups.id_s1=1&distrib=false&hl=false&group.limit=2&fl=id,score&shards.purpose=4&start=0&shard.url=https://127.0.0.1:56788/n_r/s/collection1&rows=10&version=2&group.distributed.second=true&q=id_s1:1&NOW=1428477685724&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1&group=true} status=0 QTime=2 [junit4] 2> 831597 T5269 c:collection1 C1565 oasc.SolrCore.execute [collection1] webapp=/n_r/s path=/select params={group.topgroups.id_s1=1&distrib=false&hl=false&group.limit=2&fl=id,score&shards.purpose=4&start=0&shard.url=https://127.0.0.1:56791/n_r/s/collection1&rows=10&version=2&group.distributed.second=true&q=id_s1:1&NOW=1428477685724&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1&group=true} status=0 QTime=1 [junit4] 2> 831606 T5253 c:collection1 C1564 oasc.SolrCore.execute [collection1] webapp=/n_r/s path=/select params={distrib=false&hl=true&group.limit=2&shards.purpose=192&shard.url=https://127.0.0.1:56788/n_r/s/collection1&version=2&q=id_s1:1&NOW=1428477685724&ids=1&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1} status=0 QTime=1 [junit4] 2> ASYNC NEW_CORE C1567 name=collection1 org.apache.solr.core.SolrCore@f515da2 [junit4] 2> 831627 T5266 c:collection1 C1567 oasc.SolrCore.execute [collection1] webapp=/n_r/s path=/select params={distrib=false&hl=true&group.limit=2&shards.purpose=192&shard.url=https://127.0.0.1:56791/n_r/s/collection1&version=2&q=id_s1:1&NOW=1428477685724&ids=1&isShard=true&hl.fl=id_s1&wt=javabin&group.field=id_s1} status=0 QTime=22 [junit4] 2> 831634 T5270 c:collection1 C1567 oasc.SolrCore.execute [collection1] webapp=/n_r/s path=/select params={q=id_s1:1&shards=https://127.0.0.1:56788/n_r/s/collection1,https://127.0.0.1:56791/n_r/s/collection1&hl=true&group.limit=2&hl.fl=id_s1&wt=javabin&version=2&group.field=id_s1&group=true} status=0 QTime=205 [junit4] 2> ASYNC NEW_CORE C1568 name=collection1 org.apache.solr.core.SolrCore@5ee24068 [junit4] 2> 831643 T5241 c:collection1 C1568 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1497867418004881408)} 0 6 [junit4] 2> ASYNC NEW_CORE C1569 name=collection1 org.apache.solr.core.SolrCore@6b70635b [junit4] 2> 831659 T5257 c:collection1 C1569 oass.SolrIndexSearcher.<init> Opening Searcher@5412b653[collection1] realtime [junit4] 2> 831659 T5257 c:collection1 C1569 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1497867418021658624)} 0 5 [junit4] 2> 831669 T5267 c:collection1 C1567 oass.SolrIndexSearcher.<init> Opening Searcher@71538177[collection1] realtime [junit4] 2> 831669 T5267 c:collection1 C1567 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1497867418032144384)} 0 5 [junit4] 2> 831674 T5246 c:collection1 C1568 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 831676 T5246 c:collection1 C1568 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit. [junit4] 2> 831677 T5246 c:collection1 C1568 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 831677 T5246 c:collection1 C1568 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 831677 T5246 c:collection1 C1568 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 3 [junit4] 2> 831680 T5254 c:collection1 C1569 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 831681 T5254 c:collection1 C1569 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e3b0a95 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a45be),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e3b0a95 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a45be),segFN=segments_3,generation=3} [junit4] 2> 831681 T5254 c:collection1 C1569 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 831681 T5254 c:collection1 C1569 oass.SolrIndexSearcher.<init> Opening Searcher@192252b1[collection1] main [junit4] 2> 831682 T5254 c:collection1 C1569 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 831683 T5260 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@192252b1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 831683 T5254 c:collection1 C1569 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 3 [junit4] 2> 831687 T5265 c:collection1 C1567 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 831687 T5265 c:collection1 C1567 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@353b55f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25c2347b),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@353b55f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25c2347b),segFN=segments_3,generation=3} [junit4] 2> 831687 T5265 c:collection1 C1567 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 831688 T5265 c:collection1 C1567 oass.SolrIndexSearcher.<init> Opening Searcher@6b6b87e7[collection1] main [junit4] 2> 831688 T5265 c:collection1 C1567 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 831689 T5272 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6b6b87e7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 831689 T5265 c:collection1 C1567 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2 [junit4] 2> 831700 T5258 c:collection1 C1569 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[0 (1497867418063601664)]} 0 6 [junit4] 2> 831702 T5255 c:collection1 C1569 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[1 (1497867418071990272)]} 0 0 [junit4] 2> 831708 T5269 c:collection1 C1567 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[1 (1497867418076184576)]} 0 2 [junit4] 2> 831711 T5256 c:collection1 C1569 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[2 (1497867418081427456)]} 0 0 [junit4] 2> 831715 T5253 c:collection1 C1569 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[3 (1497867418085621760)]} 0 0 [junit4] 2> 831718 T5266 c:collection1 C1567 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[4 (1497867418088767488)]} 0 0 [junit4] 2> 831721 T5257 c:collection1 C1569 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[5 (1497867418091913216)]} 0 0 [junit4] 2> 831727 T5254 c:collection1 C1569 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[6 (1497867418098204672)]} 0 0 [junit4] 2> 831730 T5270 c:collection1 C1567 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[7 (1497867418101350400)]} 0 0 [junit4] 2> 925005 T5237 oas.SolrTestCaseJ4.tearDown ###Ending test [junit4] 2> 925008 T5266 c:collection1 C1567 oasup.LogUpdateProcessor.finish [collection1] webapp=/n_r/s path=/update params={wt=javabin&version=2} {add=[8 (1497867515910422528)]} 0 1 [junit4] 2> 925019 T5237 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1499400499 [junit4] 2> 925023 T5237 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5ee24068 [junit4] 2> 925025 T5237 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=0,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0,transaction_logs_total_size=134,transaction_logs_total_number=2} [junit4] 2> 925028 T5237 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 925029 T5237 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 925029 T5237 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 925030 T5237 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 925060 T5237 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 925061 T5237 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\index;done=false>>] [junit4] 2> 925061 T5237 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\index [junit4] 2> 925065 T5237 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\;done=false>>] [junit4] 2> 925066 T5237 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\control\cores\collection1\data\ [junit4] 2> 925067 T5237 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/n_r/s,null} [junit4] 2> 925287 T5237 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1919027628 [junit4] 2> 925294 T5237 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6b70635b [junit4] 2> 925297 T5237 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=6,adds=6,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=7,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0,transaction_logs_total_size=264,transaction_logs_total_number=3} [junit4] 2> 925297 T5237 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 925298 T5237 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 925298 T5237 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> ASYNC NEW_CORE C1570 name=collection1 org.apache.solr.core.SolrCore@6b70635b [junit4] 2> 925298 T5237 C1570 oasu.DirectUpdateHandler2.closeWriter Committing on IndexWriter close. [junit4] 2> 925302 T5237 C1570 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e3b0a95 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a45be),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1e3b0a95 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4a45be),segFN=segments_4,generation=4} [junit4] 2> 925302 T5237 C1570 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4 [junit4] 2> 925304 T5237 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 925342 T5237 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 925343 T5237 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\index;done=false>>] [junit4] 2> 925343 T5237 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\index [junit4] 2> 925344 T5237 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-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\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\;done=false>>] [junit4] 2> 925344 T5237 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard0\cores\collection1\data\ [junit4] 2> 925345 T5237 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/n_r/s,null} [junit4] 2> 925541 T5237 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1965371992 [junit4] 2> 925541 T5237 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@f515da2 [junit4] 2> 925541 T5237 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=4,adds=4,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0,transaction_logs_total_size=264,transaction_logs_total_number=3} [junit4] 2> 925542 T5237 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 925542 T5237 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 925542 T5237 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> ASYNC NEW_CORE C1571 name=collection1 org.apache.solr.core.SolrCore@f515da2 [junit4] 2> 925542 T5237 C1571 oasu.DirectUpdateHandler2.closeWriter Committing on IndexWriter close. [junit4] 2> 925551 T5237 C1571 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@353b55f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25c2347b),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@353b55f2 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@25c2347b),segFN=segments_4,generation=4} [junit4] 2> 925552 T5237 C1571 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4 [junit4] 2> 925553 T5237 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 925597 T5237 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 925598 T5237 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\;done=false>>] [junit4] 2> 925598 T5237 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\ [junit4] 2> 925598 T5237 oasc.CachingDirectoryFactory.closeCac [...truncated too long message...] lection1\data\index;done=false>>] [junit4] 2> 925598 T5237 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001\tempDir-001\shard1\cores\collection1\data\index [junit4] 2> 925599 T5237 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/n_r/s,null} [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestHighlightDedupGrouping -Dtests.method=test -Dtests.seed=891A7A857EFF9899 -Dtests.slow=true -Dtests.locale=sr_CS -Dtests.timezone=Etc/GMT0 -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 96.6s J1 | TestHighlightDedupGrouping.test <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:56791/n_r/s/collection1 [junit4] > at __randomizedtesting.SeedInfo.seed([891A7A857EFF9899:14E455FD003F561]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:568) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:233) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:225) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) [junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:174) [junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:139) [junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:153) [junit4] > at org.apache.solr.TestHighlightDedupGrouping.addDoc(TestHighlightDedupGrouping.java:122) [junit4] > at org.apache.solr.TestHighlightDedupGrouping.randomizedTest(TestHighlightDedupGrouping.java:96) [junit4] > at org.apache.solr.TestHighlightDedupGrouping.test(TestHighlightDedupGrouping.java:42) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:960) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:935) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > Caused by: java.net.SocketTimeoutException: Read timed out [junit4] > at java.net.SocketInputStream.socketRead0(Native Method) [junit4] > at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:170) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:141) [junit4] > at sun.security.ssl.InputRecord.readFully(InputRecord.java:465) [junit4] > at sun.security.ssl.InputRecord.read(InputRecord.java:503) [junit4] > at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:961) [junit4] > at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:918) [junit4] > at sun.security.ssl.AppInputStream.read(AppInputStream.java:105) [junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) [junit4] > at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) [junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) [junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) [junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) [junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) [junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) [junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:462) [junit4] > ... 50 more [junit4] 2> 925766 T5237 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J1\temp\solr.TestHighlightDedupGrouping 891A7A857EFF9899-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {shard_i1=FSTOrd50, id_s1=PostingsFormat(name=LuceneFixedGap), _version_=PostingsFormat(name=Memory doPackFST= false), multiDefault=PostingsFormat(name=LuceneFixedGap), intDefault=PostingsFormat(name=Memory doPackFST= false), id=PostingsFormat(name=LuceneVarGapFixedInterval), group_ti1=PostingsFormat(name=LuceneFixedGap), range_facet_l=PostingsFormat(name=LuceneFixedGap), timestamp=PostingsFormat(name=LuceneFixedGap)}, docValues:{timestamp=DocValuesFormat(name=Asserting)}, sim=DefaultSimilarity, locale=sr_CS, timezone=Etc/GMT0 [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_40 (64-bit)/cpus=3,threads=1,free=105067488,total=184336384 [junit4] 2> NOTE: All tests run in this JVM: [RegexBoostProcessorTest, HdfsBasicDistributedZk2Test, SpellCheckComponentTest, TestFieldResource, TestRecovery, TestDistributedGrouping, TermVectorComponentDistributedTest, TestPivotHelperCode, TestDocSet, DocExpirationUpdateProcessorFactoryTest, TestManagedResource, SolrCmdDistributorTest, ResourceLoaderTest, ShardRoutingCustomTest, TestReversedWildcardFilterFactory, UpdateRequestProcessorFactoryTest, QueryResultKeyTest, DisMaxRequestHandlerTest, MoreLikeThisHandlerTest, TestFileDictionaryLookup, TestSolrQueryParserResource, TestQuerySenderNoQuery, TestRemoteStreaming, SearchHandlerTest, TestHashQParserPlugin, TestTolerantSearch, AnalyticsMergeStrategyTest, TestNamedUpdateProcessors, TermVectorComponentTest, ZkNodePropsTest, ActionThrottleTest, LeaderElectionIntegrationTest, DateFieldTest, QueryEqualityTest, TestLMJelinekMercerSimilarityFactory, BasicZkTest, TestRestoreCore, TestReplicaProperties, ZkSolrClientTest, SpatialHeatmapFacetsTest, TestMissingGroups, BufferStoreTest, ConvertedLegacyTest, TestRTGBase, TestFiltering, DirectUpdateHandlerOptimizeTest, TestNRTOpen, TestSolrXml, TestShortCircuitedRequests, CurrencyFieldOpenExchangeTest, HighlighterTest, TestDFRSimilarityFactory, RequestLoggingTest, TestSolr4Spatial2, SaslZkACLProviderTest, TestManagedSchemaDynamicFieldResource, TestManagedSchemaFieldResource, TestLMDirichletSimilarityFactory, TestCodecSupport, ExternalFileFieldSortTest, DocValuesMissingTest, PolyFieldTest, FullSolrCloudDistribCmdsTest, TestMiniSolrCloudCluster, CollectionsAPIDistributedZkTest, TestPseudoReturnFields, BlockCacheTest, IndexSchemaTest, TestSolr4Spatial, UpdateParamsTest, TestDynamicLoading, OverseerStatusTest, DistributedQueryComponentCustomSortTest, TestRecoveryHdfs, TestNoOpRegenerator, DocumentBuilderTest, TestSolrDeletionPolicy2, SuggesterTSTTest, SimplePostToolTest, DeleteInactiveReplicaTest, TestSearchPerf, QueryParsingTest, XsltUpdateRequestHandlerTest, ReplicationFactorTest, AliasIntegrationTest, CopyFieldTest, TestSuggestSpellingConverter, TestManagedSynonymFilterFactory, TestHighlightDedupGrouping] [junit4] Completed on J1 in 96.67s, 1 test, 1 error <<< FAILURES! [...truncated 975 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:529: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:477: 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:191: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:509: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1370: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:976: There were test failures: 480 suites, 1905 tests, 1 error, 57 ignored (30 assumptions) Total time: 63 minutes 52 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 64bit/jdk1.8.0_40 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
