Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.x-Java7/3013/
1 tests failed. FAILED: org.apache.solr.handler.component.DistributedMLTComponentTest.test Error Message: Timeout occured while waiting response from server at: http://127.0.0.1:23259//collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:23259//collection1 at __randomizedtesting.SeedInfo.seed([DA88FC81E91109EA:52DCC35B47ED6412]: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 10451 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/init-core-data-001 [junit4] 2> 2053238 T5342 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false) [junit4] 2> 2053238 T5342 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: / [junit4] 2> 2055040 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores/collection1 [junit4] 2> 2055043 T5342 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2055050 T5342 oejs.AbstractConnector.doStart Started [email protected]:23253 [junit4] 2> 2055051 T5342 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/, hostPort=23253, coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores} [junit4] 2> 2055052 T5342 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@57bd06bf [junit4] 2> 2055052 T5342 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/' [junit4] 2> 2055122 T5342 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/solr.xml [junit4] 2> 2055201 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores [junit4] 2> 2055202 T5342 oasc.CoreContainer.<init> New CoreContainer 708834375 [junit4] 2> 2055202 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/] [junit4] 2> 2055203 T5342 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/lib [junit4] 2> 2055204 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/lib). [junit4] 2> 2055219 T5342 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> 2055229 T5342 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2055231 T5342 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2055231 T5342 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2055231 T5342 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 2055233 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores [junit4] 2> 2055236 T5342 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {config=solrconfig.xml, configSet=collection1, transient=false, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores/collection1, dataDir=data/, name=collection1, schema=schema.xml, loadOnStartup=true, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores/collection1/} [junit4] 2> 2055237 T5342 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores/collection1/ [junit4] 2> 2055238 T5342 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2055240 T5352 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> 2055242 T5352 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> 2055243 T5352 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> 2055243 T5352 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> 2055314 T5352 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 2055349 T5352 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 2055421 T5352 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2055422 T5352 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> 2055433 T5352 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 2055887 T5352 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2055910 T5352 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2055913 T5352 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2055924 T5352 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2055929 T5352 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2055933 T5352 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2055934 T5352 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2055934 T5352 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2055935 T5352 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2055935 T5352 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2055935 T5352 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2055936 T5352 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> 2055936 T5352 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2055936 T5352 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=[null] [junit4] 2> 2055937 T5352 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@779231e1 [junit4] 2> 2055937 T5352 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores/collection1/data [junit4] 2> 2055938 T5352 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores/collection1/data/index/ [junit4] 2> 2055938 T5352 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2055938 T5352 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/control/cores/collection1/data/index [junit4] 2> 2055939 T5352 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=84.0146484375, floorSegmentMB=1.603515625, forceMergeDeletesPctAllowed=15.27791581606442, segmentsPerTier=47.0, maxCFSSegmentSizeMB=2.0361328125, noCFSRatio=0.42091818604911235 [junit4] 2> 2055939 T5352 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4334b982 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3a7f2846),segFN=segments_1,generation=1} [junit4] 2> 2055940 T5352 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2055947 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2055947 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2055947 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2055948 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2055948 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2055948 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2055948 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 2055949 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 2055949 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2055949 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2055950 T5352 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2055950 T5352 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2055972 T5352 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2055974 T5352 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2055976 T5352 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2055981 T5352 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2055987 T5352 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2055990 T5352 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /update/csv,tvrh,mltrh,standard,/admin/system,/update/json,/update,/admin/threads,/schema,/admin/file,spellCheckWithWordbreak_Direct,/admin/luke,spellCheckWithWordbreak,/search-facet-def,/debug/dump,/admin/logging,spellCheckCompRH_Direct,spellCheckCompRH1,dismax,/admin/mbeans,/config,/search-facet-invariants,defaults,mock,/get,lazy,/admin/ping,/admin/plugins,/admin/segments,/admin/properties,spellCheckCompRH,/terms,/mlt,/update/json/docs,/replication [junit4] 2> 2055992 T5352 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 2055994 T5352 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2055996 T5352 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2055996 T5352 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 2055998 T5352 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2055999 T5352 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2055999 T5352 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=33, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6345497941254191] [junit4] 2> 2056000 T5352 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4334b982 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3a7f2846),segFN=segments_1,generation=1} [junit4] 2> 2056000 T5352 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2056001 T5352 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@10ccf13e[collection1] main [junit4] 2> 2056001 T5352 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 2056001 T5352 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 2056001 T5352 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2056002 T5352 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 2056059 T5352 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2056159 T5352 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 2056159 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 2056160 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 2056161 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 2056161 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 2056161 T5352 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 2056161 T5342 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1 [junit4] 2> 2056162 T5342 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2056162 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 2056163 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 2056164 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 2056165 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 2056166 T5353 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 2056168 T5353 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10ccf13e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2058436 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 2058440 T5342 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2058444 T5342 oejs.AbstractConnector.doStart Started [email protected]:23256 [junit4] 2> 2058444 T5342 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores, hostPort=23256, hostContext=/} [junit4] 2> 2058445 T5342 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@57bd06bf [junit4] 2> 2058445 T5342 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/' [junit4] 2> 2058519 T5342 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/solr.xml [junit4] 2> 2058594 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores [junit4] 2> 2058594 T5342 oasc.CoreContainer.<init> New CoreContainer 1959828470 [junit4] 2> 2058595 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/] [junit4] 2> 2058595 T5342 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/lib [junit4] 2> 2058596 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/lib). [junit4] 2> 2058613 T5342 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> 2058626 T5342 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2058627 T5342 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2058628 T5342 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2058628 T5342 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 2058630 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores [junit4] 2> 2058632 T5342 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {schema=schema.xml, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores/collection1, name=collection1, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores/collection1/, configSet=collection1, transient=false, dataDir=data/, loadOnStartup=true, config=solrconfig.xml} [junit4] 2> 2058633 T5342 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores/collection1/ [junit4] 2> 2058633 T5342 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2058635 T5364 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> 2058637 T5364 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> 2058638 T5364 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> 2058639 T5364 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> 2058726 T5364 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 2058771 T5364 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 2058853 T5364 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2058854 T5364 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> 2058866 T5364 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 2059389 T5364 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2059413 T5364 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2059417 T5364 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2059429 T5364 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2059435 T5364 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2059440 T5364 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2059441 T5364 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2059442 T5364 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2059442 T5364 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2059443 T5364 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2059443 T5364 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2059443 T5364 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> 2059444 T5364 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2059444 T5364 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=[null] [junit4] 2> 2059444 T5364 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@779231e1 [junit4] 2> 2059445 T5364 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores/collection1/data [junit4] 2> 2059446 T5364 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores/collection1/data/index/ [junit4] 2> 2059446 T5364 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2059446 T5364 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard0/cores/collection1/data/index [junit4] 2> 2059447 T5364 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=84.0146484375, floorSegmentMB=1.603515625, forceMergeDeletesPctAllowed=15.27791581606442, segmentsPerTier=47.0, maxCFSSegmentSizeMB=2.0361328125, noCFSRatio=0.42091818604911235 [junit4] 2> 2059448 T5364 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2d0522eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2c378964),segFN=segments_1,generation=1} [junit4] 2> 2059448 T5364 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2059456 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2059457 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2059457 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2059457 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2059458 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2059458 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2059458 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 2059459 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 2059459 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2059459 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2059460 T5364 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2059460 T5364 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2059495 T5364 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2059498 T5364 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2059502 T5364 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2059505 T5364 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2059513 T5364 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2059519 T5364 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /update/csv,tvrh,mltrh,standard,/admin/system,/update/json,/update,/admin/threads,/schema,/admin/file,spellCheckWithWordbreak_Direct,/admin/luke,spellCheckWithWordbreak,/search-facet-def,/debug/dump,/admin/logging,spellCheckCompRH_Direct,spellCheckCompRH1,dismax,/admin/mbeans,/config,/search-facet-invariants,defaults,mock,/get,lazy,/admin/ping,/admin/plugins,/admin/segments,/admin/properties,spellCheckCompRH,/terms,/mlt,/update/json/docs,/replication [junit4] 2> 2059521 T5364 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 2059523 T5364 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2059525 T5364 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2059526 T5364 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 2059528 T5364 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2059528 T5364 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2059530 T5364 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=33, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6345497941254191] [junit4] 2> 2059531 T5364 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2d0522eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2c378964),segFN=segments_1,generation=1} [junit4] 2> 2059531 T5364 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2059532 T5364 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@30d33857[collection1] main [junit4] 2> 2059532 T5364 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 2059533 T5364 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 2059533 T5364 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2059533 T5364 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 2059564 T5364 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2059632 T5364 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 2059633 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 2059634 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 2059634 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 2059635 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 2059635 T5364 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 2059636 T5342 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1 [junit4] 2> 2059636 T5342 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2059636 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 2059638 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 2059639 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 2059639 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 2059640 T5365 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 2059642 T5365 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@30d33857[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2061834 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores/collection1 [junit4] 2> 2061838 T5342 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2061841 T5342 oejs.AbstractConnector.doStart Started [email protected]:23259 [junit4] 2> 2061841 T5342 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostPort=23259, coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores, hostContext=/} [junit4] 2> 2061842 T5342 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@57bd06bf [junit4] 2> 2061842 T5342 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/' [junit4] 2> 2061914 T5342 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/solr.xml [junit4] 2> 2061992 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores [junit4] 2> 2061992 T5342 oasc.CoreContainer.<init> New CoreContainer 507149944 [junit4] 2> 2061993 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/] [junit4] 2> 2061993 T5342 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/lib [junit4] 2> 2061995 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/lib). [junit4] 2> 2062015 T5342 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> 2062024 T5342 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2062025 T5342 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2062026 T5342 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2062026 T5342 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 2062028 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores [junit4] 2> 2062031 T5342 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {schema=schema.xml, configSet=collection1, loadOnStartup=true, transient=false, config=solrconfig.xml, dataDir=data/, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores/collection1, name=collection1, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores/collection1/} [junit4] 2> 2062031 T5342 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores/collection1/ [junit4] 2> 2062032 T5342 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2062034 T5376 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> 2062036 T5376 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> 2062037 T5376 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> 2062038 T5376 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> 2062113 T5376 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 2062148 T5376 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 2062225 T5376 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2062226 T5376 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> 2062238 T5376 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 2062706 T5376 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2062729 T5376 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2062733 T5376 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2062745 T5376 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2062752 T5376 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2062758 T5376 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2062759 T5376 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2062759 T5376 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2062759 T5376 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2062760 T5376 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2062760 T5376 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2062761 T5376 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> 2062761 T5376 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2062761 T5376 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=[null] [junit4] 2> 2062762 T5376 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@779231e1 [junit4] 2> 2062763 T5376 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores/collection1/data [junit4] 2> 2062763 T5376 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores/collection1/data/index/ [junit4] 2> 2062763 T5376 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2062764 T5376 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard1/cores/collection1/data/index [junit4] 2> 2062764 T5376 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=84.0146484375, floorSegmentMB=1.603515625, forceMergeDeletesPctAllowed=15.27791581606442, segmentsPerTier=47.0, maxCFSSegmentSizeMB=2.0361328125, noCFSRatio=0.42091818604911235 [junit4] 2> 2062765 T5376 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@74f118eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9b2848),segFN=segments_1,generation=1} [junit4] 2> 2062765 T5376 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2062773 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2062774 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2062774 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2062774 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2062775 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2062775 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2062775 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 2062775 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 2062776 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2062776 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2062777 T5376 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2062777 T5376 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2062812 T5376 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2062816 T5376 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2062819 T5376 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2062822 T5376 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2062830 T5376 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2062834 T5376 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /update/csv,tvrh,mltrh,standard,/admin/system,/update/json,/update,/admin/threads,/schema,/admin/file,spellCheckWithWordbreak_Direct,/admin/luke,spellCheckWithWordbreak,/search-facet-def,/debug/dump,/admin/logging,spellCheckCompRH_Direct,spellCheckCompRH1,dismax,/admin/mbeans,/config,/search-facet-invariants,defaults,mock,/get,lazy,/admin/ping,/admin/plugins,/admin/segments,/admin/properties,spellCheckCompRH,/terms,/mlt,/update/json/docs,/replication [junit4] 2> 2062836 T5376 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 2062838 T5376 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2062841 T5376 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2062841 T5376 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 2062843 T5376 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2062843 T5376 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2062845 T5376 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=33, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6345497941254191] [junit4] 2> 2062846 T5376 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@74f118eb lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@9b2848),segFN=segments_1,generation=1} [junit4] 2> 2062846 T5376 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2062847 T5376 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@57a1be1[collection1] main [junit4] 2> 2062847 T5376 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 2062847 T5376 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 2062848 T5376 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2062848 T5376 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 2062883 T5376 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2062986 T5376 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 2062987 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 2062988 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 2062988 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 2062989 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 2062990 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 2062990 T5376 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 2062991 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 2062991 T5342 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1 [junit4] 2> 2062991 T5342 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2062992 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 2062993 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 2062994 T5377 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 2062996 T5377 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@57a1be1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2065153 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1 [junit4] 2> 2065157 T5342 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 2065161 T5342 oejs.AbstractConnector.doStart Started [email protected]:23267 [junit4] 2> 2065161 T5342 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/, hostPort=23267, coreRootDirectory=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores} [junit4] 2> 2065162 T5342 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@57bd06bf [junit4] 2> 2065162 T5342 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/' [junit4] 2> 2065243 T5342 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/solr.xml [junit4] 2> 2065317 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores [junit4] 2> 2065318 T5342 oasc.CoreContainer.<init> New CoreContainer 1986632351 [junit4] 2> 2065318 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/] [junit4] 2> 2065318 T5342 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/lib [junit4] 2> 2065320 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/lib). [junit4] 2> 2065334 T5342 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> 2065345 T5342 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 2065347 T5342 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 2065347 T5342 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 2065347 T5342 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 2065349 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores [junit4] 2> 2065351 T5342 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1, transient=false, config=solrconfig.xml, configSet=collection1, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1/, schema=schema.xml, loadOnStartup=true, name=collection1, dataDir=data/} [junit4] 2> 2065352 T5342 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1/ [junit4] 2> 2065352 T5342 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 2065354 T5388 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> 2065356 T5388 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> 2065357 T5388 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> 2065357 T5388 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> 2065423 T5388 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 2065458 T5388 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 2065543 T5388 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 2065544 T5388 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> 2065555 T5388 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 2066050 T5388 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 2066073 T5388 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 2066078 T5388 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 2066091 T5388 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2066097 T5388 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 2066103 T5388 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2066105 T5388 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2066105 T5388 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2066105 T5388 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 2066106 T5388 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 2066107 T5388 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 2066107 T5388 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> 2066108 T5388 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 2066108 T5388 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=[null] [junit4] 2> 2066109 T5388 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@779231e1 [junit4] 2> 2066110 T5388 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1/data [junit4] 2> 2066128 T5388 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1/data/index/ [junit4] 2> 2066128 T5388 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 2066129 T5388 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1/data/index [junit4] 2> 2066130 T5388 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=84.0146484375, floorSegmentMB=1.603515625, forceMergeDeletesPctAllowed=15.27791581606442, segmentsPerTier=47.0, maxCFSSegmentSizeMB=2.0361328125, noCFSRatio=0.42091818604911235 [junit4] 2> 2066131 T5388 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1041cd34 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@50071942),segFN=segments_1,generation=1} [junit4] 2> 2066131 T5388 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2066141 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 2066142 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 2066142 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2066143 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 2066143 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 2066143 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 2066144 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 2066144 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 2066145 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 2066145 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2066146 T5388 c:collection1 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 2066146 T5388 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 2066171 T5388 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2066174 T5388 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2066177 T5388 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2066179 T5388 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 2066188 T5388 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 2066194 T5388 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /update/csv,tvrh,mltrh,standard,/admin/system,/update/json,/update,/admin/threads,/schema,/admin/file,spellCheckWithWordbreak_Direct,/admin/luke,spellCheckWithWordbreak,/search-facet-def,/debug/dump,/admin/logging,spellCheckCompRH_Direct,spellCheckCompRH1,dismax,/admin/mbeans,/config,/search-facet-invariants,defaults,mock,/get,lazy,/admin/ping,/admin/plugins,/admin/segments,/admin/properties,spellCheckCompRH,/terms,/mlt,/update/json/docs,/replication [junit4] 2> 2066196 T5388 c:collection1 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 2066197 T5388 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 2066199 T5388 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2066199 T5388 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 2066201 T5388 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 2066201 T5388 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 2066203 T5388 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=33, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6345497941254191] [junit4] 2> 2066204 T5388 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1041cd34 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@50071942),segFN=segments_1,generation=1} [junit4] 2> 2066204 T5388 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 2066205 T5388 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@607d82f4[collection1] main [junit4] 2> 2066205 T5388 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 2066206 T5388 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 2066206 T5388 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 2066206 T5388 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 2066227 T5388 c:collection1 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 2066302 T5388 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 2066302 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 2066303 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: direct [junit4] 2> 2066304 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 2066304 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: multipleFields [junit4] 2> 2066304 T5388 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 2066305 T5342 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1 [junit4] 2> 2066305 T5342 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 2066305 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: jarowinkler [junit4] 2> 2066307 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: external [junit4] 2> 2066307 T5342 oas.SolrTestCaseJ4.setUp ###Starting test [junit4] 2> 2066308 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: freq [junit4] 2> 2066309 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: fqcn [junit4] 2> 2066310 T5389 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: perDict [junit4] 2> 2066313 T5389 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@607d82f4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> ASYNC NEW_CORE C790 name=collection1 org.apache.solr.core.SolrCore@7098e97a [junit4] 2> 2066319 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1499488542629298176)} 0 9 [junit4] 2> ASYNC NEW_CORE C791 name=collection1 org.apache.solr.core.SolrCore@3c80ab51 [junit4] 2> 2066330 T5357 c:collection1 C791 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1499488542641881088)} 0 8 [junit4] 2> ASYNC NEW_CORE C792 name=collection1 org.apache.solr.core.SolrCore@800a545 [junit4] 2> 2066337 T5372 c:collection1 C792 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1499488542653415424)} 0 4 [junit4] 2> ASYNC NEW_CORE C793 name=collection1 org.apache.solr.core.SolrCore@367cfef6 [junit4] 2> 2066343 T5382 c:collection1 C793 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1499488542660755456)} 0 3 [junit4] 2> 2066349 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1 (1499488542668095488)]} 0 2 [junit4] 2> 2066354 T5357 c:collection1 C791 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[1 (1499488542673338368)]} 0 2 [junit4] 2> 2066359 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2 (1499488542679629824)]} 0 1 [junit4] 2> 2066364 T5372 c:collection1 C792 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[2 (1499488542683824128)]} 0 2 [junit4] 2> 2066368 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3 (1499488542689067008)]} 0 1 [junit4] 2> 2066373 T5382 c:collection1 C793 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[3 (1499488542693261312)]} 0 2 [junit4] 2> 2066377 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4 (1499488542698504192)]} 0 1 [junit4] 2> 2066381 T5357 c:collection1 C791 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[4 (1499488542703747072)]} 0 1 [junit4] 2> 2066386 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5 (1499488542707941376)]} 0 1 [junit4] 2> 2066390 T5372 c:collection1 C792 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[5 (1499488542712135680)]} 0 1 [junit4] 2> 2066394 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6 (1499488542716329984)]} 0 1 [junit4] 2> 2066398 T5382 c:collection1 C793 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[6 (1499488542720524288)]} 0 1 [junit4] 2> 2066403 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7 (1499488542724718592)]} 0 2 [junit4] 2> 2066408 T5357 c:collection1 C791 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[7 (1499488542729961472)]} 0 2 [junit4] 2> 2066412 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8 (1499488542735204352)]} 0 1 [junit4] 2> 2066416 T5372 c:collection1 C792 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[8 (1499488542739398656)]} 0 1 [junit4] 2> 2066420 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9 (1499488542743592960)]} 0 1 [junit4] 2> 2066424 T5382 c:collection1 C793 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[9 (1499488542747787264)]} 0 1 [junit4] 2> 2066428 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10 (1499488542751981568)]} 0 1 [junit4] 2> 2066432 T5357 c:collection1 C791 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[10 (1499488542756175872)]} 0 1 [junit4] 2> 2066436 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12 (1499488542760370176)]} 0 1 [junit4] 2> 2066440 T5382 c:collection1 C793 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[12 (1499488542764564480)]} 0 1 [junit4] 2> 2066445 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[13 (1499488542770855936)]} 0 1 [junit4] 2> 2066450 T5357 c:collection1 C791 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[13 (1499488542775050240)]} 0 1 [junit4] 2> 2066455 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14 (1499488542780293120)]} 0 1 [junit4] 2> 2066461 T5372 c:collection1 C792 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[14 (1499488542785536000)]} 0 2 [junit4] 2> 2066465 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15 (1499488542790778880)]} 0 1 [junit4] 2> 2066470 T5382 c:collection1 C793 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[15 (1499488542796021760)]} 0 1 [junit4] 2> 2066474 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16 (1499488542800216064)]} 0 1 [junit4] 2> 2066478 T5357 c:collection1 C791 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[16 (1499488542804410368)]} 0 1 [junit4] 2> 2066482 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17 (1499488542808604672)]} 0 1 [junit4] 2> 2066487 T5372 c:collection1 C792 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[17 (1499488542813847552)]} 0 1 [junit4] 2> 2066491 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[18 (1499488542818041856)]} 0 1 [junit4] 2> 2066495 T5382 c:collection1 C793 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[18 (1499488542822236160)]} 0 1 [junit4] 2> 2066499 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[19 (1499488542826430464)]} 0 1 [junit4] 2> 2066503 T5357 c:collection1 C791 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[19 (1499488542830624768)]} 0 1 [junit4] 2> 2066507 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[20 (1499488542834819072)]} 0 1 [junit4] 2> 2066511 T5372 c:collection1 C792 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[20 (1499488542839013376)]} 0 1 [junit4] 2> 2066515 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[21 (1499488542844256256)]} 0 1 [junit4] 2> 2066520 T5382 c:collection1 C793 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[21 (1499488542848450560)]} 0 1 [junit4] 2> 2066524 T5347 c:collection1 C790 oasup.LogUpdateProcessor.finish [collection1] webapp= path=/update params={version=2&wt=javabin} {add=[22 (1499488542852644864)]} 0 1 [junit4] 2> 2066528 T5357 c:collection1 C791 oasup.LogUpdateProcess [...truncated too long message...] ndex [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1/data/index;done=false>>] [junit4] 2> 2157179 T5342 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.x-Java7/solr/build/solr-core/test/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001/tempDir-001/shard2/cores/collection1/data/index [junit4] 2> 2157180 T5342 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/,null} [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistributedMLTComponentTest -Dtests.method=test -Dtests.seed=DA88FC81E91109EA -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=el_GR -Dtests.timezone=Etc/GMT+11 -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 104s J1 | DistributedMLTComponentTest.test <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:23259//collection1 [junit4] > at __randomizedtesting.SeedInfo.seed([DA88FC81E91109EA:52DCC35B47ED6412]: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> 2157399 T5342 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/J1/temp/solr.handler.component.DistributedMLTComponentTest DA88FC81E91109EA-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {timestamp=PostingsFormat(name=Direct), id=PostingsFormat(name=MockRandom), range_facet_l_dv=PostingsFormat(name=MockRandom), lowerfilt1and2=PostingsFormat(name=Memory doPackFST= true), intDefault=PostingsFormat(name=Direct), range_facet_l=PostingsFormat(name=Direct), range_facet_i_dv=PostingsFormat(name=Direct), multiDefault=PostingsFormat(name=Memory doPackFST= true), lowerfilt1=Lucene50(blocksize=128), lowerfilt=PostingsFormat(name=Memory doPackFST= true), _version_=PostingsFormat(name=Direct)}, docValues:{timestamp=DocValuesFormat(name=Memory), range_facet_l_dv=DocValuesFormat(name=Direct), range_facet_i_dv=DocValuesFormat(name=Memory)}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=el_GR, timezone=Etc/GMT+11 [junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 (64-bit)/cpus=16,threads=1,free=246348480,total=379584512 [junit4] 2> NOTE: All tests run in this JVM: [ReplicationFactorTest, TestExceedMaxTermLength, PreAnalyzedFieldTest, EnumFieldTest, TestZkChroot, CloudExitableDirectoryReaderTest, CacheHeaderTest, FullSolrCloudDistribCmdsTest, SampleTest, TestFieldTypeResource, TestTolerantSearch, DistributedTermsComponentTest, TestDocumentBuilder, TestPivotHelperCode, LeaderInitiatedRecoveryOnCommitTest, DistributedFacetPivotWhiteBoxTest, CoreMergeIndexesAdminHandlerTest, LeaderElectionTest, HdfsDirectoryTest, HdfsLockFactoryTest, TestCoreContainer, CoreAdminRequestStatusTest, SolrRequestParserTest, CursorPagingTest, TestCursorMarkWithoutUniqueKey, MinimalSchemaTest, AliasIntegrationTest, TestCloudPivotFacet, InfoHandlerTest, TestDFRSimilarityFactory, TestSolrXml, StatelessScriptUpdateProcessorFactoryTest, TestPartialUpdateDeduplication, SharedFSAutoReplicaFailoverUtilsTest, RAMDirectoryFactoryTest, SimpleFacetsTest, SOLR749Test, CloudMLTQParserTest, TestHighlightDedupGrouping, ReturnFieldsTest, IndexBasedSpellCheckerTest, HardAutoCommitTest, TestIndexSearcher, TestRTGBase, DistributedQueryComponentOptimizationTest, LeaderElectionIntegrationTest, TestBM25SimilarityFactory, TestSuggestSpellingConverter, RequestLoggingTest, PeerSyncTest, SliceStateTest, MigrateRouteKeyTest, MBeansHandlerTest, HighlighterMaxOffsetTest, BinaryUpdateRequestHandlerTest, ShowFileRequestHandlerTest, TestReplicaProperties, TestFoldingMultitermQuery, TestHdfsUpdateLog, SyncSliceTest, BasicDistributedZkTest, UnloadDistributedZkTest, RecoveryAfterSoftCommitTest, DistribDocExpirationUpdateProcessorTest, ExternalCollectionsTest, TestDistribDocBasedVersion, TestManagedSchemaDynamicFieldResource, DistributedFacetPivotLargeTest, ZkSolrClientTest, TestRecovery, TestHashPartitioner, DistributedMLTComponentTest] [junit4] Completed [316/484] on J1 in 104.19s, 1 test, 1 error <<< FAILURES! [...truncated 524 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: 484 suites, 1946 tests, 1 error, 68 ignored (26 assumptions) Total time: 59 minutes 22 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Sending artifact delta relative to Lucene-Solr-Tests-5.x-Java7 #3011 Archived 5 artifacts Archive block size is 32768 Received 0 blocks and 215956009 bytes Compression is 0.0% Took 43 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]
