Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4657/
Java: 32bit/jdk1.8.0_45 -server -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.embedded.LargeVolumeJettyTest
Error Message:
Some resources were not closed, shutdown, or released.
Stack Trace:
java.lang.AssertionError: Some resources were not closed, shutdown, or released.
at __randomizedtesting.SeedInfo.seed([5AEA969D5ED84A9C]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:234)
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$5.evaluate(RandomizedRunner.java:799)
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)
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.embedded.LargeVolumeJettyTest
Error Message:
Could not remove the following files (in the order of attempts):
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog\tlog.0000000000000000002:
The process cannot access the file because it is being used by another
process.
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of
attempts):
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog\tlog.0000000000000000002:
The process cannot access the file because it is being used by another process.
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:294)
at
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:215)
at
com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43)
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)
Build Log:
[...truncated 11652 lines...]
[junit4] Suite: org.apache.solr.client.solrj.embedded.LargeVolumeJettyTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\init-core-data-001
[junit4] 2> 94113 T268 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (true)
[junit4] 2> 94312 T268 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 94313 T268 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 94318 T268 oas.SolrTestCaseJ4.writeCoreProperties Writing
core.properties file to
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-002\cores\core
[junit4] 2> 94329 T268 oejs.Server.doStart jetty-9.2.10.v20150310
[junit4] 2> 94343 T268 oejsh.ContextHandler.doStart Started
o.e.j.s.ServletContextHandler@53e997{/solr,null,AVAILABLE}
[junit4] 2> 94359 T268 oejs.AbstractConnector.doStart Started
ServerConnector@13c8af4{HTTP/1.1}{127.0.0.1:57064}
[junit4] 2> 94360 T268 oejs.Server.doStart Started @95055ms
[junit4] 2> 94360 T268 oascse.JettySolrRunner$1.lifeCycleStarted Jetty
properties: {hostContext=/solr, hostPort=57064,
configSetBaseDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001,
coreRootDirectory=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-002\cores}
[junit4] 2> 94361 T268 oass.SolrDispatchFilter.init
SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@19e0bfd
[junit4] 2> 94361 T268 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\'
[junit4] 2> 94401 T268 oasc.SolrXmlConfig.fromFile Loading container
configuration from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\solr.xml
[junit4] 2> 94414 T268 oasc.CorePropertiesLocator.<init> Config-defined
core root directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001
[junit4] 2> 94415 T268 oasc.CoreContainer.<init> New CoreContainer 17786296
[junit4] 2> 94415 T268 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\]
[junit4] 2> 94416 T268 oasc.CoreContainer.load loading shared library:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\lib
[junit4] 2> 94416 T268 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: lib (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\lib).
[junit4] 2> 94439 T268 oashc.HttpShardHandlerFactory.init created with
socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 94443 T268 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 94444 T268 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 94446 T268 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 94446 T268 oasc.CoreContainer.load Node Name:
[junit4] 2> 94452 T268 oasc.CorePropertiesLocator.discover Looking for
core definitions underneath
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001
[junit4] 2> 94456 T268 oasc.CoreDescriptor.<init> CORE DESCRIPTOR:
{name=collection1, config=solrconfig.xml,
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1, loadOnStartup=true,
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\, schema=schema.xml,
transient=false, dataDir=data\}
[junit4] 2> 94456 T268 oasc.CorePropertiesLocator.discoverUnder Found core
collection1 in
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\
[junit4] 2> 94457 T268 oasc.CorePropertiesLocator.discover Found 1 core
definitions
[junit4] 2> 94458 T280 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\'
[junit4] 2> 94506 T280 oasc.SolrConfig.refreshRequestParams current
version of requestparams : -1
[junit4] 2> 94507 T280 oasc.SolrConfig.initLibs Adding specified lib dirs
to ClassLoader
[junit4] 2> 94507 T280 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader:
../../../../contrib/extraction/lib (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib).
[junit4] 2> 94508 T280 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 94508 T280 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader:
../../../../contrib/clustering/lib/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib).
[junit4] 2> 94508 T280 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 94511 T280 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../contrib/langid/lib/
(resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib).
[junit4] 2> 94511 T280 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 94511 T280 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader:
../../../../contrib/velocity/lib (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib).
[junit4] 2> 94511 T280 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 94550 T280 oasu.SolrIndexConfig.<init> IndexWriter infoStream
solr logging is enabled
[junit4] 2> 94553 T280 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.2.0
[junit4] 2> 94603 T280 oasc.SolrConfig.<init> Loaded SolrConfig:
solrconfig.xml
[junit4] 2> 94604 T280 oass.IndexSchema.readSchema Reading Solr Schema
from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf\schema.xml
[junit4] 2> 94611 T280 oass.IndexSchema.readSchema [collection1] Schema
name=example
[junit4] 2> 94912 T280 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 94912 T280 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path
/schema/analysis/stopwords/english
[junit4] 2> 94912 T280 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager
for path /schema/analysis/synonyms/english
[junit4] 2> 94932 T280 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 94937 T280 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 94983 T280 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from instancedir
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\
[junit4] 2> 94983 T280 x:collection1 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 94983 T280 x:collection1 oasc.SolrCore.<init> [[collection1] ]
Opening new SolrCore at
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\], dataDir=[null]
[junit4] 2> 94983 T280 x:collection1 oasc.JmxMonitoredMap.<init> JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15476e7
[junit4] 2> 94983 T280 x:collection1 oasc.SolrCore.initListeners
[[collection1] ] Added SolrEventListener for newSearcher:
[org.apache.solr.core.QuerySenderListener{queries=[]}]
[junit4] 2> 94983 T280 x:collection1 oasc.SolrCore.initListeners
[[collection1] ] Added SolrEventListener for firstSearcher:
[org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher
warming in solrconfig.xml}]}]
[junit4] 2> 94984 T280 x:collection1 oasc.CachingDirectoryFactory.get
return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\
[junit4] 2> 94986 T280 x:collection1 oasc.SolrCore.getNewIndexDir New
index directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\index/
[junit4] 2> 94986 T280 x:collection1 oasc.SolrCore.initIndex WARN
[collection1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\index' doesn't exist.
Creating new index...
[junit4] 2> 94988 T280 x:collection1 oasc.CachingDirectoryFactory.get
return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\index
[junit4] 2> 94988 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: init: current segments file is
"segments";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@1b3b4f0
[junit4] 2> 94988 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: now checkpoint "" [0 segments ; isCommit
= false]
[junit4] 2> 94988 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: 0 msec to checkpoint
[junit4] 2> 94989 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: init: create=true
[junit4] 2> 94989 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@9666b5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f33b45)
[junit4] 2> index=
[junit4] 2> version=5.2.0
[junit4] 2>
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
[junit4] 2> ramBufferSizeMB=100.0
[junit4] 2> maxBufferedDocs=-1
[junit4] 2> maxBufferedDeleteTerms=-1
[junit4] 2> mergedSegmentWarmer=null
[junit4] 2>
delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
[junit4] 2> commit=null
[junit4] 2> openMode=CREATE
[junit4] 2>
similarity=org.apache.lucene.search.similarities.DefaultSimilarity
[junit4] 2> mergeScheduler=ConcurrentMergeScheduler:
maxThreadCount=-1, maxMergeCount=-1, ioThrottle=true
[junit4] 2> default WRITE_LOCK_TIMEOUT=1000
[junit4] 2> writeLockTimeout=1000
[junit4] 2> codec=Lucene50
[junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream
[junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10,
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0,
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2>
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@1c62e7b
[junit4] 2> readerPooling=false
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@c645f8
[junit4] 2>
[junit4] 2> 94989 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: now flush at close
[junit4] 2> 94989 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: start flush: applyAllDeletes=true
[junit4] 2> 94990 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: index before flush
[junit4] 2> 94990 T280 x:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-160-thread-1]: startFullFlush
[junit4] 2> 94990 T280 x:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-160-thread-1]: coreLoadExecutor-160-thread-1
finishFullFlush success=true
[junit4] 2> 94990 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: apply all deletes during flush
[junit4] 2> 94990 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: now apply all deletes for all segments
maxDoc=0
[junit4] 2> 94992 T280 x:collection1 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-160-thread-1]: prune sis=segments:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 94992 T280 x:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-160-thread-1]: initDynamicDefaults spins=true
maxThreadCount=1 maxMergeCount=6
[junit4] 2> 94992 T280 x:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-160-thread-1]: updateMergeThreads ioThrottle=true
targetMBPerSec=10240.0 MB/sec
[junit4] 2> 94993 T280 x:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-160-thread-1]: now merge
[junit4] 2> 94993 T280 x:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-160-thread-1]: index:
[junit4] 2> 94993 T280 x:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-160-thread-1]: no more merges pending; now return
[junit4] 2> 94993 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: waitForMerges
[junit4] 2> 94993 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: waitForMerges done
[junit4] 2> 94993 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: commit: start
[junit4] 2> 94993 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: commit: enter lock
[junit4] 2> 94994 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: commit: now prepare
[junit4] 2> 94994 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: prepareCommit: flush
[junit4] 2> 94994 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: index before flush
[junit4] 2> 94994 T280 x:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-160-thread-1]: startFullFlush
[junit4] 2> 94995 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: apply all deletes during flush
[junit4] 2> 94995 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: now apply all deletes for all segments
maxDoc=0
[junit4] 2> 94995 T280 x:collection1 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-160-thread-1]: prune sis=segments:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 94995 T280 x:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-160-thread-1]: coreLoadExecutor-160-thread-1
finishFullFlush success=true
[junit4] 2> 94995 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: startCommit(): start
[junit4] 2> 94995 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: startCommit index= changeCount=1
[junit4] 2> 94997 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: done all syncs: []
[junit4] 2> 94997 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: commit: pendingCommit != null
[junit4] 2> 94999 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: now checkpoint "" [0 segments ; isCommit
= true]
[junit4] 2> 94999 T280 x:collection1 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@9666b5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f33b45),segFN=segments_1,generation=1}
[junit4] 2> 94999 T280 x:collection1 oasc.SolrDeletionPolicy.updateCommits
newest commit generation = 1
[junit4] 2> 94999 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: 0 msec to checkpoint
[junit4] 2> 94999 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: commit: wrote segments file "segments_1"
[junit4] 2> 95000 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: commit: took 4.7 msec
[junit4] 2> 95000 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: commit: done
[junit4] 2> 95000 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: rollback
[junit4] 2> 95000 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: all running merges have aborted
[junit4] 2> 95001 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: rollback: done finish merges
[junit4] 2> 95001 T280 x:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-160-thread-1]: abort
[junit4] 2> 95001 T280 x:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-160-thread-1]: done abort success=true
[junit4] 2> 95002 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: rollback: infos=
[junit4] 2> 95002 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: now checkpoint "" [0 segments ; isCommit
= false]
[junit4] 2> 95003 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: 0 msec to checkpoint
[junit4] 2> 95003 T280 x:collection1 oasc.PluginBag.createPlugin
queryResponseWriter : 'velocity' created with startup=lazy
[junit4] 2> 95004 T280 x:collection1 oasr.XSLTResponseWriter.init
xsltCacheLifetimeSeconds=5
[junit4] 2> 95017 T280 x:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 95032 T280 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 95036 T280 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 95039 T280 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 95048 T280 x:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 95062 T280 x:collection1 oasc.PluginBag.createPlugin
requestHandler : '/update/extract' created with startup=lazy
[junit4] 2> 95062 T280 x:collection1 oasc.PluginBag.createPlugin
requestHandler : '/analysis/field' created with startup=lazy
[junit4] 2> 95062 T280 x:collection1 oasc.PluginBag.createPlugin
requestHandler : '/analysis/document' created with startup=lazy
[junit4] 2> 95063 T280 x:collection1 oasc.PluginBag.createPlugin
requestHandler : '/spell' created with startup=lazy
[junit4] 2> 95063 T280 x:collection1 oasc.PluginBag.createPlugin
requestHandler : '/suggest' created with startup=lazy
[junit4] 2> 95063 T280 x:collection1 oasc.PluginBag.createPlugin
requestHandler : '/tvrh' created with startup=lazy
[junit4] 2> 95063 T280 x:collection1 oasc.PluginBag.createPlugin
requestHandler : '/terms' created with startup=lazy
[junit4] 2> 95063 T280 x:collection1 oasc.PluginBag.createPlugin
requestHandler : '/elevate' created with startup=lazy
[junit4] 2> 95063 T280 x: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,/suggest,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/debug/dump,/terms,/update/extract
[junit4] 2> 95066 T280 x:collection1 oasc.SolrCore.initStatsCache Using
default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 95068 T280 x:collection1 oasu.UpdateHandler.<init> Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 95068 T280 x:collection1 oasu.UpdateLog.init Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10
[junit4] 2> 95070 T280 x:collection1 oasu.CommitTracker.<init> Hard
AutoCommit: if uncommited for 15000ms;
[junit4] 2> 95070 T280 x:collection1 oasu.CommitTracker.<init> Soft
AutoCommit: disabled
[junit4] 2> 95071 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: init: current segments file is
"segments_1";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@1b3b4f0
[junit4] 2> 95071 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: init: load commit "segments_1"
[junit4] 2> 95071 T280 x:collection1 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@9666b5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f33b45),segFN=segments_1,generation=1}
[junit4] 2> 95071 T280 x:collection1 oasc.SolrDeletionPolicy.updateCommits
newest commit generation = 1
[junit4] 2> 95072 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: now checkpoint "" [0 segments ; isCommit
= false]
[junit4] 2> 95072 T280 x:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-160-thread-1]: 0 msec to checkpoint
[junit4] 2> 95072 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: init: create=false
[junit4] 2> 95078 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@9666b5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f33b45)
[junit4] 2> index=
[junit4] 2> version=5.2.0
[junit4] 2>
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
[junit4] 2> ramBufferSizeMB=100.0
[junit4] 2> maxBufferedDocs=-1
[junit4] 2> maxBufferedDeleteTerms=-1
[junit4] 2> mergedSegmentWarmer=null
[junit4] 2>
delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
[junit4] 2> commit=null
[junit4] 2> openMode=APPEND
[junit4] 2>
similarity=org.apache.lucene.search.similarities.DefaultSimilarity
[junit4] 2> mergeScheduler=ConcurrentMergeScheduler:
maxThreadCount=-1, maxMergeCount=-1, ioThrottle=true
[junit4] 2> default WRITE_LOCK_TIMEOUT=1000
[junit4] 2> writeLockTimeout=1000
[junit4] 2> codec=Lucene50
[junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream
[junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10,
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0,
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2>
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@85e313
[junit4] 2> readerPooling=false
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@7ef9c8
[junit4] 2>
[junit4] 2> 95079 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: flush at getReader
[junit4] 2> 95079 T280 x:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-160-thread-1]: startFullFlush
[junit4] 2> 95079 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: apply all deletes during flush
[junit4] 2> 95080 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: now apply all deletes for all segments
maxDoc=0
[junit4] 2> 95080 T280 x:collection1 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-160-thread-1]: prune sis=segments_1:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 95080 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: return reader version=1
reader=StandardDirectoryReader(segments_1:1:nrt)
[junit4] 2> 95080 T280 x:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-160-thread-1]: coreLoadExecutor-160-thread-1
finishFullFlush success=true
[junit4] 2> 95080 T280 x:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-160-thread-1]: getReader took 1 msec
[junit4] 2> 95082 T280 x:collection1 oass.SolrIndexSearcher.<init> Opening
Searcher@19fdcca[collection1] main
[junit4] 2> 95083 T280 x:collection1
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage
initialized to use dir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf
[junit4] 2> 95084 T280 x:collection1 oasr.RestManager.init Initializing
RestManager with initArgs:
{storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf}
[junit4] 2> 95084 T280 x:collection1 oasr.ManagedResourceStorage.load
Reading _rest_managed.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf
[junit4] 2> 95084 T280 x:collection1 oasr.ManagedResourceStorage.load
Loaded LinkedHashMap at path _rest_managed.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf
[junit4] 2> 95085 T280 x:collection1
oasr.ManagedResource.processStoredData Loaded initArgs {} for /rest/managed
[junit4] 2> 95085 T280 x:collection1 oasr.RestManager.init Initializing 2
registered ManagedResources
[junit4] 2> 95085 T280 x:collection1 oasr.ManagedResourceStorage.load
Reading _schema_analysis_stopwords_english.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf
[junit4] 2> 95085 T280 x:collection1 oasr.ManagedResourceStorage.load
Loaded LinkedHashMap at path _schema_analysis_stopwords_english.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf
[junit4] 2> 95085 T280 x:collection1
oasr.ManagedResource.processStoredData Loaded initArgs {ignoreCase=true} for
/schema/analysis/stopwords/english
[junit4] 2> 95085 T280 x:collection1
oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 35 words
for /schema/analysis/stopwords/english
[junit4] 2> 95086 T280 x:collection1
oasr.ManagedResource.notifyObserversDuringInit Notified 1 observers of
/schema/analysis/stopwords/english
[junit4] 2> 95086 T280 x:collection1 oasr.ManagedResourceStorage.load
Reading _schema_analysis_synonyms_english.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf
[junit4] 2> 95089 T280 x:collection1 oasr.ManagedResourceStorage.load
Loaded LinkedHashMap at path _schema_analysis_synonyms_english.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf
[junit4] 2> 95089 T280 x:collection1
oasr.ManagedResource.processStoredData Loaded initArgs
{ignoreCase=true,format=solr} for /schema/analysis/synonyms/english
[junit4] 2> 95090 T280 x:collection1
oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage
Loaded 3 synonym mappings for /schema/analysis/synonyms/english
[junit4] 2> 95090 T280 x:collection1
oasr.ManagedResource.notifyObserversDuringInit Notified 1 observers of
/schema/analysis/synonyms/english
[junit4] 2> 95090 T280 x:collection1 oashc.SpellCheckComponent.inform
Initializing spell checkers
[junit4] 2> 95091 T280 x: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> 95091 T280 x:collection1 oashc.SpellCheckComponent.inform No
queryConverter defined, using default converter
[junit4] 2> 95091 T280 x:collection1 oashc.SuggestComponent.inform
Initializing SuggestComponent
[junit4] 2> 95092 T280 x:collection1 oasss.SolrSuggester.init init:
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
[junit4] 2> 95092 T280 x:collection1 oasss.SolrSuggester.init Dictionary
loaded with params:
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
[junit4] 2> 95093 T280 x:collection1 oashc.QueryElevationComponent.inform
Loading QueryElevation from:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\conf\elevate.xml
[junit4] 2> 95103 T280 x:collection1 oash.ReplicationHandler.inform
Commits will be reserved for 10000
[junit4] 2> 95104 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@19fdcca[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> ASYNC NEW_CORE C97 name=collection1
org.apache.solr.core.SolrCore@131466
[junit4] 2> 95105 T281 x:collection1 C97 oasc.SolrCore.execute
[collection1] webapp=null path=null
params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher}
hits=0 status=0 QTime=1
[junit4] 2> 95105 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 95105 T281 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 95105 T281 x:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 95106 T281 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@19fdcca[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 95105 T280 x:collection1 oasc.CoreContainer.registerCore
registering core: collection1
[junit4] 2> 95112 T268 oass.SolrDispatchFilter.init
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1
[junit4] 2> 95112 T268 oass.SolrDispatchFilter.init
SolrDispatchFilter.init() done
[junit4] 2> 95112 T268 oas.SolrJettyTestBase.createJetty Jetty Assigned
Port#57064
[junit4] 2> 95127 T268 oas.SolrTestCaseJ4.setUp ###Starting
testMultiThreaded
[junit4] 2> 95145 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-274]: anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 95146 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-274]: anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 95146 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-274]: nrtIsCurrent: infoVersion matches: true; DW changes:
true; BD changes: false
[junit4] 2> 95146 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-274]: flush at getReader
[junit4] 2> 95146 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-274]: startFullFlush
[junit4] 2> 95146 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-274]: anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 95147 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-274]: qtp14445605-274: flush naked frozen global deletes
[junit4] 2> 95148 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-274]: push deletes 1 deleted queries bytesUsed=64
segmentPrivate?=false delGen=2 packetCount=1 totBytesUsed=64
[junit4] 2> 95148 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-274]: flush: push buffered updates: 1 deleted queries
bytesUsed=64
[junit4] 2> 95148 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-274]: apply all deletes during flush
[junit4] 2> 95148 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-274]: now apply all deletes for all segments maxDoc=0
[junit4] 2> 95148 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-274]: prune sis=segments_1: minGen=9223372036854775807
packetCount=1
[junit4] 2> 95148 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-274]: pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 95148 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-274]: return reader version=1
reader=StandardDirectoryReader(segments_1:1:nrt)
[junit4] 2> 95151 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-274]: qtp14445605-274 finishFullFlush success=true
[junit4] 2> 95151 T274 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-274]: getReader took 5 msec
[junit4] 2> 95152 T274 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update params={wt=javabin&version=2}
{deleteByQuery=*:* (-1500478621838475264)} 0 15
[junit4] 2> 95154 T268 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 0
[junit4] 2> 95156 T268 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 1
[junit4] 2> 95159 T268 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 2
[junit4] 2> 95160 T268 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 3
[junit4] 2> 95162 T268 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 4
[junit4] 2> 95204 T277 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update params={wt=javabin&version=2}
{add=[T0:0 (1500478621888806912), T0:1 (1500478621898244096), T0:2
(1500478621898244097), T0:3 (1500478621898244098), T0:4 (1500478621898244099),
T0:5 (1500478621898244100), T0:6 (1500478621898244101), T0:7
(1500478621898244102), T0:8 (1500478621898244103), T0:9 (1500478621898244104),
... (100 adds)]} 0 23
[junit4] 2> 95227 T273 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update params={wt=javabin&version=2}
{add=[T1:0 (1500478621920264192), T1:1 (1500478621920264193), T1:2
(1500478621920264194), T1:3 (1500478621920264195), T1:4 (1500478621920264196),
T1:5 (1500478621920264197), T1:6 (1500478621920264198), T1:7
(1500478621920264199), T1:8 (1500478621920264200), T1:9 (1500478621925507072),
... (100 adds)]} 0 10
[junit4] 2> 95231 T271 x:collection1 C97 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 95231 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: commit: start
[junit4] 2> 95231 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: commit: enter lock
[junit4] 2> 95232 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: commit: now prepare
[junit4] 2> 95234 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: prepareCommit: flush
[junit4] 2> 95234 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: index before flush
[junit4] 2> 95234 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-271]: startFullFlush
[junit4] 2> 95234 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-271]: anyChanges? numDocsInRam=400 deletes=true
hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 95234 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWFC][qtp14445605-271]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 136 deleted terms (unique count=136) bytesUsed=19157,
segment=_0, aborted=false, numDocsInRAM=31, deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 95234 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWFC][qtp14445605-271]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 398 deleted terms (unique count=398) bytesUsed=56080,
segment=_1, aborted=false, numDocsInRAM=369, deleteQueue=DWDQ: [ generation: 2
]]
[junit4] 2> 95238 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: flush postings as segment _0 numDocs=31
[junit4] 2> 95243 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: new segment has 0 deleted docs
[junit4] 2> 95243 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 95243 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: flushedFiles=[_0_Lucene50_0.doc, _0_Lucene50_0.tim,
_0_Lucene50_0.pos, _0.nvd, _0.fdx, _0_Lucene50_0.tip, _0.fdt, _0.nvm, _0.fnm]
[junit4] 2> 95243 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: flushed codec=Lucene50
[junit4] 2> 95243 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: flushed: segment=_0 ramUsed=0.15 MB
newFlushedSize=0.002 MB docs/MB=13,915.178
[junit4] 2> 95244 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: flush postings as segment _1 numDocs=369
[junit4] 2> 95248 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: new segment has 0 deleted docs
[junit4] 2> 95248 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 95249 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: flushedFiles=[_1_Lucene50_0.doc, _1_Lucene50_0.tim,
_1.nvd, _1_Lucene50_0.pos, _1.fdx, _1.nvm, _1.fnm, _1.fdt, _1_Lucene50_0.tip]
[junit4] 2> 95249 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: flushed codec=Lucene50
[junit4] 2> 95250 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-271]: flushed: segment=_1 ramUsed=0.172 MB
newFlushedSize=0.01 MB docs/MB=37,398.467
[junit4] 2> 95250 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-271]: publishFlushedSegment seg-private updates=null
[junit4] 2> 95251 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: publishFlushedSegment
[junit4] 2> 95251 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: push deletes 400 deleted terms (unique count=400)
bytesUsed=2080 segmentPrivate?=false delGen=4 packetCount=1 totBytesUsed=2080
[junit4] 2> 95251 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: publish sets newSegment delGen=5 seg=_0(5.2.0):C31
[junit4] 2> 95251 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-271]: now checkpoint "_0(5.2.0):C31" [1 segments ; isCommit =
false]
[junit4] 2> 95252 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-271]: 0 msec to checkpoint
[junit4] 2> 95252 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-271]: publishFlushedSegment seg-private updates=null
[junit4] 2> 95252 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: publishFlushedSegment
[junit4] 2> 95254 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: publish sets newSegment delGen=6 seg=_1(5.2.0):C369
[junit4] 2> 95254 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-271]: now checkpoint "_0(5.2.0):C31 _1(5.2.0):C369" [2
segments ; isCommit = false]
[junit4] 2> 95254 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-271]: 0 msec to checkpoint
[junit4] 2> 95254 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: apply all deletes during flush
[junit4] 2> 95255 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: now apply all deletes for all segments maxDoc=400
[junit4] 2> 95255 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 95255 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: applyDeletes: infos=[_0(5.2.0):C31, _1(5.2.0):C369]
packetCount=1
[junit4] 2> 95255 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: applyDeletes took 0 msec for 2 segments, 0 newly deleted
docs (query deletes), 0 visited terms, allDeleted=null
[junit4] 2> 95256 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: prune sis=segments_1: _0(5.2.0):C31 _1(5.2.0):C369
minGen=5 packetCount=1
[junit4] 2> 95256 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 95256 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-271]: qtp14445605-271 finishFullFlush success=true
[junit4] 2> 95257 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-271]: findMerges: 2 segments
[junit4] 2> 95257 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-271]: seg=_1(5.2.0):C369 size=0.010 MB [floored]
[junit4] 2> 95258 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-271]: seg=_0(5.2.0):C31 size=0.002 MB [floored]
[junit4] 2> 95258 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-271]: allowedSegmentCount=1 vs count=2 (eligible count=2)
tooBigCount=0
[junit4] 2> 95258 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[MS][qtp14445605-271]: initDynamicDefaults spins=true maxThreadCount=1
maxMergeCount=6
[junit4] 2> 95258 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[MS][qtp14445605-271]: now merge
[junit4] 2> 95258 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[MS][qtp14445605-271]: index: _0(5.2.0):C31 _1(5.2.0):C369
[junit4] 2> 95258 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[MS][qtp14445605-271]: no more merges pending; now return
[junit4] 2> 95259 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: startCommit(): start
[junit4] 2> 95259 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: startCommit index=_0(5.2.0):C31 _1(5.2.0):C369
changeCount=5
[junit4] 2> 95261 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: done all syncs: [_0.si, _0_Lucene50_0.doc,
_0_Lucene50_0.tim, _1.si, _1.nvd, _0_Lucene50_0.pos, _0.nvd, _0.fdx,
_0_Lucene50_0.tip, _1.nvm, _1.fnm, _0.fdt, _1_Lucene50_0.doc,
_1_Lucene50_0.tim, _1_Lucene50_0.pos, _1.fdx, _0.nvm, _0.fnm, _1.fdt,
_1_Lucene50_0.tip]
[junit4] 2> 95262 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: commit: pendingCommit != null
[junit4] 2> 95262 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-271]: now checkpoint "_0(5.2.0):C31 _1(5.2.0):C369" [2
segments ; isCommit = true]
[junit4] 2> 95262 T271 x:collection1 C97 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@9666b5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f33b45),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@9666b5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f33b45),segFN=segments_2,generation=2}
[junit4] 2> 95263 T271 x:collection1 C97
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 95264 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-271]: deleteCommits: now decRef commit "segments_1"
[junit4] 2> 95264 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-271]: delete "segments_1"
[junit4] 2> 95265 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-271]: 2 msec to checkpoint
[junit4] 2> 95265 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: commit: wrote segments file "segments_2"
[junit4] 2> 95266 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: commit: took 27.9 msec
[junit4] 2> 95266 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: commit: done
[junit4] 2> 95269 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: nrtIsCurrent: infoVersion matches: false; DW changes:
false; BD changes: false
[junit4] 2> 95270 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: flush at getReader
[junit4] 2> 95270 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-271]: startFullFlush
[junit4] 2> 95270 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: apply all deletes during flush
[junit4] 2> 95270 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: now apply all deletes for all segments maxDoc=400
[junit4] 2> 95271 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 95271 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: applyDeletes: no segments; skipping
[junit4] 2> 95272 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-271]: prune sis=segments_1: _0(5.2.0):C31 _1(5.2.0):C369
minGen=5 packetCount=0
[junit4] 2> 95273 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: return reader version=5
reader=StandardDirectoryReader(segments_1:5:nrt _0(5.2.0):C31 _1(5.2.0):C369)
[junit4] 2> 95275 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-271]: qtp14445605-271 finishFullFlush success=true
[junit4] 2> 95275 T271 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-271]: getReader took 5 msec
[junit4] 2> 95276 T271 x:collection1 C97 oass.SolrIndexSearcher.<init>
Opening Searcher@cbfcaf[collection1] main
[junit4] 2> 95276 T271 x:collection1 C97 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 95277 T274 x:collection1 C97 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 95278 T274 x:collection1 C97 oasu.DirectUpdateHandler2.commit
No uncommitted changes. Skipping IW.commit.
[junit4] 2> 95279 T274 x:collection1 C97 oasc.SolrCore.getSearcher WARN
[collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 95284 T274 x:collection1 C97 oasc.SolrCore.openNewSearcher
SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 95285 T274 x:collection1 C97 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 95294 T277 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update params={wt=javabin&version=2}
{add=[T4:0 (1500478621992615936), T4:1 (1500478621996810240), T4:2
(1500478621996810241), T4:3 (1500478621996810242), T4:4 (1500478621996810243),
T4:5 (1500478621996810244), T4:6 (1500478621996810245), T4:7
(1500478621996810246), T4:8 (1500478621996810247), T4:9 (1500478621996810248),
... (100 adds)]} 0 8
[junit4] 2> 95314 T273 x:collection1 C97 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 95317 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: commit: start
[junit4] 2> 95317 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: commit: enter lock
[junit4] 2> 95317 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: commit: now prepare
[junit4] 2> 95318 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: prepareCommit: flush
[junit4] 2> 95319 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: index before flush _0(5.2.0):C31 _1(5.2.0):C369
[junit4] 2> 95319 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-273]: startFullFlush
[junit4] 2> 95319 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-273]: anyChanges? numDocsInRam=100 deletes=true
hasTickets:false pendingChangesInFullFlush: false
[junit4] 2> 95319 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DWFC][qtp14445605-273]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 99 deleted terms (unique count=99) bytesUsed=13950,
segment=_2, aborted=false, numDocsInRAM=100, deleteQueue=DWDQ: [ generation: 4
]]
[junit4] 2> 95320 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-273]: flush postings as segment _2 numDocs=100
[junit4] 2> 95320 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-273]: new segment has 0 deleted docs
[junit4] 2> 95323 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-273]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 95323 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-273]: flushedFiles=[_2.nvd, _2.fdt, _2.nvm,
_2_Lucene50_0.pos, _2.fnm, _2.fdx, _2_Lucene50_0.doc, _2_Lucene50_0.tim,
_2_Lucene50_0.tip]
[junit4] 2> 95324 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-273]: flushed codec=Lucene50
[junit4] 2> 95324 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DWPT][qtp14445605-273]: flushed: segment=_2 ramUsed=0.114 MB
newFlushedSize=0.004 MB docs/MB=26,941.829
[junit4] 2> 95324 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-273]: publishFlushedSegment seg-private updates=null
[junit4] 2> 95324 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: publishFlushedSegment
[junit4] 2> 95325 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-273]: push deletes 100 deleted terms (unique count=100)
bytesUsed=1056 segmentPrivate?=false delGen=9 packetCount=1 totBytesUsed=1056
[junit4] 2> 95325 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: publish sets newSegment delGen=10 seg=_2(5.2.0):C100
[junit4] 2> 95325 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-273]: now checkpoint "_0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100" [3 segments ; isCommit = false]
[junit4] 2> 95326 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-273]: 0 msec to checkpoint
[junit4] 2> 95326 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: apply all deletes during flush
[junit4] 2> 95326 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: now apply all deletes for all segments maxDoc=500
[junit4] 2> 95326 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-273]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 95326 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-273]: applyDeletes: infos=[_0(5.2.0):C31, _1(5.2.0):C369,
_2(5.2.0):C100] packetCount=1
[junit4] 2> 95327 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-273]: applyTermDeletes took 0.2 msec for 3 segments and 1
packets; 100 del terms visited; 201 seg terms visited
[junit4] 2> 95327 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-273]: applyDeletes: 0 new deleted documents
[junit4] 2> 95328 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-273]: applyDeletes took 2 msec for 3 segments, 0 newly deleted
docs (query deletes), 100 visited terms, allDeleted=null
[junit4] 2> 95328 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-273]: prune sis=segments_1: _0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100 minGen=11 packetCount=1
[junit4] 2> 95328 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-273]: pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 95328 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-273]: qtp14445605-273 finishFullFlush success=true
[junit4] 2> 95328 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-273]: findMerges: 3 segments
[junit4] 2> 95330 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-273]: seg=_1(5.2.0):C369 size=0.010 MB [floored]
[junit4] 2> 95330 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-273]: seg=_2(5.2.0):C100 size=0.004 MB [floored]
[junit4] 2> 95330 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-273]: seg=_0(5.2.0):C31 size=0.002 MB [floored]
[junit4] 2> 95330 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[TMP][qtp14445605-273]: allowedSegmentCount=1 vs count=3 (eligible count=3)
tooBigCount=0
[junit4] 2> 95332 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[MS][qtp14445605-273]: now merge
[junit4] 2> 95332 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[MS][qtp14445605-273]: index: _0(5.2.0):C31 _1(5.2.0):C369 _2(5.2.0):C100
[junit4] 2> 95332 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[MS][qtp14445605-273]: no more merges pending; now return
[junit4] 2> 95333 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: startCommit(): start
[junit4] 2> 95333 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: startCommit index=_0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100 changeCount=8
[junit4] 2> 95333 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: done all syncs: [_0_Lucene50_0.doc, _1.si, _1.nvd,
_0.nvd, _2.fdt, _2_Lucene50_0.pos, _1.nvm, _1.fnm, _2.fdx, _2_Lucene50_0.tim,
_2_Lucene50_0.tip, _1_Lucene50_0.tim, _2.nvd, _1_Lucene50_0.pos, _2.nvm,
_2.fnm, _1.fdx, _1.fdt, _1_Lucene50_0.tip, _0.si, _0_Lucene50_0.tim, _2.si,
_0_Lucene50_0.pos, _0.fdx, _0_Lucene50_0.tip, _2_Lucene50_0.doc, _0.fdt,
_1_Lucene50_0.doc, _0.nvm, _0.fnm]
[junit4] 2> 95334 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: commit: pendingCommit != null
[junit4] 2> 95334 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-273]: now checkpoint "_0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100" [3 segments ; isCommit = true]
[junit4] 2> 95334 T273 x:collection1 C97 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@9666b5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f33b45),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@9666b5
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f33b45),segFN=segments_3,generation=3}
[junit4] 2> 95334 T273 x:collection1 C97
oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3
[junit4] 2> 95335 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-273]: deleteCommits: now decRef commit "segments_2"
[junit4] 2> 95335 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-273]: delete "segments_2"
[junit4] 2> 95337 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IFD][qtp14445605-273]: 2 msec to checkpoint
[junit4] 2> 95337 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: commit: wrote segments file "segments_3"
[junit4] 2> 95338 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: commit: took 16.9 msec
[junit4] 2> 95338 T273 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-273]: commit: done
[junit4] 2> 95339 T273 x:collection1 C97 oasc.SolrCore.getSearcher WARN
[collection1] Error opening new searcher. exceeded limit of
maxWarmingSearchers=2, try again later.
[junit4] 2> 95339 T273 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2} {}
0 25
[junit4] 2> 95339 T273 x:collection1 C97 oasc.SolrException.log Ignoring
exception matching maxWarmingSearchers
[junit4] 2> 95340 T289 oascs.LargeVolumeTestBase$DocThread.run Caught
benign exception during commit: Error from server at
http://127.0.0.1:57064/solr/collection1: Error opening new searcher. exceeded
limit of maxWarmingSearchers=2, try again later.
[junit4] 2> 95215 T272 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update params={wt=javabin&version=2}
{add=[T2:0 (1500478621912924160), T2:1 (1500478621915021312), T2:2
(1500478621915021313), T2:3 (1500478621915021314), T2:4 (1500478621915021315),
T2:5 (1500478621915021316), T2:6 (1500478621915021317), T2:7
(1500478621915021318), T2:8 (1500478621915021319), T2:9 (1500478621915021320),
... (100 adds)]} 0 5
[junit4] 2> 95207 T276 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update params={wt=javabin&version=2}
{add=[T3:0 (1500478621887758336), T3:1 (1500478621902438420), T3:2
(1500478621903486977), T3:3 (1500478621903486979), T3:4 (1500478621903486981),
T3:5 (1500478621903486983), T3:6 (1500478621903486985), T3:7
(1500478621903486987), T3:8 (1500478621903486989), T3:9 (1500478621903486991),
... (100 adds)]} 0 26
[junit4] 2> 95371 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@cbfcaf[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C31)
Uninverting(_1(5.2.0):C369)))}
[junit4] 2> 95371 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 95372 T281 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@cbfcaf[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C31)
Uninverting(_1(5.2.0):C369)))}
[junit4] 2> 95373 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@cbfcaf[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C31)
Uninverting(_1(5.2.0):C369)))}
[junit4] 2> 95373 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 95418 T274 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
{commit=} 0 176
[junit4] 2> 95420 T277 x:collection1 C97 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 95420 T277 x:collection1 C97 oasu.DirectUpdateHandler2.commit
No uncommitted changes. Skipping IW.commit.
[junit4] 2> 95421 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-277]: nrtIsCurrent: infoVersion matches: false; DW changes:
false; BD changes: false
[junit4] 2> 95421 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-277]: flush at getReader
[junit4] 2> 95422 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-277]: startFullFlush
[junit4] 2> 95423 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-277]: apply all deletes during flush
[junit4] 2> 95423 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-277]: now apply all deletes for all segments maxDoc=500
[junit4] 2> 95423 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-277]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 95424 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-277]: applyDeletes: no segments; skipping
[junit4] 2> 95424 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[BD][qtp14445605-277]: prune sis=segments_1: _0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100 minGen=11 packetCount=0
[junit4] 2> 95426 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-277]: return reader version=7
reader=StandardDirectoryReader(segments_1:7:nrt _0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100)
[junit4] 2> 95426 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[DW][qtp14445605-277]: qtp14445605-277 finishFullFlush success=true
[junit4] 2> 95427 T277 x:collection1 C97 oasu.LoggingInfoStream.message
[IW][qtp14445605-277]: getReader took 6 msec
[junit4] 2> 95427 T277 x:collection1 C97 oass.SolrIndexSearcher.<init>
Opening Searcher@1770b5d[collection1] main
[junit4] 2> 95428 T277 x:collection1 C97 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 95428 T271 x:collection1 C97 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
{commit=} 0 198
[junit4] 2> 95429 T273 x:collection1 C97 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 95429 T273 x:collection1 C97 oasu.DirectUpdateHandler2.commit
No uncommitted changes. Skipping IW.commit.
[junit4] 2> 95429 T273 x:collection1 C97 oasc.SolrCore.getSearcher WARN
[collection1] PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 95430 T273 x:collection1 C97 oasc.SolrCore.openNewSearcher
SolrIndexSearcher has not changed - not re-opening:
org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 95431 T273 x:collection1 C97 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 95433 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@1770b5d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C31)
Uninverting(_1(5.2.0):C369) Uninverting(_2(5.2.0):C100)))}
[junit4] 2> 95433 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> ASYNC NEW_CORE C98 name=collection1
org.apache.solr.core.SolrCore@131466
[junit4] 2> 95442 T272 x:collection1 C98 oasu.DirectUpdateHandler2.commit
start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 95442 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: forceMerge: index now _0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100
[junit4] 2> 95445 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: now flush at forceMerge
[junit4] 2> 95447 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: start flush: applyAllDeletes=true
[junit4] 2> 95448 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: index before flush _0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100
[junit4] 2> 95448 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[DW][qtp14445605-272]: startFullFlush
[junit4] 2> 95448 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[DW][qtp14445605-272]: qtp14445605-272 finishFullFlush success=true
[junit4] 2> 95448 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: apply all deletes during flush
[junit4] 2> 95448 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: now apply all deletes for all segments maxDoc=500
[junit4] 2> 95449 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[BD][qtp14445605-272]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 95449 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[BD][qtp14445605-272]: applyDeletes: no segments; skipping
[junit4] 2> 95449 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[BD][qtp14445605-272]: prune sis=segments_1: _0(5.2.0):C31 _1(5.2.0):C369
_2(5.2.0):C100 minGen=11 packetCount=0
[junit4] 2> 95449 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[TMP][qtp14445605-272]: findForcedMerges maxSegmentCount=1 infos=_0(5.2.0):C31
_1(5.2.0):C369 _2(5.2.0):C100 segmentsToMerge={_2(5.2.0):C100=true,
_0(5.2.0):C31=true, _1(5.2.0):C369=true}
[junit4] 2> 95451 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[TMP][qtp14445605-272]: eligible=[_1(5.2.0):C369, _2(5.2.0):C100, _0(5.2.0):C31]
[junit4] 2> 95452 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[TMP][qtp14445605-272]: forceMergeRunning=false
[junit4] 2> 95452 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[TMP][qtp14445605-272]: add final merge=_1(5.2.0):C369 _2(5.2.0):C100
_0(5.2.0):C31
[junit4] 2> 95452 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: add merge to pendingMerges: _1(5.2.0):C369
_2(5.2.0):C100 _0(5.2.0):C31 [total 1 pending]
[junit4] 2> 95452 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: registerMerge merging= []
[junit4] 2> 95452 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: registerMerge info=_1(5.2.0):C369
[junit4] 2> 95454 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: registerMerge info=_2(5.2.0):C100
[junit4] 2> 95454 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: registerMerge info=_0(5.2.0):C31
[junit4] 2> 95454 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[MS][qtp14445605-272]: now merge
[junit4] 2> 95454 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[MS][qtp14445605-272]: index: _0(5.2.0):C31 _1(5.2.0):C369 _2(5.2.0):C100
[junit4] 2> 95455 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[MS][qtp14445605-272]: consider merge _1(5.2.0):C369 _2(5.2.0):C100
_0(5.2.0):C31
[junit4] 2> 95456 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[MS][qtp14445605-272]: launch new thread [Lucene Merge Thread #0]
[junit4] 2> 95458 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[MS][qtp14445605-272]: updateMergeThreads ioThrottle=true targetMBPerSec=20.0
MB/sec
[junit4] 2> merge thread Lucene Merge Thread #0 estSize=0.0 MB
(written=0.0 MB) runTime=0.0s (stopped=0.0s, paused=0.0s) rate=unlimited
[junit4] 2> leave running at Infinity MB/sec
[junit4] 2> 95459 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[MS][qtp14445605-272]: no more merges pending; now return
[junit4] 2> 95461 T281 x:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@1770b5d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C31)
Uninverting(_1(5.2.0):C369) Uninverting(_2(5.2.0):C100)))}
[junit4] 2> 95462 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@1770b5d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.2.0):C31)
Uninverting(_1(5.2.0):C369) Uninverting(_2(5.2.0):C100)))}
[junit4] 2> 95462 T281 x:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 95462 T273 x:collection1 C98 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
{commit=} 0 33
[junit4] 2> 95463 T290 x:collection1 oasu.LoggingInfoStream.message
[MS][Lucene Merge Thread #0]: merge thread: start
[junit4] 2> 95465 T277 x:collection1 C98 oasup.LogUpdateProcessor.finish
[collection1] webapp=/solr path=/update
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}
{commit=} 0 45
[junit4] 2> 95470 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: now apply deletes for 3 merging segments
[junit4] 2> 95470 T290 x:collection1 oasu.LoggingInfoStream.message
[BD][Lucene Merge Thread #0]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 95470 T290 x:collection1 oasu.LoggingInfoStream.message
[BD][Lucene Merge Thread #0]: applyDeletes: no segments; skipping
[junit4] 2> 95470 T290 x:collection1 oasu.LoggingInfoStream.message
[BD][Lucene Merge Thread #0]: prune sis=segments_1: _0(5.2.0):C31
_1(5.2.0):C369 _2(5.2.0):C100 minGen=11 packetCount=0
[junit4] 2> 95470 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: merge seg=_3 _1(5.2.0):C369 _2(5.2.0):C100
_0(5.2.0):C31
[junit4] 2> 95471 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: now merge
[junit4] 2> merge=_1(5.2.0):C369 _2(5.2.0):C100 _0(5.2.0):C31
[junit4] 2> index=_0(5.2.0):C31 _1(5.2.0):C369 _2(5.2.0):C100
[junit4] 2> 95471 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: merging _1(5.2.0):C369 _2(5.2.0):C100
_0(5.2.0):C31
[junit4] 2> 95471 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: seg=_1(5.2.0):C369 no deletes
[junit4] 2> 95471 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: seg=_2(5.2.0):C100 no deletes
[junit4] 2> 95471 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: seg=_0(5.2.0):C31 no deletes
[junit4] 2> 95471 T290 x:collection1 oasu.LoggingInfoStream.message
[SM][Lucene Merge Thread #0]: merge store matchedCount=3 vs 3
[junit4] 2> 95473 T290 x:collection1 oasu.LoggingInfoStream.message
[SM][Lucene Merge Thread #0]: 1 msec to merge stored fields [500 docs]
[junit4] 2> 95476 T290 x:collection1 oasu.LoggingInfoStream.message
[SM][Lucene Merge Thread #0]: 2 msec to merge postings [500 docs]
[junit4] 2> 95476 T290 x:collection1 oasu.LoggingInfoStream.message
[SM][Lucene Merge Thread #0]: 0 msec to merge doc values [500 docs]
[junit4] 2> 95477 T290 x:collection1 oasu.LoggingInfoStream.message
[SM][Lucene Merge Thread #0]: 0 msec to merge norms [500 docs]
[junit4] 2> 95477 T290 x:collection1 oasu.LoggingInfoStream.message
[SM][Lucene Merge Thread #0]: 0 msec to write field infos [500 docs]
[junit4] 2> 95477 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: merge codec=Lucene50 maxDoc=500; merged segment
has no vectors; norms; no docValues; prox; freqs; 0.0 sec (0.0 sec stopped, 0.0
sec paused) to merge segment [0.01 MB, 2.80 MB/sec]
[junit4] 2> 95477 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: merged segment size=0.013 MB vs estimate=0.017 MB
[junit4] 2> 95477 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: commitMerge: _1(5.2.0):C369 _2(5.2.0):C100
_0(5.2.0):C31 index=_0(5.2.0):C31 _1(5.2.0):C369 _2(5.2.0):C100
[junit4] 2> 95477 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: commitMergeDeletes _1(5.2.0):C369 _2(5.2.0):C100
_0(5.2.0):C31
[junit4] 2> 95477 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: no new deletes or field updates since merge
started
[junit4] 2> 95478 T290 x:collection1 oasu.LoggingInfoStream.message
[IFD][Lucene Merge Thread #0]: now checkpoint "_3(5.2.0):C500" [1 segments ;
isCommit = false]
[junit4] 2> 95478 T290 x:collection1 oasu.LoggingInfoStream.message
[IFD][Lucene Merge Thread #0]: 0 msec to checkpoint
[junit4] 2> 95478 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: after commitMerge: _3(5.2.0):C500
[junit4] 2> 95478 T290 x:collection1 oasu.LoggingInfoStream.message
[TMP][Lucene Merge Thread #0]: findForcedMerges maxSegmentCount=1
infos=_3(5.2.0):C500 segmentsToMerge={_2(5.2.0):C100=true, _0(5.2.0):C31=true,
_1(5.2.0):C369=true, _3(5.2.0):C500=false}
[junit4] 2> 95478 T290 x:collection1 oasu.LoggingInfoStream.message
[TMP][Lucene Merge Thread #0]: already merged
[junit4] 2> 95479 T290 x:collection1 oasu.LoggingInfoStream.message
[IW][Lucene Merge Thread #0]: merge time 9 msec for 500 docs
[junit4] 2> 95479 T290 x:collection1 oasu.LoggingInfoStream.message
[MS][Lucene Merge Thread #0]: merge thread: done
[junit4] 2> 95479 T290 x:collection1 oasu.LoggingInfoStream.message
[MS][Lucene Merge Thread #0]: now merge
[junit4] 2> 95479 T290 x:collection1 oasu.LoggingInfoStream.message
[MS][Lucene Merge Thread #0]: index: _3(5.2.0):C500
[junit4] 2> 95479 T290 x:collection1 oasu.LoggingInfoStream.message
[MS][Lucene Merge Thread #0]: no more merges pending; now return
[junit4] 2> 95480 T290 x:collection1 oasu.LoggingInfoStream.message
[MS][Lucene Merge Thread #0]: updateMergeThreads ioThrottle=true
targetMBPerSec=20.0 MB/sec
[junit4] 2> 95484 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: commit: start
[junit4] 2> 95484 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: commit: enter lock
[junit4] 2> 95484 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: commit: now prepare
[junit4] 2> 95485 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: prepareCommit: flush
[junit4] 2> 95485 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: index before flush _3(5.2.0):C500
[junit4] 2> 95485 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[DW][qtp14445605-272]: startFullFlush
[junit4] 2> 95485 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: apply all deletes during flush
[junit4] 2> 95486 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[IW][qtp14445605-272]: now apply all deletes for all segments maxDoc=500
[junit4] 2> 95486 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[BD][qtp14445605-272]: applyDeletes: open segment readers took 0 msec
[junit4] 2> 95486 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[BD][qtp14445605-272]: applyDeletes: no segments; skipping
[junit4] 2> 95486 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[BD][qtp14445605-272]: prune sis=segments_1: _3(5.2.0):C500 minGen=11
packetCount=0
[junit4] 2> 95486 T272 x:collection1 C98 oasu.LoggingInfoStream.message
[DW][qtp14445605-272]: qtp14445605-272 finishFullFlush success=true
[junit4] 2>
[...truncated too long message...]
at org.apache.solr.update.UpdateLog.ensureLog(UpdateLog.java:852)
[junit4] 2> at
org.apache.solr.update.UpdateLog.add(UpdateLog.java:414)
[junit4] 2> at
org.apache.solr.update.UpdateLog.add(UpdateLog.java:400)
[junit4] 2> at
org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:258)
[junit4] 2> at
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:163)
[junit4] 2> at
org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69)
[junit4] 2> at
org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:955)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1110)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:706)
[junit4] 2> at
org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104)
[junit4] 2> at
org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250)
[junit4] 2> at
org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177)
[junit4] 2> at
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98)
[junit4] 2> at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143)
[junit4] 2> at
org.apache.solr.core.SolrCore.execute(SolrCore.java:2047)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:578)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:378)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:176)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:169)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:105)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at
org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
[junit4] 2> at
org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:300)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:497)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> NOTE: test params are: codec=Lucene50,
sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=en_IE,
timezone=Europe/San_Marino
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_45
(32-bit)/cpus=3,threads=1,free=25850392,total=66637824
[junit4] 2> NOTE: All tests run in this JVM: [QueryResponseTest,
SolrPingTest, SolrSchemalessExampleTest, SolrExampleJettyTest,
TestNamedListCodec, TestZkConfigManager, LargeVolumeBinaryJettyTest,
MergeIndexesEmbeddedTest, SolrExceptionTest, SolrExampleBinaryTest,
ClientUtilsTest, LargeVolumeEmbeddedTest, BasicHttpSolrClientTest,
SolrExampleStreamingBinaryTest, SolrExampleXMLTest, TestBatchUpdate,
TestSpellCheckResponse, LargeVolumeJettyTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=LargeVolumeJettyTest -Dtests.seed=5AEA969D5ED84A9C -Dtests.slow=true
-Dtests.locale=en_IE -Dtests.timezone=Europe/San_Marino -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | LargeVolumeJettyTest (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: Some resources were
not closed, shutdown, or released.
[junit4] > at
__randomizedtesting.SeedInfo.seed([5AEA969D5ED84A9C]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:234)
[junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2:
java.io.IOException: Could not remove the following files (in the order of
attempts):
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog\tlog.0000000000000000002:
The process cannot access the file because it is being used by another process.
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data\tlog
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1\data
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001\collection1
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001\tempDir-001
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeJettyTest
5AEA969D5ED84A9C-001
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:294)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [33/57] on J1 in 1.88s, 1 test, 1 failure, 1 error <<<
FAILURES!
[...truncated 82 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:536: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:484: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:242: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:511:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1433:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:991:
There were test failures: 57 suites, 381 tests, 2 suite-level errors
Total time: 64 minutes 17 seconds
Build step 'Invoke Ant' marked build as failure
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]