Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.x-Java7/2968/
1 tests failed. REGRESSION: org.apache.solr.handler.component.DistributedMLTComponentTest.test Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:10961//collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:10961//collection1 at __randomizedtesting.SeedInfo.seed([70257D9BA4FAA1EF:F87142410A06CC17]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:570) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958) at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:558) at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:606) at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:588) at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:567) at org.apache.solr.handler.component.DistributedMLTComponentTest.test(DistributedMLTComponentTest.java:126) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$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:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.read(SocketInputStream.java:152) at java.net.SocketInputStream.read(SocketInputStream.java:122) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:466) ... 51 more Build Log: [...truncated 10400 lines...] [junit4] Suite: org.apache.solr.handler.component.DistributedMLTComponentTest [junit4] 2> Creating dataDir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/init-core-data-001 [junit4] 2> 1812520 T6418 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false) [junit4] 2> 1812520 T6418 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: / [junit4] 2> 1813905 T6418 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1 [junit4] 2> 1813908 T6418 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1813913 T6418 oejs.AbstractConnector.doStart Started [email protected]:10949 [junit4] 2> 1813913 T6418 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores, hostContext=/, hostPort=10949} [junit4] 2> 1813913 T6418 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@17072b90 [junit4] 2> 1813914 T6418 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/' [junit4] 2> 1813966 T6418 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/solr.xml [junit4] 2> 1814031 T6418 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores [junit4] 2> 1814032 T6418 oasc.CoreContainer.<init> New CoreContainer 1244923054 [junit4] 2> 1814032 T6418 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/] [junit4] 2> 1814032 T6418 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/lib [junit4] 2> 1814033 T6418 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/lib). [junit4] 2> 1814043 T6418 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1814052 T6418 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1814053 T6418 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1814053 T6418 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1814053 T6418 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 1814055 T6418 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores [junit4] 2> 1814057 T6418 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {dataDir=data/, config=solrconfig.xml, name=collection1, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1/, transient=false, loadOnStartup=true, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1, schema=schema.xml, configSet=collection1} [junit4] 2> 1814057 T6418 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1/ [junit4] 2> 1814058 T6418 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1814058 T6428 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1814060 T6428 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1814060 T6428 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1814061 T6428 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 1814110 T6428 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1814136 T6428 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 1814194 T6428 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1814195 T6428 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1814203 T6428 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1814564 T6428 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1814576 T6428 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1814578 T6428 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1814585 T6428 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1814588 T6428 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1814591 T6428 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1814591 T6428 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1814592 T6428 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1814592 T6428 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1814592 T6428 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1814592 T6428 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1814593 T6428 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1 [junit4] 2> 1814593 T6428 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1814593 T6428 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1/data/ [junit4] 2> 1814593 T6428 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3673453f [junit4] 2> 1814594 T6428 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1/data [junit4] 2> 1814594 T6428 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1/data/index/ [junit4] 2> 1814594 T6428 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1814594 T6428 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/control/cores/collection1/data/index [junit4] 2> 1814595 T6428 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=31.580078125, floorSegmentMB=0.37890625, forceMergeDeletesPctAllowed=1.0443926582469687, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5401628480397264 [junit4] 2> 1814595 T6428 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@142c9590 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7b0f2b48),segFN=segments_1,generation=1} [junit4] 2> 1814596 T6428 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1814600 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 1814600 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1814601 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1814601 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1814601 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1814601 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1814601 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1814602 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1814602 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1814602 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1814602 T6428 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1814602 T6428 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1814616 T6428 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1814618 T6428 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1814619 T6428 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1814621 T6428 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1814625 T6428 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1814627 T6428 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: spellCheckWithWordbreak,/get,defaults,/admin/luke,mltrh,/admin/threads,/schema,/update/csv,/search-facet-def,/update,spellCheckCompRH1,spellCheckCompRH_Direct,/admin/system,/admin/properties,lazy,spellCheckCompRH,/admin/segments,mock,/admin/plugins,/search-facet-invariants,/admin/mbeans,/admin/file,dismax,/debug/dump,/admin/ping,/update/json,/replication,/terms,/config,/update/json/docs,standard,tvrh,/admin/logging,/mlt,spellCheckWithWordbreak_Direct [junit4] 2> 1814628 T6428 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1814629 T6428 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1814631 T6428 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1814631 T6428 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 1814632 T6428 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1814632 T6428 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1814633 T6428 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=64.955078125, floorSegmentMB=0.873046875, forceMergeDeletesPctAllowed=21.378166179464465, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1814633 T6428 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@142c9590 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7b0f2b48),segFN=segments_1,generation=1} [junit4] 2> 1814633 T6428 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1814634 T6428 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@4c80599d[collection1] main [junit4] 2> 1814634 T6428 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1814634 T6428 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1814634 T6428 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1814634 T6428 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 1814658 T6428 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1814708 T6428 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1814709 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 1814710 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 1814710 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 1814710 T6428 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1814710 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 1814710 T6418 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3 [junit4] 2> 1814710 T6418 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1814711 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 1814711 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 1814712 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 1814713 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 1814713 T6429 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 1814714 T6429 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4c80599d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1816301 T6418 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 1816304 T6418 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1816306 T6418 oejs.AbstractConnector.doStart Started [email protected]:10958 [junit4] 2> 1816306 T6418 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores, hostContext=/, hostPort=10958} [junit4] 2> 1816307 T6418 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@17072b90 [junit4] 2> 1816307 T6418 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/' [junit4] 2> 1816352 T6418 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/solr.xml [junit4] 2> 1816404 T6418 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores [junit4] 2> 1816404 T6418 oasc.CoreContainer.<init> New CoreContainer 345238389 [junit4] 2> 1816404 T6418 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/] [junit4] 2> 1816405 T6418 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/lib [junit4] 2> 1816406 T6418 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/lib). [junit4] 2> 1816415 T6418 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1816421 T6418 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1816422 T6418 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1816422 T6418 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1816422 T6418 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 1816423 T6418 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores [junit4] 2> 1816425 T6418 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {config=solrconfig.xml, configSet=collection1, schema=schema.xml, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1, name=collection1, dataDir=data/, transient=false, loadOnStartup=true, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1/} [junit4] 2> 1816425 T6418 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1/ [junit4] 2> 1816426 T6418 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1816426 T6440 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1816428 T6440 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1816428 T6440 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1816429 T6440 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 1816470 T6440 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1816492 T6440 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 1816544 T6440 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1816545 T6440 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1816552 T6440 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1816847 T6440 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1816859 T6440 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1816861 T6440 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1816868 T6440 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1816872 T6440 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1816874 T6440 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1816875 T6440 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1816875 T6440 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1816875 T6440 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1816876 T6440 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1816876 T6440 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1816876 T6440 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1 [junit4] 2> 1816876 T6440 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1816877 T6440 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1/data/ [junit4] 2> 1816877 T6440 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3673453f [junit4] 2> 1816878 T6440 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1/data [junit4] 2> 1816878 T6440 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1/data/index/ [junit4] 2> 1816878 T6440 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1816878 T6440 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard0/cores/collection1/data/index [junit4] 2> 1816879 T6440 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=31.580078125, floorSegmentMB=0.37890625, forceMergeDeletesPctAllowed=1.0443926582469687, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5401628480397264 [junit4] 2> 1816879 T6440 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@575b3b06 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@268033b8),segFN=segments_1,generation=1} [junit4] 2> 1816879 T6440 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1816885 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 1816885 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1816885 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1816886 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1816886 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1816886 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1816886 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1816886 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1816887 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1816887 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1816887 T6440 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1816887 T6440 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1816902 T6440 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1816903 T6440 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1816905 T6440 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1816906 T6440 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1816912 T6440 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1816915 T6440 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: spellCheckWithWordbreak,/get,defaults,/admin/luke,mltrh,/admin/threads,/schema,/update/csv,/search-facet-def,/update,spellCheckCompRH1,spellCheckCompRH_Direct,/admin/system,/admin/properties,lazy,spellCheckCompRH,/admin/segments,mock,/admin/plugins,/search-facet-invariants,/admin/mbeans,/admin/file,dismax,/debug/dump,/admin/ping,/update/json,/replication,/terms,/config,/update/json/docs,standard,tvrh,/admin/logging,/mlt,spellCheckWithWordbreak_Direct [junit4] 2> 1816916 T6440 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1816917 T6440 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1816919 T6440 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1816919 T6440 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 1816921 T6440 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1816921 T6440 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1816922 T6440 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=64.955078125, floorSegmentMB=0.873046875, forceMergeDeletesPctAllowed=21.378166179464465, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1816923 T6440 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@575b3b06 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@268033b8),segFN=segments_1,generation=1} [junit4] 2> 1816923 T6440 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1816923 T6440 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@23733fe3[collection1] main [junit4] 2> 1816924 T6440 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1816924 T6440 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1816924 T6440 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1816924 T6440 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 1816952 T6440 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1817023 T6440 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1817023 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 1817024 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 1817025 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 1817025 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 1817025 T6440 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1817025 T6418 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3 [junit4] 2> 1817025 T6418 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1817025 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 1817026 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 1817027 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 1817028 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 1817028 T6441 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 1817030 T6441 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@23733fe3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1818755 T6418 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1 [junit4] 2> 1818758 T6418 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1818761 T6418 oejs.AbstractConnector.doStart Started [email protected]:10961 [junit4] 2> 1818761 T6418 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores, hostPort=10961, hostContext=/} [junit4] 2> 1818762 T6418 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@17072b90 [junit4] 2> 1818762 T6418 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/' [junit4] 2> 1818812 T6418 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/solr.xml [junit4] 2> 1818883 T6418 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores [junit4] 2> 1818884 T6418 oasc.CoreContainer.<init> New CoreContainer 650799026 [junit4] 2> 1818884 T6418 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/] [junit4] 2> 1818884 T6418 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/lib [junit4] 2> 1818885 T6418 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/lib). [junit4] 2> 1818895 T6418 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1818904 T6418 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1818905 T6418 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1818905 T6418 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1818906 T6418 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 1818907 T6418 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores [junit4] 2> 1818909 T6418 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {config=solrconfig.xml, transient=false, schema=schema.xml, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1/, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1, name=collection1, dataDir=data/, loadOnStartup=true, configSet=collection1} [junit4] 2> 1818909 T6418 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1/ [junit4] 2> 1818909 T6418 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1818910 T6452 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1818912 T6452 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1818913 T6452 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1818913 T6452 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 1818962 T6452 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1818987 T6452 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 1819051 T6452 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1819052 T6452 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1819061 T6452 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1819369 T6452 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1819383 T6452 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1819385 T6452 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1819393 T6452 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1819397 T6452 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1819400 T6452 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1819400 T6452 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1819401 T6452 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1819401 T6452 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1819401 T6452 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1819401 T6452 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1819402 T6452 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1 [junit4] 2> 1819402 T6452 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1819402 T6452 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1/data/ [junit4] 2> 1819402 T6452 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3673453f [junit4] 2> 1819404 T6452 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1/data [junit4] 2> 1819404 T6452 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1/data/index/ [junit4] 2> 1819404 T6452 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1819404 T6452 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard1/cores/collection1/data/index [junit4] 2> 1819405 T6452 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=31.580078125, floorSegmentMB=0.37890625, forceMergeDeletesPctAllowed=1.0443926582469687, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5401628480397264 [junit4] 2> 1819405 T6452 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2cb370ee lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@38bb302f),segFN=segments_1,generation=1} [junit4] 2> 1819405 T6452 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1819411 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 1819411 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1819411 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1819411 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1819412 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1819412 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1819412 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1819412 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1819412 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1819413 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1819413 T6452 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1819413 T6452 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1819433 T6452 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1819436 T6452 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1819438 T6452 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1819439 T6452 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1819445 T6452 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1819448 T6452 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: spellCheckWithWordbreak,/get,defaults,/admin/luke,mltrh,/admin/threads,/schema,/update/csv,/search-facet-def,/update,spellCheckCompRH1,spellCheckCompRH_Direct,/admin/system,/admin/properties,lazy,spellCheckCompRH,/admin/segments,mock,/admin/plugins,/search-facet-invariants,/admin/mbeans,/admin/file,dismax,/debug/dump,/admin/ping,/update/json,/replication,/terms,/config,/update/json/docs,standard,tvrh,/admin/logging,/mlt,spellCheckWithWordbreak_Direct [junit4] 2> 1819449 T6452 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1819451 T6452 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1819453 T6452 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1819453 T6452 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 1819454 T6452 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1819454 T6452 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1819456 T6452 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=64.955078125, floorSegmentMB=0.873046875, forceMergeDeletesPctAllowed=21.378166179464465, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1819457 T6452 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2cb370ee lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@38bb302f),segFN=segments_1,generation=1} [junit4] 2> 1819457 T6452 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1819457 T6452 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@3405f998[collection1] main [junit4] 2> 1819457 T6452 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1819458 T6452 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1819458 T6452 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1819458 T6452 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 1819478 T6452 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1819535 T6452 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1819535 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 1819536 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 1819536 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 1819536 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 1819537 T6452 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1819537 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 1819537 T6418 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3 [junit4] 2> 1819537 T6418 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1819538 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 1819538 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 1819539 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 1819539 T6453 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 1819541 T6453 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3405f998[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1821049 T6418 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1 [junit4] 2> 1821051 T6418 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1821055 T6418 oejs.AbstractConnector.doStart Started [email protected]:10966 [junit4] 2> 1821055 T6418 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostPort=10966, hostContext=/, coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores} [junit4] 2> 1821055 T6418 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@17072b90 [junit4] 2> 1821056 T6418 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/' [junit4] 2> 1821095 T6418 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/solr.xml [junit4] 2> 1821143 T6418 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores [junit4] 2> 1821143 T6418 oasc.CoreContainer.<init> New CoreContainer 1561449548 [junit4] 2> 1821143 T6418 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/] [junit4] 2> 1821144 T6418 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/lib [junit4] 2> 1821144 T6418 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/lib). [junit4] 2> 1821154 T6418 oashc.HttpShardHandlerFactory.init created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1821162 T6418 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1821164 T6418 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1821164 T6418 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1821164 T6418 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 1821166 T6418 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores [junit4] 2> 1821168 T6418 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/, configSet=collection1, transient=false, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1, name=collection1, schema=schema.xml, config=solrconfig.xml, dataDir=data/, loadOnStartup=true} [junit4] 2> 1821169 T6418 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/ [junit4] 2> 1821169 T6418 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1821170 T6464 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/' [junit4] 2> 1821172 T6464 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1821172 T6464 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1821173 T6464 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 1821234 T6464 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1821257 T6464 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 1821311 T6464 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1821312 T6464 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/conf/schema.xml [junit4] 2> 1821320 T6464 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1821658 T6464 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1821673 T6464 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1821676 T6464 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1821686 T6464 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1821690 T6464 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1821693 T6464 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1821693 T6464 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1821694 T6464 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1821694 T6464 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1821694 T6464 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 1821694 T6464 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 1821695 T6464 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from configset /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1 [junit4] 2> 1821695 T6464 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1821695 T6464 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/core/src/test-files/solr/collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/data/ [junit4] 2> 1821695 T6464 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3673453f [junit4] 2> 1821696 T6464 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/data [junit4] 2> 1821696 T6464 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/data/index/ [junit4] 2> 1821696 T6464 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1821697 T6464 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/data/index [junit4] 2> 1821697 T6464 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=38, maxMergedSegmentMB=31.580078125, floorSegmentMB=0.37890625, forceMergeDeletesPctAllowed=1.0443926582469687, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5401628480397264 [junit4] 2> 1821698 T6464 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448b4fb9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@161f1dd7),segFN=segments_1,generation=1} [junit4] 2> 1821698 T6464 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1821703 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 1821703 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1821704 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1821704 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1821704 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1821704 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1821704 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1821705 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1821705 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1821705 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1821705 T6464 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1821705 T6464 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1821724 T6464 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1821726 T6464 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1821728 T6464 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1821729 T6464 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1821735 T6464 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1821738 T6464 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: spellCheckWithWordbreak,/get,defaults,/admin/luke,mltrh,/admin/threads,/schema,/update/csv,/search-facet-def,/update,spellCheckCompRH1,spellCheckCompRH_Direct,/admin/system,/admin/properties,lazy,spellCheckCompRH,/admin/segments,mock,/admin/plugins,/search-facet-invariants,/admin/mbeans,/admin/file,dismax,/debug/dump,/admin/ping,/update/json,/replication,/terms,/config,/update/json/docs,standard,tvrh,/admin/logging,/mlt,spellCheckWithWordbreak_Direct [junit4] 2> 1821739 T6464 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1821740 T6464 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1821742 T6464 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1821742 T6464 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 1821744 T6464 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1821744 T6464 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1821745 T6464 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=64.955078125, floorSegmentMB=0.873046875, forceMergeDeletesPctAllowed=21.378166179464465, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1821746 T6464 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@448b4fb9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@161f1dd7),segFN=segments_1,generation=1} [junit4] 2> 1821746 T6464 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1821746 T6464 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@6874a29a[collection1] main [junit4] 2> 1821747 T6464 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1821747 T6464 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1821747 T6464 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1821747 T6464 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 1821757 T6464 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1821808 T6464 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1821808 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 1821809 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 1821809 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 1821809 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 1821809 T6464 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1821810 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 1821810 T6418 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3 [junit4] 2> 1821810 T6418 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1821810 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 1821811 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 1821812 T6418 oas.SolrTestCaseJ4.setUp ###Starting test [junit4] 2> 1821812 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 1821813 T6465 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 1821815 T6465 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6874a29a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> ASYNC NEW_CORE C2714 name=collection1 org.apache.solr.core.SolrCore@55671f88 [junit4] 2> 1821817 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1498778541867663360)} 0 3 [junit4] 2> ASYNC NEW_CORE C2715 name=collection1 org.apache.solr.core.SolrCore@1c14e345 [junit4] 2> 1821821 T6434 c:collection1 C2715 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1498778541872906240)} 0 2 [junit4] 2> ASYNC NEW_CORE C2716 name=collection1 org.apache.solr.core.SolrCore@60b14fb1 [junit4] 2> 1821826 T6448 c:collection1 C2716 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1498778541878149120)} 0 3 [junit4] 2> ASYNC NEW_CORE C2717 name=collection1 org.apache.solr.core.SolrCore@5dc82550 [junit4] 2> 1821830 T6460 c:collection1 C2717 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1498778541882343424)} 0 2 [junit4] 2> 1821834 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1 (1498778541887586304)]} 0 1 [junit4] 2> 1821838 T6434 c:collection1 C2715 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1 (1498778541891780608)]} 0 1 [junit4] 2> 1821840 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2 (1498778541894926336)]} 0 0 [junit4] 2> 1821844 T6448 c:collection1 C2716 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2 (1498778541898072064)]} 0 1 [junit4] 2> 1821847 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3 (1498778541902266368)]} 0 0 [junit4] 2> 1821851 T6460 c:collection1 C2717 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3 (1498778541905412096)]} 0 1 [junit4] 2> 1821853 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4 (1498778541908557824)]} 0 0 [junit4] 2> 1821856 T6434 c:collection1 C2715 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4 (1498778541911703552)]} 0 0 [junit4] 2> 1821859 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5 (1498778541914849280)]} 0 0 [junit4] 2> 1821862 T6448 c:collection1 C2716 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5 (1498778541917995008)]} 0 0 [junit4] 2> 1821865 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6 (1498778541921140736)]} 0 0 [junit4] 2> 1821868 T6460 c:collection1 C2717 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6 (1498778541924286464)]} 0 0 [junit4] 2> 1821871 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7 (1498778541927432192)]} 0 0 [junit4] 2> 1821874 T6434 c:collection1 C2715 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7 (1498778541930577920)]} 0 0 [junit4] 2> 1821877 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8 (1498778541933723648)]} 0 0 [junit4] 2> 1821880 T6448 c:collection1 C2716 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8 (1498778541936869376)]} 0 0 [junit4] 2> 1821883 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9 (1498778541940015104)]} 0 0 [junit4] 2> 1821886 T6460 c:collection1 C2717 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9 (1498778541943160832)]} 0 0 [junit4] 2> 1821889 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10 (1498778541946306560)]} 0 0 [junit4] 2> 1821892 T6434 c:collection1 C2715 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10 (1498778541949452288)]} 0 0 [junit4] 2> 1821896 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12 (1498778541953646592)]} 0 0 [junit4] 2> 1821899 T6460 c:collection1 C2717 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12 (1498778541956792320)]} 0 0 [junit4] 2> 1821902 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[13 (1498778541959938048)]} 0 0 [junit4] 2> 1821905 T6434 c:collection1 C2715 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[13 (1498778541963083776)]} 0 0 [junit4] 2> 1821908 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14 (1498778541966229504)]} 0 0 [junit4] 2> 1821911 T6448 c:collection1 C2716 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14 (1498778541969375232)]} 0 0 [junit4] 2> 1821915 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15 (1498778541973569536)]} 0 0 [junit4] 2> 1821918 T6460 c:collection1 C2717 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15 (1498778541976715264)]} 0 0 [junit4] 2> 1821921 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16 (1498778541979860992)]} 0 0 [junit4] 2> 1821924 T6434 c:collection1 C2715 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16 (1498778541983006720)]} 0 0 [junit4] 2> 1821929 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17 (1498778541987201024)]} 0 1 [junit4] 2> 1821933 T6448 c:collection1 C2716 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17 (1498778541991395328)]} 0 1 [junit4] 2> 1821935 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[18 (1498778541994541056)]} 0 0 [junit4] 2> 1821938 T6460 c:collection1 C2717 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[18 (1498778541997686784)]} 0 0 [junit4] 2> 1821941 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[19 (1498778542000832512)]} 0 0 [junit4] 2> 1821945 T6434 c:collection1 C2715 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[19 (1498778542003978240)]} 0 1 [junit4] 2> 1821950 T6425 c:collection1 C2714 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params [...truncated too long message...] solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/data/index [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/data/index;done=false>>] [junit4] 2> 1912808 T6418 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001/tempDir-001/shard2/cores/collection1/data/index [junit4] 2> 1912809 T6418 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null} [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistributedMLTComponentTest -Dtests.method=test -Dtests.seed=70257D9BA4FAA1EF -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ar_EG -Dtests.timezone=US/Pacific-New -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 101s J3 | DistributedMLTComponentTest.test <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:10961//collection1 [junit4] > at __randomizedtesting.SeedInfo.seed([70257D9BA4FAA1EF:F87142410A06CC17]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:570) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:943) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:958) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:558) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:606) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:588) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.query(BaseDistributedSearchTestCase.java:567) [junit4] > at org.apache.solr.handler.component.DistributedMLTComponentTest.test(DistributedMLTComponentTest.java:126) [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.read(SocketInputStream.java:152) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:122) [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:466) [junit4] > ... 51 more [junit4] 2> 1913078 T6418 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J3/temp/solr.handler.component.DistributedMLTComponentTest 70257D9BA4FAA1EF-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {lowerfilt1and2=BlockTreeOrds(blocksize=128), timestamp=BlockTreeOrds(blocksize=128), range_facet_l=BlockTreeOrds(blocksize=128), intDefault=PostingsFormat(name=Memory doPackFST= true), lowerfilt1=Lucene50(blocksize=128), multiDefault=BlockTreeOrds(blocksize=128), lowerfilt=BlockTreeOrds(blocksize=128), id=Lucene50(blocksize=128), _version_=PostingsFormat(name=Memory doPackFST= true)}, docValues:{timestamp=DocValuesFormat(name=Asserting)}, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=ar_EG, timezone=US/Pacific-New [junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 (64-bit)/cpus=16,threads=1,free=150262968,total=330825728 [junit4] 2> NOTE: All tests run in this JVM: [SimpleMLTQParserTest, SolrCmdDistributorTest, JSONWriterTest, OverseerStatusTest, CustomCollectionTest, TestManagedSchema, TestJsonRequest, TestFunctionQuery, PrimUtilsTest, DateRangeFieldTest, TestLFUCache, TestSuggestSpellingConverter, TestManagedSynonymFilterFactory, TestExactSharedStatsCache, TestHashPartitioner, DistribDocExpirationUpdateProcessorTest, TestImplicitCoreProperties, DistributedIntervalFacetingTest, OverriddenZkACLAndCredentialsProvidersTest, PreAnalyzedFieldTest, FastVectorHighlighterTest, TestConfigReload, PolyFieldTest, QueryResultKeyTest, TestLMJelinekMercerSimilarityFactory, SimpleCollectionCreateDeleteTest, DeleteLastCustomShardedReplicaTest, EchoParamsTest, BasicDistributedZk2Test, StandardRequestHandlerTest, StatsComponentTest, TestDefaultSimilarityFactory, TestExactStatsCache, TestDistributedMissingSort, TestSchemaSimilarityResource, TestSimpleQParserPlugin, TestBlobHandler, TestCursorMarkWithoutUniqueKey, DirectUpdateHandlerOptimizeTest, AsyncMigrateRouteKeyTest, PingRequestHandlerTest, DirectSolrConnectionTest, ParsingFieldUpdateProcessorsTest, SpellCheckCollatorTest, TestMergePolicyConfig, TestReload, RemoteQueryErrorTest, PathHierarchyTokenizerFactoryTest, DistributedQueueTest, ResponseHeaderTest, TestStressLucene, TestLeaderElectionZkExpiry, TestSolrConfigHandlerConcurrent, TestReversedWildcardFilterFactory, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TermVectorComponentTest, QueryElevationComponentTest, TestSort, UUIDFieldTest, ShardSplitTest, TestCloudSchemaless, DeleteInactiveReplicaTest, TestDynamicLoading, TestRebalanceLeaders, TestReplicaProperties, RollingRestartTest, TriLevelCompositeIdRoutingTest, TestManagedSchemaDynamicFieldResource, TestSolrConfigHandler, DistributedTermsComponentTest, DistributedMLTComponentTest] [junit4] Completed [358/483] on J3 in 100.59s, 1 test, 1 error <<< FAILURES! [...truncated 405 lines...] BUILD FAILED /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:536: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:484: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/build.xml:61: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/extra-targets.xml:39: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build.xml:229: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/common-build.xml:511: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:1434: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/lucene/common-build.xml:991: There were test failures: 483 suites, 1916 tests, 1 error, 64 ignored (23 assumptions) Total time: 52 minutes 38 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Sending artifact delta relative to Lucene-Solr-Tests-5.x-Java7 #2966 Archived 5 artifacts Archive block size is 32768 Received 0 blocks and 228262245 bytes Compression is 0.0% Took 48 sec Recording test results Email was triggered for: Failure Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
