Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2120/ Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed. FAILED: org.apache.solr.client.solrj.SolrSchemalessExampleTest.testAddDelete Error Message: IOException occured when talking to server at: https://127.0.0.1:56397/solr/collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:56397/solr/collection1 at __randomizedtesting.SeedInfo.seed([39F5E06397B629A1:F1159D69661EFA77]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:571) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:233) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:225) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:174) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:139) at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:153) at org.apache.solr.client.solrj.SolrExampleTestsBase.testAddDelete(SolrExampleTestsBase.java:198) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) at 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: org.apache.http.NoHttpResponseException: 127.0.0.1:56397 failed to respond at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:462) ... 46 more Build Log: [...truncated 11482 lines...] [junit4] Suite: org.apache.solr.client.solrj.SolrSchemalessExampleTest [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/init-core-data-001 [junit4] 2> 83321 T274 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 83465 T274 oas.SolrTestCaseJ4.initCore ####initCore [junit4] 2> 83465 T274 oas.SolrTestCaseJ4.initCore ####initCore end [junit4] 2> 83467 T274 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-002/cores/core [junit4] 2> 83519 T274 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 83954 T274 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 83967 T274 oejs.AbstractConnector.doStart Started [email protected]:56397 [junit4] 2> 83968 T274 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/solr, hostPort=56397, configSetBaseDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-002/cores} [junit4] 2> 83970 T274 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@677327b6 [junit4] 2> 83970 T274 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/' [junit4] 2> 84002 T274 oasc.SolrXmlConfig.fromFile Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/solr.xml [junit4] 2> 84021 T274 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001 [junit4] 2> 84021 T274 oasc.CoreContainer.<init> New CoreContainer 261083345 [junit4] 2> 84021 T274 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/] [junit4] 2> 84021 T274 oasc.CoreContainer.load loading shared library: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/lib [junit4] 2> 84022 T274 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/lib). [junit4] 2> 84033 T274 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 600000 [junit4] 2> 84033 T274 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null [junit4] 2> 84033 T274 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 60000 [junit4] 2> 84033 T274 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 84033 T274 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 84033 T274 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 84034 T274 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 84034 T274 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 84034 T274 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 84034 T274 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 84034 T274 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 84041 T274 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true [junit4] 2> 84046 T274 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 84046 T274 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 84046 T274 oasc.CoreContainer.load Node Name: [junit4] 2> 84072 T274 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001 [junit4] 2> 84074 T274 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {name=collection1, config=solrconfig.xml, instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1, loadOnStartup=true, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/, schema=schema.xml, transient=false, dataDir=data/} [junit4] 2> 84074 T274 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/ [junit4] 2> 84075 T274 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 84078 T284 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/' [junit4] 2> 84106 T284 oasc.SolrConfig.refreshRequestParams current version of requestparams : 0 [junit4] 2> 84106 T284 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader [junit4] 2> 84107 T284 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/../../../../contrib/extraction/lib). [junit4] 2> 84107 T284 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/../../../../dist). [junit4] 2> 84108 T284 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/../../../../contrib/clustering/lib). [junit4] 2> 84108 T284 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/../../../../dist). [junit4] 2> 84109 T284 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/../../../../contrib/langid/lib). [junit4] 2> 84109 T284 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/../../../../dist). [junit4] 2> 84109 T284 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/../../../../contrib/velocity/lib). [junit4] 2> 84110 T284 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/../../../../dist). [junit4] 2> 84133 T284 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.0.0 [junit4] 2> 84159 T284 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 84251 T284 oass.IndexSchema.readSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 84272 T284 oass.IndexSchema.readSchema [collection1] Schema name=example-data-driven-schema [junit4] 2> 84463 T284 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 84522 T284 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 84525 T284 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 84564 T284 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/ [junit4] 2> 84564 T284 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 84564 T284 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data/ [junit4] 2> 84565 T284 c:collection1 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@51cf3288 [junit4] 2> 84565 T284 c:collection1 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]} [junit4] 2> 84567 T284 c:collection1 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[]} [junit4] 2> 84571 T284 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data [junit4] 2> 84571 T284 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data/index/ [junit4] 2> 84572 T284 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 84572 T284 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data/index [junit4] 2> 84573 T284 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_1,generation=1} [junit4] 2> 84573 T284 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 84574 T284 c:collection1 oasc.PluginBag.createPlugin queryResponseWriter : 'velocity' created with startup=lazy [junit4] 2> 84574 T284 c:collection1 oasr.XSLTResponseWriter.init xsltCacheLifetimeSeconds=5 [junit4] 2> 84579 T284 c:collection1 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "add-unknown-fields-to-the-schema" [junit4] 2> 85543 T284 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 85560 T284 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 85563 T284 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 85569 T284 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 85574 T284 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 85580 T284 c:collection1 oasc.PluginBag.createPlugin requestHandler : '/update/extract' created with startup=lazy [junit4] 2> 85580 T284 c:collection1 oasc.PluginBag.createPlugin requestHandler : '/analysis/field' created with startup=lazy [junit4] 2> 85580 T284 c:collection1 oasc.PluginBag.createPlugin requestHandler : '/analysis/document' created with startup=lazy [junit4] 2> 85581 T284 c:collection1 oasc.PluginBag.createPlugin requestHandler : '/spell' created with startup=lazy [junit4] 2> 85581 T284 c:collection1 oasc.PluginBag.createPlugin requestHandler : '/tvrh' created with startup=lazy [junit4] 2> 85581 T284 c:collection1 oasc.PluginBag.createPlugin requestHandler : '/terms' created with startup=lazy [junit4] 2> 85582 T284 c:collection1 oasc.PluginBag.createPlugin requestHandler : '/elevate' created with startup=lazy [junit4] 2> 85584 T284 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /admin/mbeans,/browse,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/elevate,/update/json,/admin/threads,/query,/analysis/field,/analysis/document,/spell,/update/csv,/tvrh,/select,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/debug/dump,/terms,/update/extract [junit4] 2> 85591 T284 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 85595 T284 c:collection1 oasu.UpdateHandler.<init> Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 85595 T284 c:collection1 oasu.UpdateLog.init Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 [junit4] 2> 85596 T284 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: if uncommited for 15000ms; [junit4] 2> 85596 T284 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 85596 T284 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_1,generation=1} [junit4] 2> 85597 T284 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 85598 T284 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@3b91c97e[collection1] main [junit4] 2> 85598 T284 c:collection1 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf [junit4] 2> 85598 T284 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf} [junit4] 2> 85598 T284 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf [junit4] 2> 85600 T284 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 85601 T284 c:collection1 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 85601 T284 c:collection1 oass.DirectSolrSpellChecker.init init: {name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01} [junit4] 2> 85603 T284 c:collection1 oashc.SpellCheckComponent.inform No queryConverter defined, using default converter [junit4] 2> 85605 T284 c:collection1 oashc.QueryElevationComponent.inform Loading QueryElevation from: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/elevate.xml [junit4] 2> 85695 T284 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 85699 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3b91c97e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 85701 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 85701 T285 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default [junit4] 2> 85701 T285 c:collection1 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak [junit4] 2> 85702 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3b91c97e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 85700 T284 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 85707 T274 oass.SolrDispatchFilter.init user.dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0 [junit4] 2> 85707 T274 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 85707 T274 oas.SolrJettyTestBase.createJetty Jetty Assigned Port#56397 [junit4] 2> 85719 T274 oas.SolrTestCaseJ4.setUp ###Starting testFieldMutating [junit4] 2> ASYNC NEW_CORE C16 name=collection1 org.apache.solr.core.SolrCore@3b399b5b [junit4] 2> 86115 T278 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1498235880727379968)} 0 41 [junit4] 2> 86126 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 86127 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit. [junit4] 2> 86127 T283 c:collection1 C16 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 86128 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 86128 T283 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 5 [junit4] 2> 86134 T282 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 [junit4] 2> 86585 T281 c:collection1 C16 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 86634 T281 c:collection1 C16 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 86694 T281 c:collection1 C16 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 86755 T281 c:collection1 C16 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 86812 T281 c:collection1 C16 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 86849 T281 c:collection1 C16 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 86852 T281 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update/json/docs params={} {add=[e6bfdc32-e5b0-4f00-bba2-acc08d6c6e34 (1498235880819654656), c63222c5-eead-45a3-a376-d4261fabdff8 (1498235881231745024), 879b28dd-35bf-42a1-b7de-1063078e4b01 (1498235881276833792), 3e949d41-b900-4f6d-a7dc-b826f5fb80ef (1498235881341845504), 4629005c-6c6f-4a25-a8d9-36c1ef528643 (1498235881403711488), 9181db6a-b69a-408b-981d-f09ea76810b3 (1498235881463480320), 979890e8-9802-46dd-ac1d-c5b052a7a5cf (1498235881503326208)]} 0 713 [junit4] 2> 86877 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 86881 T283 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_2,generation=2} [junit4] 2> 86882 T283 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 86885 T283 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@2ff2a383[collection1] main [junit4] 2> 86886 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 86886 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@2ff2a383[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C7)))} [junit4] 2> 86887 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 86888 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2ff2a383[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C7)))} [junit4] 2> 86888 T283 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 11 [junit4] 2> 86895 T282 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=7 status=0 QTime=1 [junit4] 2> 86896 T274 oas.SolrTestCaseJ4.tearDown ###Ending testFieldMutating [junit4] 2> 86904 T274 oas.SolrTestCaseJ4.setUp ###Starting testCommitWithinOnDelete [junit4] 2> 86911 T279 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@6f7b9421[collection1] realtime [junit4] 2> 86912 T279 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1498235881563095040)} 0 4 [junit4] 2> 86916 T280 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 86917 T280 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_3,generation=3} [junit4] 2> 86917 T280 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 86918 T280 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@46e5f94c[collection1] main [junit4] 2> 86918 T280 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 86918 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@46e5f94c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 86918 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 86921 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@46e5f94c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 86922 T280 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 6 [junit4] 2> 86927 T281 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 [junit4] 2> 86978 T278 c:collection1 C16 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 86982 T278 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id3 (1498235881587212288)]} 0 52 [junit4] 2> 86988 T282 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 86996 T282 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_4,generation=4} [junit4] 2> 86997 T282 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4 [junit4] 2> 86999 T282 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@63228e60[collection1] main [junit4] 2> 86999 T282 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 86999 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@63228e60[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.2.0):C1)))} [junit4] 2> 86999 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 87000 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@63228e60[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(5.2.0):C1)))} [junit4] 2> 87001 T282 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 13 [junit4] 2> 87005 T279 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=1 [junit4] 2> 87025 T280 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {delete=[id3 (-1498235881669001216)]} 0 16 [junit4] 2> 87034 T281 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=0 [junit4] 2> 87289 T278 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=0 [junit4] 2> 87546 T283 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=0 [junit4] 2> 87801 T279 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=0 [junit4] 2> 88023 T288 c:collection1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 88024 T288 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@280e3695[collection1] main [junit4] 2> 88024 T288 c:collection1 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 88025 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@280e3695[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 88025 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 88026 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@280e3695[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 88057 T278 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 88059 T274 oas.SolrTestCaseJ4.tearDown ###Ending testCommitWithinOnDelete [junit4] 2> 88065 T274 oas.SolrTestCaseJ4.setUp ###Starting testArbitraryJsonIndexing [junit4] 2> 88068 T283 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1498235882779443200)} 0 0 [junit4] 2> 88074 T279 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 88074 T279 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_4,generation=4} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_5,generation=5} [junit4] 2> 88074 T279 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5 [junit4] 2> 88075 T279 c:collection1 C16 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 88075 T279 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 88076 T279 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 2 [junit4] 2> 88080 T280 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 88088 T281 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update/json/docs params={} {add=[abc1 (1498235882796220416), ed1356a8-c0a9-4057-9621-f16c91d69b93 (1498235882799366144)]} 0 4 [junit4] 2> 88109 T278 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 88113 T278 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_5,generation=5} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_6,generation=6} [junit4] 2> 88113 T278 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6 [junit4] 2> 88115 T278 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@25386f7e[collection1] main [junit4] 2> 88115 T278 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 88115 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@25386f7e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(5.2.0):C2)))} [junit4] 2> 88115 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 88117 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@25386f7e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(5.2.0):C2)))} [junit4] 2> 88117 T278 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 8 [junit4] 2> 88123 T283 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=1 [junit4] 2> 88124 T274 oas.SolrTestCaseJ4.tearDown ###Ending testArbitraryJsonIndexing [junit4] 2> 88131 T274 oas.SolrTestCaseJ4.setUp ###Starting testAddDelete [junit4] 2> 88136 T279 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@1e5cfcec[collection1] realtime [junit4] 2> 88136 T279 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1498235882848649216)} 0 3 [junit4] 2> 88142 T280 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0 & 222 (1498235882855989248)]} 0 1 [junit4] 2> 88148 T281 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 88151 T281 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_6,generation=6} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_7,generation=7} [junit4] 2> 88151 T281 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7 [junit4] 2> 88152 T281 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@7e575e8b[collection1] main [junit4] 2> 88153 T281 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 88153 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7e575e8b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(5.2.0):C1)))} [junit4] 2> 88153 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 88154 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7e575e8b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(5.2.0):C1)))} [junit4] 2> 88155 T281 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 7 [junit4] 2> 88161 T282 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=1 [junit4] 2> 88166 T278 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {delete=[0 & 222 (-1498235882881155072)]} 0 1 [junit4] 2> 88170 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 88170 T283 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_7,generation=7} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_8,generation=8} [junit4] 2> 88170 T283 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8 [junit4] 2> 88171 T283 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@70cc763e[collection1] main [junit4] 2> 88171 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 88171 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@70cc763e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 88172 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 88173 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@70cc763e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 88174 T283 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 5 [junit4] 2> 88178 T279 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 [junit4] 2> 88184 T280 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0 & 222 (1498235882897932288)]} 0 3 [junit4] 2> 88188 T281 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 88189 T281 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_8,generation=8} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_9,generation=9} [junit4] 2> 88190 T281 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9 [junit4] 2> 88191 T281 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@47f6de50[collection1] main [junit4] 2> 88191 T281 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 88191 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@47f6de50[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.2.0):C1)))} [junit4] 2> 88191 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 88193 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@47f6de50[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(5.2.0):C1)))} [junit4] 2> 88193 T281 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 5 [junit4] 2> 88201 T282 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0 [junit4] 2> 88218 T278 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@75188dae[collection1] realtime [junit4] 2> 88220 T278 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=id:"0\ \&\ 222" (-1498235882925195264)} 0 13 [junit4] 2> 88226 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 88226 T283 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_9,generation=9} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_a,generation=10} [junit4] 2> 88226 T283 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10 [junit4] 2> 88227 T283 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@139eee20[collection1] main [junit4] 2> 88227 T283 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 88228 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@139eee20[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 88228 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 88230 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@139eee20[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 88230 T283 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 5 [junit4] 2> 88236 T279 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 88256 T280 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0 & 222 (1498235882973429760)]} 0 4 [junit4] 2> 88266 T281 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 & 222 (1498235882987061248)]} 0 1 [junit4] 2> 103264 T287 c:collection1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 103266 T287 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_a,generation=10} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_b,generation=11} [junit4] 2> 103267 T287 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11 [junit4] 2> 103268 T287 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@3e0648a0[collection1] realtime [junit4] 2> 103269 T287 c:collection1 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 288665 T274 oas.SolrTestCaseJ4.tearDown ###Ending testAddDelete [junit4] 2> 288665 T278 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2 & 222 (1498236093117497344)]} 0 3 [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrSchemalessExampleTest -Dtests.method=testAddDelete -Dtests.seed=39F5E06397B629A1 -Dtests.slow=true -Dtests.locale=es_EC -Dtests.timezone=Atlantic/Stanley -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 201s J0 | SolrSchemalessExampleTest.testAddDelete <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:56397/solr/collection1 [junit4] > at __randomizedtesting.SeedInfo.seed([39F5E06397B629A1:F1159D69661EFA77]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:571) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:233) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:225) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135) [junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:174) [junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:139) [junit4] > at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:153) [junit4] > at org.apache.solr.client.solrj.SolrExampleTestsBase.testAddDelete(SolrExampleTestsBase.java:198) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > Caused by: org.apache.http.NoHttpResponseException: 127.0.0.1:56397 failed to respond [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:143) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) [junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) [junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) [junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) [junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) [junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:462) [junit4] > ... 46 more [junit4] 2> 288820 T274 oas.SolrTestCaseJ4.setUp ###Starting testCommitWithinOnAdd [junit4] 2> 288855 T278 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@571f4106[collection1] realtime [junit4] 2> 288856 T278 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1498236093302046720)} 0 19 [junit4] 2> 288862 T279 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 288862 T279 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_b,generation=11} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_c,generation=12} [junit4] 2> 288863 T279 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12 [junit4] 2> 288863 T279 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@4bf38dd0[collection1] main [junit4] 2> 288864 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4bf38dd0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 288864 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 288864 T279 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 288865 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4bf38dd0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 288865 T279 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 4 [junit4] 2> 288872 T282 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 [junit4] 2> 288878 T283 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id3 (1498236093341892608)]} 0 2 [junit4] 2> 288882 T281 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 289379 T288 c:collection1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 289381 T288 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@28887630[collection1] main [junit4] 2> 289382 T288 c:collection1 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 289382 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@28887630[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(5.2.0):C1)))} [junit4] 2> 289382 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 289383 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@28887630[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(5.2.0):C1)))} [junit4] 2> 289890 T280 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=1 [junit4] 2> 289897 T278 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id4 (1498236094411440128)]} 0 1 [junit4] 2> 290398 T288 c:collection1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 290403 T288 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@3c5755b[collection1] main [junit4] 2> 290403 T288 c:collection1 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 290403 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3c5755b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(5.2.0):C1) Uninverting(_8(5.2.0):C1)))} [junit4] 2> 290404 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 290405 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3c5755b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(5.2.0):C1) Uninverting(_8(5.2.0):C1)))} [junit4] 2> 290904 T278 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=id:id4&wt=javabin&version=2} hits=1 status=0 QTime=1 [junit4] 2> 290905 T274 oas.SolrTestCaseJ4.tearDown ###Ending testCommitWithinOnAdd [junit4] 2> 290911 T274 oas.SolrTestCaseJ4.setUp ###Starting testStreamingRequest [junit4] 2> 290916 T279 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@6f2285ed[collection1] realtime [junit4] 2> 290917 T279 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1498236095479939072)} 0 3 [junit4] 2> 290923 T282 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 290924 T282 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_c,generation=12} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_d,generation=13} [junit4] 2> 290925 T282 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13 [junit4] 2> 290926 T282 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@10a8a9bf[collection1] main [junit4] 2> 290927 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@10a8a9bf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 290927 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 290927 T282 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 290928 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10a8a9bf[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 290929 T282 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {commit=} 0 6 [junit4] 2> 290933 T283 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1 [junit4] 2> 291000 T281 c:collection1 C16 oass.ManagedIndexSchema.persistManagedSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/conf/managed-schema [junit4] 2> 291004 T281 c:collection1 C16 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 291006 T281 c:collection1 C16 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_d,generation=13} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11e6509f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45893f75),segFN=segments_e,generation=14} [junit4] 2> 291006 T281 c:collection1 C16 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14 [junit4] 2> 291009 T281 c:collection1 C16 oass.SolrIndexSearcher.<init> Opening Searcher@f4bce2e[collection1] main [junit4] 2> 291009 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@f4bce2e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(5.2.0):C10)))} [junit4] 2> 291010 T285 c:collection1 oasc.QuerySenderListener.newSearcher QuerySenderListener done. [junit4] 2> 291010 T281 c:collection1 C16 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 291011 T285 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f4bce2e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(5.2.0):C10)))} [junit4] 2> 291012 T281 c:collection1 C16 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {add=[0 (1498236095503007744), 1 (1498236095571165184), 2 (1498236095571165185), 3 (1498236095571165186), 4 (1498236095571165187), 5 (1498236095571165188), 6 (1498236095572213760), 7 (1498236095572213761), 8 (1498236095572213762), 9 (1498236095573262336)],commit=} 0 74 [junit4] 2> 291017 T280 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&fl=id,score,_docid_&wt=javabin&version=2} hits=10 status=0 QTime=1 [junit4] 2> 291022 T278 c:collection1 C16 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&fl=id,score,_docid_&wt=javabin&version=2} hits=10 status=0 QTime=0 [junit4] 2> 291024 T274 oas.SolrTestCaseJ4.tearDown ###Ending testStreamingRequest [junit4] 2> 291038 T274 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=261083345 [junit4] 2> 291039 T274 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3b399b5b [junit4] 2> 291042 T274 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=17,autocommit maxTime=15000ms,autocommits=1,soft autocommits=3,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=27,cumulative_deletesById=2,cumulative_deletesByQuery=7,cumulative_errors=0,transaction_logs_total_size=1588,transaction_logs_total_number=10} [junit4] 2> 291043 T274 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 291043 T274 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 291043 T274 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 291047 T274 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 291081 T274 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 291082 T274 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data;done=false>>] [junit4] 2> 291083 T274 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data [junit4] 2> 291083 T274 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data/index;done=false>>] [junit4] 2> 291083 T274 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001/tempDir-001/collection1/data/index [junit4] 2> 291084 T274 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null} [junit4] 2> 291228 T274 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.SolrSchemalessExampleTest 39F5E06397B629A1-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=crazy): {}, locale=es_EC, timezone=Atlantic/Stanley [junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_40 (64-bit)/cpus=3,threads=1,free=25489200,total=230686720 [junit4] 2> NOTE: All tests run in this JVM: [FacetFieldTest, TestSolrProperties, ExternalHttpClientTest, TestRetryUtil, ConcurrentUpdateSolrClientTest, SolrExampleXMLTest, DocumentAnalysisResponseTest, FieldAnalysisResponseTest, TermsResponseTest, ModifiableSolrParamsTest, TestXMLEscaping, TestCloudSolrClientConnections, TestJavaBinCodec, TestSpellCheckResponse, SolrExampleStreamingBinaryTest, JettyWebappTest, TestEmbeddedSolrServer, TestCoreAdmin, IteratorChainTest, ClientUtilsTest, AnlysisResponseBaseTest, SolrSchemalessExampleTest] [junit4] Completed [57/57] on J0 in 207.93s, 6 tests, 1 error <<< FAILURES! [...truncated 10 lines...] BUILD FAILED /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:536: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:484: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:242: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:510: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1434: The following error occurred while executing this line: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:991: There were test failures: 57 suites, 374 tests, 1 error Total time: 74 minutes 38 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseParallelGC Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
