Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4393/
Java: 64bit/jdk1.8.0_20 -XX:-UseCompressedOops -XX:+UseSerialGC (asserts: false)
1 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.embedded.LargeVolumeEmbeddedTest
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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001
at __randomizedtesting.SeedInfo.seed([C6AF373F8E6FDC52]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:289)
at
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:170)
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 10778 lines...]
[junit4] Suite: org.apache.solr.client.solrj.embedded.LargeVolumeEmbeddedTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001
[junit4] 2> 176888 T446 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 177550 T446 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 177550 T446 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\'
[junit4] 2> 177614 T446 oasc.SolrConfig.initLibs Adding specified lib dirs
to ClassLoader
[junit4] 2> 177614 T446 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\contrib\extraction\lib).
[junit4] 2> 177616 T446 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\dist).
[junit4] 2> 177616 T446 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\contrib\clustering\lib).
[junit4] 2> 177616 T446 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\dist).
[junit4] 2> 177619 T446 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\contrib\langid\lib).
[junit4] 2> 177619 T446 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\dist).
[junit4] 2> 177620 T446 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\contrib\velocity\lib).
[junit4] 2> 177620 T446 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\dist).
[junit4] 2> 177643 T446 oasu.SolrIndexConfig.<init> IndexWriter infoStream
solr logging is enabled
[junit4] 2> 177644 T446 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 177693 T446 oasc.SolrConfig.<init> Loaded SolrConfig:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001/collection1/conf/solrconfig.xml
[junit4] 2> 177697 T446 oass.IndexSchema.readSchema Reading Solr Schema
from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf\C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001/collection1/conf/schema.xml
[junit4] 2> 177704 T446 oass.IndexSchema.readSchema [null] Schema
name=example
[junit4] 2> 178012 T446 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 178015 T446 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path
/schema/analysis/stopwords/english
[junit4] 2> 178015 T446 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager
for path /schema/analysis/synonyms/english
[junit4] 2> 178053 T446 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 178060 T446 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 178100 T446 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 178100 T446 oasc.SolrResourceLoader.locateSolrHome using
system property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001
[junit4] 2> 178107 T446 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\'
[junit4] 2> 178160 T446 oasc.CoreContainer.<init> New CoreContainer
567817790
[junit4] 2> 178161 T446 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\]
[junit4] 2> 178161 T446 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 0
[junit4] 2> 178161 T446 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 178161 T446 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 0
[junit4] 2> 178161 T446 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 178162 T446 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnections to: 10000
[junit4] 2> 178162 T446 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 178162 T446 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 178162 T446 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 178162 T446 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 178162 T446 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 178162 T446 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=false
[junit4] 2> 178162 T446 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 178163 T446 oasl.LogWatcher.newRegisteredLogWatcher
Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 178163 T446 oasc.CoreContainer.load Host Name:
[junit4] 2> 178169 T447 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1/'
[junit4] 2> 178196 T447 oasc.SolrConfig.initLibs Adding specified lib dirs
to ClassLoader
[junit4] 2> 178196 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\contrib\extraction\lib).
[junit4] 2> 178196 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\dist).
[junit4] 2> 178196 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\contrib\clustering\lib).
[junit4] 2> 178196 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\dist).
[junit4] 2> 178196 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\contrib\langid\lib).
[junit4] 2> 178197 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\dist).
[junit4] 2> 178197 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\contrib\velocity\lib).
[junit4] 2> 178198 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\..\..\..\dist).
[junit4] 2> 178231 T447 oasu.SolrIndexConfig.<init> IndexWriter infoStream
solr logging is enabled
[junit4] 2> 178234 T447 oasc.SolrConfig.<init> Using Lucene MatchVersion:
5.0.0
[junit4] 2> 178276 T447 oasc.SolrConfig.<init> Loaded SolrConfig:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001/collection1/conf/solrconfig.xml
[junit4] 2> 178277 T447 oass.IndexSchema.readSchema Reading Solr Schema
from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1/conf\C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001/collection1/conf/schema.xml
[junit4] 2> 178283 T447 oass.IndexSchema.readSchema [collection1] Schema
name=example
[junit4] 2> 178707 T447 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 178715 T447 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path
/schema/analysis/stopwords/english
[junit4] 2> 178715 T447 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager
for path /schema/analysis/synonyms/english
[junit4] 2> 178741 T447 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 178750 T447 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 178810 T447 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from instancedir
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1/
[junit4] 2> 178810 T447 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 178810 T447 oasc.SolrCore.<init> [collection1] Opening new
SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1/,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\
[junit4] 2> 178810 T447 oasc.JmxMonitoredMap.<init> JMX monitoring is
enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@66f59af9
[junit4] 2> 178811 T447 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for newSearcher:
org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 178811 T447 oasc.SolrCore.initListeners [collection1] Added
SolrEventListener for firstSearcher:
org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher
warming in solrconfig.xml}]}
[junit4] 2> 178811 T447 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\
[junit4] 2> 178812 T447 oasc.SolrCore.getNewIndexDir New index directory
detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\index/
[junit4] 2> 178812 T447 oasc.SolrCore.initIndex WARN [collection1] Solr
index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\index'
doesn't exist. Creating new index...
[junit4] 2> 178812 T447 oasc.CachingDirectoryFactory.get return new
directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\index
[junit4] 2> 178813 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: init: current segments file is
"segments";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@10b158c7
[junit4] 2> 178814 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: now checkpoint "" [0 segments ; isCommit
= false]
[junit4] 2> 178815 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: 0 msec to checkpoint
[junit4] 2> 178815 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: init: create=true
[junit4] 2> 178815 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@3d216992
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45c99d48)
[junit4] 2> index=
[junit4] 2> version=5.0.0
[junit4] 2> analyzer=null
[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=2, mergeThreadPriority=-1
[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@50428edb
[junit4] 2> readerPooling=false
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> writer=org.apache.lucene.util.SetOnce@661900b8
[junit4] 2>
[junit4] 2> 178815 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: now flush at close
[junit4] 2> 178815 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: start flush: applyAllDeletes=true
[junit4] 2> 178815 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: index before flush
[junit4] 2> 178815 T447 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-256-thread-1]: startFullFlush
[junit4] 2> 178815 T447 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-256-thread-1]: coreLoadExecutor-256-thread-1
finishFullFlush success=true
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: apply all deletes during flush
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-256-thread-1]: prune sis=segments:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[CMS][coreLoadExecutor-256-thread-1]: now merge
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[CMS][coreLoadExecutor-256-thread-1]: index:
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[CMS][coreLoadExecutor-256-thread-1]: no more merges pending; now return
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: waitForMerges
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: waitForMerges done
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: commit: start
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: commit: enter lock
[junit4] 2> 178816 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: commit: now prepare
[junit4] 2> 178817 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: prepareCommit: flush
[junit4] 2> 178818 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: index before flush
[junit4] 2> 178818 T447 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-256-thread-1]: startFullFlush
[junit4] 2> 178818 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: apply all deletes during flush
[junit4] 2> 178819 T447 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-256-thread-1]: prune sis=segments:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 178819 T447 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-256-thread-1]: coreLoadExecutor-256-thread-1
finishFullFlush success=true
[junit4] 2> 178820 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: startCommit(): start
[junit4] 2> 178820 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: startCommit index= changeCount=1
[junit4] 2> 178820 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: done all syncs: []
[junit4] 2> 178820 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: commit: pendingCommit != null
[junit4] 2> 178820 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: now checkpoint "" [0 segments ; isCommit
= true]
[junit4] 2> 178820 T447 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3d216992
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45c99d48),segFN=segments_1,generation=1}
[junit4] 2> 178822 T447 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 178822 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: 0 msec to checkpoint
[junit4] 2> 178822 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: commit: wrote segments file "segments_1"
[junit4] 2> 178822 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: commit: took 4.6 msec
[junit4] 2> 178822 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: commit: done
[junit4] 2> 178823 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: rollback
[junit4] 2> 178823 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: all running merges have aborted
[junit4] 2> 178823 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: rollback: done finish merges
[junit4] 2> 178823 T447 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-256-thread-1]: abort
[junit4] 2> 178823 T447 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-256-thread-1]: done abort success=true
[junit4] 2> 178824 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: rollback: infos=
[junit4] 2> 178824 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: now checkpoint "" [0 segments ; isCommit
= false]
[junit4] 2> 178824 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: 0 msec to checkpoint
[junit4] 2> 178824 T447 oasc.SolrCore.initWriters created json:
solr.JSONResponseWriter
[junit4] 2> 178825 T447 oasc.SolrCore.initWriters adding lazy
queryResponseWriter: solr.VelocityResponseWriter
[junit4] 2> 178825 T447 oasc.SolrCore.initWriters created velocity:
solr.VelocityResponseWriter
[junit4] 2> 178825 T447 oasc.SolrCore.initWriters created xslt:
solr.XSLTResponseWriter
[junit4] 2> 178825 T447 oasr.XSLTResponseWriter.init
xsltCacheLifetimeSeconds=5
[junit4] 2> 178828 T447 oasc.SolrCore.loadUpdateProcessorChains no
updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 178830 T447 oasc.RequestHandlers.initHandlersFromConfig
created /update: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 178830 T447 oasc.RequestHandlers.initHandlersFromConfig
created /update/json: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 178830 T447 oasc.RequestHandlers.initHandlersFromConfig
created /update/csv: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 178831 T447 oasc.RequestHandlers.initHandlersFromConfig
created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler
[junit4] 2> 178831 T447 oasc.RequestHandlers.initHandlersFromConfig
created /config: org.apache.solr.handler.SolrConfigHandler
[junit4] 2> 178831 T447 oasc.RequestHandlers.initHandlersFromConfig
created /schema: org.apache.solr.handler.SchemaHandler
[junit4] 2> 178832 T447 oasc.RequestHandlers.initHandlersFromConfig
created /replication: org.apache.solr.handler.ReplicationHandler
[junit4] 2> 178832 T447 oasc.RequestHandlers.initHandlersFromConfig
created /get: org.apache.solr.handler.RealTimeGetHandler
[junit4] 2> 178833 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler
[junit4] 2> 178834 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler
[junit4] 2> 178835 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler
[junit4] 2> 178835 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler
[junit4] 2> 178836 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler
[junit4] 2> 178837 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/properties:
org.apache.solr.handler.admin.PropertiesRequestHandler
[junit4] 2> 178837 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/logging: org.apache.solr.handler.admin.LoggingHandler
[junit4] 2> 178838 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/file: org.apache.solr.handler.admin.ShowFileRequestHandler
[junit4] 2> 178838 T447 oasc.RequestHandlers.initHandlersFromConfig
created /admin/ping: org.apache.solr.handler.PingRequestHandler
[junit4] 2> 178839 T447 oasc.RequestHandlers.initHandlersFromConfig
created /select: solr.SearchHandler
[junit4] 2> 178839 T447 oasc.RequestHandlers.initHandlersFromConfig
created /query: solr.SearchHandler
[junit4] 2> 178840 T447 oasc.RequestHandlers.initHandlersFromConfig
created /export: solr.SearchHandler
[junit4] 2> 178840 T447 oasc.RequestHandlers.initHandlersFromConfig
created /browse: solr.SearchHandler
[junit4] 2> 178840 T447 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.extraction.ExtractingRequestHandler
[junit4] 2> 178841 T447 oasc.RequestHandlers.initHandlersFromConfig
created /update/extract: solr.extraction.ExtractingRequestHandler
[junit4] 2> 178841 T447 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4] 2> 178841 T447 oasc.RequestHandlers.initHandlersFromConfig
created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4] 2> 178841 T447 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4] 2> 178841 T447 oasc.RequestHandlers.initHandlersFromConfig
created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4] 2> 178842 T447 oasc.RequestHandlers.initHandlersFromConfig
created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 178842 T447 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.SearchHandler
[junit4] 2> 178843 T447 oasc.RequestHandlers.initHandlersFromConfig
created /spell: solr.SearchHandler
[junit4] 2> 178843 T447 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.SearchHandler
[junit4] 2> 178843 T447 oasc.RequestHandlers.initHandlersFromConfig
created /tvrh: solr.SearchHandler
[junit4] 2> 178843 T447 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.SearchHandler
[junit4] 2> 178844 T447 oasc.RequestHandlers.initHandlersFromConfig
created /terms: solr.SearchHandler
[junit4] 2> 178844 T447 oasc.RequestHandlers.initHandlersFromConfig adding
lazy requestHandler: solr.SearchHandler
[junit4] 2> 178844 T447 oasc.RequestHandlers.initHandlersFromConfig
created /elevate: solr.SearchHandler
[junit4] 2> 178852 T447 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 178854 T447 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 178855 T447 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 178858 T447 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 178862 T447 oasu.CommitTracker.<init> Hard AutoCommit: if
uncommited for 15000ms;
[junit4] 2> 178863 T447 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4] 2> 178867 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: init: current segments file is
"segments_1";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@10b158c7
[junit4] 2> 178867 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: init: load commit "segments_1"
[junit4] 2> 178867 T447 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3d216992
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45c99d48),segFN=segments_1,generation=1}
[junit4] 2> 178867 T447 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 1
[junit4] 2> 178867 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: now checkpoint "" [0 segments ; isCommit
= false]
[junit4] 2> 178867 T447 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-256-thread-1]: 0 msec to checkpoint
[junit4] 2> 178867 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: init: create=false
[junit4] 2> 178868 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@3d216992
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45c99d48)
[junit4] 2> index=
[junit4] 2> version=5.0.0
[junit4] 2> analyzer=null
[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=2, mergeThreadPriority=-1
[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@3a105c99
[junit4] 2> readerPooling=false
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> writer=org.apache.lucene.util.SetOnce@76ebb417
[junit4] 2>
[junit4] 2> 178868 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: flush at getReader
[junit4] 2> 178868 T447 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-256-thread-1]: startFullFlush
[junit4] 2> 178868 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: apply all deletes during flush
[junit4] 2> 178868 T447 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-256-thread-1]: prune sis=segments_1:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 178868 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: return reader version=1
reader=StandardDirectoryReader(segments_1:1:nrt)
[junit4] 2> 178868 T447 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-256-thread-1]: coreLoadExecutor-256-thread-1
finishFullFlush success=true
[junit4] 2> 178868 T447 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-256-thread-1]: getReader took 0 msec
[junit4] 2> 178868 T447 oass.SolrIndexSearcher.<init> Opening
Searcher@6fe89de0[collection1] main
[junit4] 2> 178868 T447
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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf
[junit4] 2> 178868 T447 oasr.RestManager.init Initializing RestManager
with initArgs:
{storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf}
[junit4] 2> 178868 T447 oasr.ManagedResourceStorage.load Reading
_rest_managed.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf
[junit4] 2> 178869 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf
[junit4] 2> 178869 T447 oasr.ManagedResource.reloadFromStorage Loaded
initArgs {} for /rest/managed
[junit4] 2> 178869 T447 oasr.RestManager.init Initializing 2 registered
ManagedResources
[junit4] 2> 178869 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf
[junit4] 2> 178871 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf
[junit4] 2> 178871 T447 oasr.ManagedResource.reloadFromStorage Loaded
initArgs {ignoreCase=true} for /schema/analysis/stopwords/english
[junit4] 2> 178871 T447
oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 35 words
for /schema/analysis/stopwords/english
[junit4] 2> 178871 T447 oasr.ManagedResource.notifyObserversDuringInit
Notified 1 observers of /schema/analysis/stopwords/english
[junit4] 2> 178871 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf
[junit4] 2> 178871 T447 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf
[junit4] 2> 178871 T447 oasr.ManagedResource.reloadFromStorage Loaded
initArgs {ignoreCase=true,format=solr} for /schema/analysis/synonyms/english
[junit4] 2> 178872 T447
oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage
Loaded 3 synonym mappings for /schema/analysis/synonyms/english
[junit4] 2> 178872 T447 oasr.ManagedResource.notifyObserversDuringInit
Notified 1 observers of /schema/analysis/synonyms/english
[junit4] 2> 178872 T447 oashc.SpellCheckComponent.inform Initializing
spell checkers
[junit4] 2> 178873 T447 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> 178873 T447 oashc.SpellCheckComponent.inform No queryConverter
defined, using default converter
[junit4] 2> 178877 T447 oashc.QueryElevationComponent.inform Loading
QueryElevation from:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\tempDir-001\collection1\conf\elevate.xml
[junit4] 2> 178886 T447 oash.ReplicationHandler.inform Commits will be
reserved for 10000
[junit4] 2> 178886 T448 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@6fe89de0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> ASYNC NEW_CORE C113 name=collection1
org.apache.solr.core.SolrCore@524d7ffa
[junit4] 2> 178895 T448 C113 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=0
[junit4] 2> 178895 T448 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 178895 T448
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 178895 T448
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 178895 T448 oasc.SolrCore.registerSearcher [collection1]
Registered new searcher Searcher@6fe89de0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 178888 T447 oasc.CoreContainer.registerCore registering core:
collection1
[junit4] 2> 178902 T446 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 178908 T446 oas.SolrTestCaseJ4.setUp ###Starting
testMultiThreaded
[junit4] 2> 178913 T446 C113 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 178913 T446 C113 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 178914 T446 C113 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
nrtIsCurrent: infoVersion matches: true; DW changes: true; BD changes: false
[junit4] 2> 178914 T446 C113 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
flush at getReader
[junit4] 2> 178914 T446 C113 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
startFullFlush
[junit4] 2> 178915 T446 C113 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 178915 T446 C113 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]: flush
naked frozen global deletes
[junit4] 2> 178916 T446 C113 oasu.LoggingInfoStream.message
[BD][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
push deletes 1 deleted queries bytesUsed=84 delGen=2 packetCount=1
totBytesUsed=84
[junit4] 2> 178916 T446 C113 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
flush: push buffered updates: 1 deleted queries bytesUsed=84
[junit4] 2> 178917 T446 C113 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
apply all deletes during flush
[junit4] 2> 178917 T446 C113 oasu.LoggingInfoStream.message
[BD][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
prune sis=segments_1: minGen=9223372036854775807 packetCount=1
[junit4] 2> 178917 T446 C113 oasu.LoggingInfoStream.message
[BD][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 178918 T446 C113 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
return reader version=1 reader=StandardDirectoryReader(segments_1:1:nrt)
[junit4] 2> 178918 T446 C113 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]
finishFullFlush success=true
[junit4] 2> 178918 T446 C113 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[C6AF373F8E6FDC52]]:
getReader took 4 msec
[junit4] 2> 178920 T446 C113 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {deleteByQuery=*:* (-1487864525677920256)} 0
11
[junit4] 2> 178920 T446 oascs.LargeVolumeTestBase.testMultiThreaded
Started thread: 0
[junit4] 2> 178921 T446 oascs.LargeVolumeTestBase.testMultiThreaded
Started thread: 1
[junit4] 2> 178921 T446 oascs.LargeVolumeTestBase.testMultiThreaded
Started thread: 2
[junit4] 2> 178922 T446 oascs.LargeVolumeTestBase.testMultiThreaded
Started thread: 3
[junit4] 2> 178922 T446 oascs.LargeVolumeTestBase.testMultiThreaded
Started thread: 4
[junit4] 2> 178936 T453 C113 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T2:0 (1487864525699940355), T2:1
(1487864525699940357), T2:2 (1487864525699940358), T2:3 (1487864525699940359),
T2:4 (1487864525700988928), T2:5 (1487864525700988929), T2:6
(1487864525700988930), T2:7 (1487864525700988931), T2:8 (1487864525700988932),
T2:9 (1487864525700988933), ... (100 adds)]} 0 7
[junit4] 2> 178937 T453 C113 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 178937 T453 C113 oasu.LoggingInfoStream.message
[IW][DocThread-2]: commit: start
[junit4] 2> 178937 T453 C113 oasu.LoggingInfoStream.message
[IW][DocThread-2]: commit: enter lock
[junit4] 2> 178937 T453 C113 oasu.LoggingInfoStream.message
[IW][DocThread-2]: commit: now prepare
[junit4] 2> 178937 T453 C113 oasu.LoggingInfoStream.message
[IW][DocThread-2]: prepareCommit: flush
[junit4] 2> 178937 T453 C113 oasu.LoggingInfoStream.message
[IW][DocThread-2]: index before flush
[junit4] 2> 178937 T453 C113 oasu.LoggingInfoStream.message
[DW][DocThread-2]: startFullFlush
[junit4] 2> 178937 T453 C113 oasu.LoggingInfoStream.message
[DW][DocThread-2]: anyChanges? numDocsInRam=145 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 178939 T453 C113 oasu.LoggingInfoStream.message
[DWFC][DocThread-2]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 144 deleted terms (unique count=144) bytesUsed=33532,
segment=_0, aborted=false, numDocsInRAM=145, deleteQueue=DWDQ: [ generation: 2
]]
[junit4] 2> 178956 T451 C113 oasu.LoggingInfoStream.message
[DWFC][DocThread-0]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0, segment=_2, aborted=false, numDocsInRAM=1,
deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 178966 T451 C113 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T0:0 (1487864525696794624), T0:1
(1487864525697843200), T0:2 (1487864525697843201), T0:3 (1487864525697843202),
T0:4 (1487864525697843203), T0:5 (1487864525697843204), T0:6
(1487864525697843205), T0:7 (1487864525697843206), T0:8 (1487864525697843207),
T0:9 (1487864525697843208), ... (100 adds)]} 0 39
[junit4] 2> 178967 T454 C113 oasu.LoggingInfoStream.message
[DWFC][DocThread-3]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0, segment=_1, aborted=false, numDocsInRAM=1,
deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 178970 T453 C113 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flush postings as segment _0 numDocs=145
[junit4] 2> ASYNC NEW_CORE C114 name=collection1
org.apache.solr.core.SolrCore@524d7ffa
[junit4] 2> 178980 T454 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: flush postings as segment _2 numDocs=1
[junit4] 2> 178981 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has 0 deleted docs
[junit4] 2> 178981 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 178981 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: 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> 178981 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed codec=Lucene50
[junit4] 2> 178981 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed: segment=_0 ramUsed=0.138 MB
newFlushedSize(includes docstores)=0.005 MB docs/MB=30,796.743
[junit4] 2> 178981 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flush postings as segment _1 numDocs=1
[junit4] 2> 178981 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has 0 deleted docs
[junit4] 2> 178982 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 178984 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: 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> 178984 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed codec=Lucene50
[junit4] 2> 178984 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed: segment=_1 ramUsed=0.096 MB
newFlushedSize(includes docstores)=0.001 MB docs/MB=733.783
[junit4] 2> 178988 T454 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: new segment has 0 deleted docs
[junit4] 2> 178988 T454 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 178988 T454 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: 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> 178988 T454 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: flushed codec=Lucene50
[junit4] 2> 178988 T454 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: flushed: segment=_2 ramUsed=0.096 MB
newFlushedSize(includes docstores)=0.001 MB docs/MB=731.735
[junit4] 2> 178988 T454 C114 oasu.LoggingInfoStream.message
[DW][DocThread-3]: publishFlushedSegment seg-private updates=null
[junit4] 2> 178988 T454 C114 oasu.LoggingInfoStream.message
[IW][DocThread-3]: publishFlushedSegment
[junit4] 2> 178990 T454 C114 oasu.LoggingInfoStream.message
[BD][DocThread-3]: push deletes 147 deleted terms (unique count=147)
bytesUsed=1072 delGen=4 packetCount=1 totBytesUsed=1072
[junit4] 2> 178990 T454 C114 oasu.LoggingInfoStream.message
[IW][DocThread-3]: publish sets newSegment delGen=5 seg=_0(5.0.0):C145
[junit4] 2> 178991 T454 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-3]: now checkpoint "_0(5.0.0):C145" [1 segments ; isCommit =
false]
[junit4] 2> 178991 T454 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-3]: 0 msec to checkpoint
[junit4] 2> 178991 T454 C114 oasu.LoggingInfoStream.message
[DW][DocThread-3]: publishFlushedSegment seg-private updates=null
[junit4] 2> 178991 T454 C114 oasu.LoggingInfoStream.message
[IW][DocThread-3]: publishFlushedSegment
[junit4] 2> 178991 T454 C114 oasu.LoggingInfoStream.message
[IW][DocThread-3]: publish sets newSegment delGen=6 seg=_2(5.0.0):C1
[junit4] 2> 178991 T454 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-3]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1" [2 segments ;
isCommit = false]
[junit4] 2> 178991 T454 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-3]: 0 msec to checkpoint
[junit4] 2> 178992 T454 C114 oasu.LoggingInfoStream.message
[DW][DocThread-3]: publishFlushedSegment seg-private updates=null
[junit4] 2> 178992 T454 C114 oasu.LoggingInfoStream.message
[IW][DocThread-3]: publishFlushedSegment
[junit4] 2> 178992 T454 C114 oasu.LoggingInfoStream.message
[IW][DocThread-3]: publish sets newSegment delGen=7 seg=_1(5.0.0):C1
[junit4] 2> 178992 T454 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-3]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1"
[3 segments ; isCommit = false]
[junit4] 2> 178992 T454 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-3]: 0 msec to checkpoint
[junit4] 2> 178992 T454 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-3]: findMerges: 3 segments
[junit4] 2> 178994 T454 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-3]: seg=_0(5.0.0):C145 size=0.005 MB [floored]
[junit4] 2> 178994 T454 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-3]: seg=_2(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 178994 T454 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-3]: seg=_1(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 178994 T454 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-3]: allowedSegmentCount=1 vs count=3 (eligible count=3)
tooBigCount=0
[junit4] 2> 178995 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: apply all deletes during flush
[junit4] 2> 178995 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: applyDeletes: infos=[_0(5.0.0):C145, _2(5.0.0):C1,
_1(5.0.0):C1] packetCount=1
[junit4] 2> 178995 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: applyDeletes took 0 msec
[junit4] 2> 178995 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: prune sis=segments_1: _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 minGen=8 packetCount=1
[junit4] 2> 178995 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 178997 T453 C114 oasu.LoggingInfoStream.message
[DW][DocThread-2]: DocThread-2 finishFullFlush success=true
[junit4] 2> 178997 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: findMerges: 3 segments
[junit4] 2> 178997 T454 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-3]: now merge
[junit4] 2> 178997 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_0(5.0.0):C145 size=0.005 MB [floored]
[junit4] 2> 178997 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_2(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 178998 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_1(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 178998 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: allowedSegmentCount=1 vs count=3 (eligible count=3)
tooBigCount=0
[junit4] 2> 178999 T454 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-3]: index: _0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
[junit4] 2> 178999 T454 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-3]: no more merges pending; now return
[junit4] 2> 179004 T454 C114 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T3:0 (1487864525693648896), T3:1
(1487864525738737664), T3:2 (1487864525772292096), T3:3 (1487864525772292097),
T3:4 (1487864525772292098), T3:5 (1487864525772292099), T3:6
(1487864525772292100), T3:7 (1487864525772292101), T3:8 (1487864525772292102),
T3:9 (1487864525772292103), ... (100 adds)]} 0 80
[junit4] 2> 179008 T453 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-2]: now merge
[junit4] 2> 179008 T453 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-2]: index: _0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
[junit4] 2> 179008 T453 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-2]: no more merges pending; now return
[junit4] 2> 179008 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: startCommit(): start
[junit4] 2> 179008 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: startCommit index=_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
changeCount=10
[junit4] 2> 179008 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: done all syncs: [_0_Lucene50_0.doc, _1.si, _1.nvd, _0.nvd,
_2.fdt, _2_Lucene50_0.pos, _2.fdx, _1.nvm, _1.fnm, _2_Lucene50_0.tim,
_2_Lucene50_0.tip, _2.nvd, _1_Lucene50_0.tim, _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> 179008 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: commit: pendingCommit != null
[junit4] 2> 179009 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1"
[3 segments ; isCommit = true]
[junit4] 2> 179009 T453 C114 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3d216992
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45c99d48),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3d216992
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45c99d48),segFN=segments_2,generation=2}
[junit4] 2> 179009 T453 C114 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 179009 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: deleteCommits: now decRef commit "segments_1"
[junit4] 2> 179010 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: delete "segments_1"
[junit4] 2> 179010 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: 1 msec to checkpoint
[junit4] 2> 179010 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: commit: wrote segments file "segments_2"
[junit4] 2> 179010 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: commit: took 68.2 msec
[junit4] 2> 179010 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: commit: done
[junit4] 2> 179011 T453 C114 oasu.LoggingInfoStream.message
[DW][DocThread-2]: anyChanges? numDocsInRam=323 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 179011 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: nrtIsCurrent: infoVersion matches: false; DW changes: true;
BD changes: false
[junit4] 2> 179011 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: flush at getReader
[junit4] 2> 179011 T453 C114 oasu.LoggingInfoStream.message
[DW][DocThread-2]: startFullFlush
[junit4] 2> 179011 T453 C114 oasu.LoggingInfoStream.message
[DW][DocThread-2]: anyChanges? numDocsInRam=323 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 179011 T453 C114 oasu.LoggingInfoStream.message
[DWFC][DocThread-2]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 322 deleted terms (unique count=322) bytesUsed=74999,
segment=_3, aborted=false, numDocsInRAM=232, deleteQueue=DWDQ: [ generation: 3
]]
[junit4] 2> 179011 T453 C114 oasu.LoggingInfoStream.message
[DWFC][DocThread-2]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0, segment=_5, aborted=false, numDocsInRAM=1,
deleteQueue=DWDQ: [ generation: 3 ]]
[junit4] 2> 179011 T453 C114 oasu.LoggingInfoStream.message
[DWFC][DocThread-2]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 89 deleted terms (unique count=89) bytesUsed=20737,
segment=_4, aborted=false, numDocsInRAM=90, deleteQueue=DWDQ: [ generation: 3 ]]
[junit4] 2> 179012 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flush postings as segment _3 numDocs=232
[junit4] 2> 179015 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has 0 deleted docs
[junit4] 2> 179015 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 179015 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushedFiles=[_3.fdx, _3.nvd, _3_Lucene50_0.pos,
_3_Lucene50_0.doc, _3_Lucene50_0.tim, _3.nvm, _3.fnm, _3.fdt, _3_Lucene50_0.tip]
[junit4] 2> 179015 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed codec=Lucene50
[junit4] 2> 179021 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed: segment=_3 ramUsed=0.181 MB
newFlushedSize(includes docstores)=0.007 MB docs/MB=33,857.986
[junit4] 2> 179025 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flush postings as segment _5 numDocs=1
[junit4] 2> 179025 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has 0 deleted docs
[junit4] 2> 179025 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 179025 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushedFiles=[_5.nvm, _5.fnm, _5_Lucene50_0.pos, _5.fdt,
_5.nvd, _5_Lucene50_0.tip, _5_Lucene50_0.doc, _5_Lucene50_0.tim, _5.fdx]
[junit4] 2> 179025 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed codec=Lucene50
[junit4] 2> 179025 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed: segment=_5 ramUsed=0.119 MB
newFlushedSize(includes docstores)=0.001 MB docs/MB=733.783
[junit4] 2> 179027 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flush postings as segment _4 numDocs=90
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has 0 deleted docs
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushedFiles=[_4.fdt, _4.nvm, _4_Lucene50_0.pos, _4.fnm,
_4_Lucene50_0.tip, _4.nvd, _4.fdx, _4_Lucene50_0.doc, _4_Lucene50_0.tim]
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed codec=Lucene50
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed: segment=_4 ramUsed=0.144 MB
newFlushedSize(includes docstores)=0.004 MB docs/MB=25,623.633
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[DW][DocThread-2]: publishFlushedSegment seg-private updates=null
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: publishFlushedSegment
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: push deletes 323 deleted terms (unique count=323)
bytesUsed=1072 delGen=9 packetCount=1 totBytesUsed=1072
[junit4] 2> 179034 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: publish sets newSegment delGen=10 seg=_3(5.0.0):C232
[junit4] 2> 179035 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232" [4 segments ; isCommit = false]
[junit4] 2> 179037 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: 2 msec to checkpoint
[junit4] 2> 179037 T453 C114 oasu.LoggingInfoStream.message
[DW][DocThread-2]: publishFlushedSegment seg-private updates=null
[junit4] 2> 179037 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: publishFlushedSegment
[junit4] 2> 179037 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: publish sets newSegment delGen=11 seg=_5(5.0.0):C1
[junit4] 2> 179038 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232 _5(5.0.0):C1" [5 segments ; isCommit = false]
[junit4] 2> 179038 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: 0 msec to checkpoint
[junit4] 2> 179038 T453 C114 oasu.LoggingInfoStream.message
[DW][DocThread-2]: publishFlushedSegment seg-private updates=null
[junit4] 2> 179038 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: publishFlushedSegment
[junit4] 2> 179038 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: publish sets newSegment delGen=12 seg=_4(5.0.0):C90
[junit4] 2> 179039 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90" [6 segments ; isCommit = false]
[junit4] 2> 179039 T453 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-2]: 0 msec to checkpoint
[junit4] 2> 179039 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: apply all deletes during flush
[junit4] 2> 179039 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: applyDeletes: infos=[_0(5.0.0):C145, _2(5.0.0):C1,
_1(5.0.0):C1, _3(5.0.0):C232, _5(5.0.0):C1, _4(5.0.0):C90] packetCount=1
[junit4] 2> 179061 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: seg=_1(5.0.0):C1 segGen=8 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179066 T455 C114 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T4:0 (1487864525709377536), T4:1
(1487864525718814720), T4:2 (1487864525718814721), T4:3 (1487864525718814722),
T4:4 (1487864525718814723), T4:5 (1487864525718814724), T4:6
(1487864525718814725), T4:7 (1487864525718814726), T4:8 (1487864525718814727),
T4:9 (1487864525718814728), ... (100 adds)]} 0 127
[junit4] 2> 179072 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: seg=_2(5.0.0):C1 segGen=8 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179076 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: seg=_0(5.0.0):C145 segGen=8 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179076 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: applyDeletes took 37 msec
[junit4] 2> 179076 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: prune sis=segments_1: _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 _3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 minGen=13 packetCount=1
[junit4] 2> 179076 T453 C114 oasu.LoggingInfoStream.message
[BD][DocThread-2]: pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 179078 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: return reader version=14
reader=StandardDirectoryReader(segments_1:14:nrt _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 _3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90)
[junit4] 2> 179078 T453 C114 oasu.LoggingInfoStream.message
[DW][DocThread-2]: DocThread-2 finishFullFlush success=true
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: findMerges: 6 segments
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_3(5.0.0):C232 size=0.007 MB [floored]
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_0(5.0.0):C145 size=0.005 MB [floored]
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_4(5.0.0):C90 size=0.003 MB [floored]
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_2(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_1(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_5(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: allowedSegmentCount=1 vs count=6 (eligible count=6)
tooBigCount=0
[junit4] 2> 179079 T453 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-2]: now merge
[junit4] 2> 179080 T453 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-2]: index: _0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90
[junit4] 2> 179082 T453 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-2]: no more merges pending; now return
[junit4] 2> 179082 T453 C114 oasu.LoggingInfoStream.message
[IW][DocThread-2]: getReader took 71 msec
[junit4] 2> 179082 T453 C114 oass.SolrIndexSearcher.<init> Opening
Searcher@3854b112[collection1] main
[junit4] 2> 179082 T453 C114 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 179084 T451 C114 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 179084 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: commit: start
[junit4] 2> 179084 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: commit: enter lock
[junit4] 2> 179084 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: commit: now prepare
[junit4] 2> 179084 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: prepareCommit: flush
[junit4] 2> 179085 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: index before flush _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 _3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90
[junit4] 2> 179085 T451 C114 oasu.LoggingInfoStream.message
[DW][DocThread-0]: startFullFlush
[junit4] 2> 179085 T451 C114 oasu.LoggingInfoStream.message
[DW][DocThread-0]: anyChanges? numDocsInRam=13 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 179085 T451 C114 oasu.LoggingInfoStream.message
[DWFC][DocThread-0]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 12 deleted terms (unique count=12) bytesUsed=2796,
segment=_6, aborted=false, numDocsInRAM=13, deleteQueue=DWDQ: [ generation: 4 ]]
[junit4] 2> 179085 T451 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: flush postings as segment _6 numDocs=13
[junit4] 2> 179086 T451 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: new segment has 0 deleted docs
[junit4] 2> 179086 T451 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 179086 T451 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: flushedFiles=[_6_Lucene50_0.doc, _6_Lucene50_0.tim,
_6_Lucene50_0.tip, _6.fdt, _6.nvm, _6.fnm, _6.fdx, _6_Lucene50_0.pos, _6.nvd]
[junit4] 2> 179086 T451 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: flushed codec=Lucene50
[junit4] 2> 179086 T451 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: flushed: segment=_6 ramUsed=0.099 MB
newFlushedSize(includes docstores)=0.002 MB docs/MB=7,285.67
[junit4] 2> 179086 T451 C114 oasu.LoggingInfoStream.message
[DW][DocThread-0]: publishFlushedSegment seg-private updates=null
[junit4] 2> 179086 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: publishFlushedSegment
[junit4] 2> 179088 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: push deletes 13 deleted terms (unique count=13)
bytesUsed=1072 delGen=14 packetCount=1 totBytesUsed=1072
[junit4] 2> 179088 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: publish sets newSegment delGen=15 seg=_6(5.0.0):C13
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13" [7 segments ; isCommit
= false]
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: 0 msec to checkpoint
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: apply all deletes during flush
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: applyDeletes: infos=[_0(5.0.0):C145, _2(5.0.0):C1,
_1(5.0.0):C1, _3(5.0.0):C232, _5(5.0.0):C1, _4(5.0.0):C90, _6(5.0.0):C13]
packetCount=1
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: seg=_4(5.0.0):C90 segGen=13 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: seg=_5(5.0.0):C1 segGen=13 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: seg=_3(5.0.0):C232 segGen=13 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: seg=_1(5.0.0):C1 segGen=13 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: seg=_2(5.0.0):C1 segGen=13 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: seg=_0(5.0.0):C145 segGen=13 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: applyDeletes took 0 msec
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: prune sis=segments_1: _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 _3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13 minGen=16
packetCount=1
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[DW][DocThread-0]: DocThread-0 finishFullFlush success=true
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: findMerges: 7 segments
[junit4] 2> 179089 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_3(5.0.0):C232 size=0.007 MB [floored]
[junit4] 2> 179091 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_0(5.0.0):C145 size=0.005 MB [floored]
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_4(5.0.0):C90 size=0.003 MB [floored]
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_6(5.0.0):C13 size=0.002 MB [floored]
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_2(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_1(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_5(5.0.0):C1 size=0.001 MB [floored]
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: allowedSegmentCount=1 vs count=7 (eligible count=7)
tooBigCount=0
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-0]: now merge
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-0]: index: _0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[CMS][DocThread-0]: no more merges pending; now return
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: startCommit(): start
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: startCommit index=_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13 changeCount=16
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: done all syncs: [_3.si, _1.nvd, _0.nvd, _2_Lucene50_0.pos,
_1.nvm, _1.fnm, _4_Lucene50_0.doc, _6_Lucene50_0.tim, _2.nvd,
_1_Lucene50_0.tim, _6_Lucene50_0.tip, _4_Lucene50_0.pos, _6.fdt, _2.nvm,
_2.fnm, _1_Lucene50_0.tip, _5_Lucene50_0.pos, _2.si, _5.fdt, _0_Lucene50_0.pos,
_4_Lucene50_0.tip, _6_Lucene50_0.pos, _4_Lucene50_0.tim, _6_Lucene50_0.doc,
_4.fdt, _3_Lucene50_0.tim, _3.fdt, _3_Lucene50_0.tip, _5_Lucene50_0.doc, _6.si,
_0.nvm, _0.fnm, _3.fdx, _0_Lucene50_0.doc, _1.si, _3_Lucene50_0.pos, _6.nvm,
_6.fnm, _2.fdt, _2.fdx, _2_Lucene50_0.tim, _2_Lucene50_0.tip, _4.fdx, _6.nvd,
_1_Lucene50_0.pos, _3_Lucene50_0.doc, _1.fdx, _5_Lucene50_0.tip, _5.si,
_5_Lucene50_0.tim, _1.fdt, _5.fdx, _0.si, _0_Lucene50_0.tim, _3.nvd, _4.nvm,
_4.fnm, _6.fdx, _0.fdx, _3.nvm, _3.fnm, _0_Lucene50_0.tip, _4.nvd,
_2_Lucene50_0.doc, _0.fdt, _5.nvm, _5.fnm, _1_Lucene50_0.doc, _5.nvd, _4.si]
[junit4] 2> 179094 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: commit: pendingCommit != null
[junit4] 2> 179095 T451 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13" [7 segments ; isCommit
= true]
[junit4] 2> 179097 T451 C114 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3d216992
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45c99d48),segFN=segments_2,generation=2}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3d216992
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@45c99d48),segFN=segments_3,generation=3}
[junit4] 2> 179097 T451 C114 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 3
[junit4] 2> 179097 T451 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: deleteCommits: now decRef commit "segments_2"
[junit4] 2> 179097 T451 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: delete "segments_2"
[junit4] 2> 179097 T451 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: 2 msec to checkpoint
[junit4] 2> 179097 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: commit: wrote segments file "segments_3"
[junit4] 2> 179098 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: commit: took 11.7 msec
[junit4] 2> 179098 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: commit: done
[junit4] 2> 179098 T451 C114 oasc.SolrCore.getSearcher WARN [collection1]
PERFORMANCE WARNING: Overlapping onDeckSearchers=2
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: nrtIsCurrent: infoVersion matches: false; DW changes: false;
BD changes: false
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: flush at getReader
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[DW][DocThread-0]: startFullFlush
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: apply all deletes during flush
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: applyDeletes: no deletes; skipping
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[BD][DocThread-0]: prune sis=segments_1: _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 _3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13 minGen=16
packetCount=0
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: return reader version=15
reader=StandardDirectoryReader(segments_1:15:nrt _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 _3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13)
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[DW][DocThread-0]: DocThread-0 finishFullFlush success=true
[junit4] 2> 179099 T451 C114 oasu.LoggingInfoStream.message
[IW][DocThread-0]: getReader took 0 msec
[junit4] 2> 179104 T451 C114 oass.SolrIndexSearcher.<init> Opening
Searcher@8b030d7[collection1] main
[junit4] 2> 179104 T451 C114 oasu.DirectUpdateHandler2.commit
end_commit_flush
[junit4] 2> 179107 T452 C114 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T1:0 (1487864525692600320), T1:1
(1487864525720911885), T1:2 (1487864525720911886), T1:3 (1487864525720911887),
T1:4 (1487864525721960448), T1:5 (1487864525721960449), T1:6
(1487864525721960450), T1:7 (1487864525721960451), T1:8 (1487864525721960452),
T1:9 (1487864525723009024), ... (100 adds)]} 0 184
[junit4] 2> 179108 T452 C114 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[IW][DocThread-1]: commit: start
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[IW][DocThread-1]: commit: enter lock
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[IW][DocThread-1]: commit: now prepare
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[IW][DocThread-1]: prepareCommit: flush
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[IW][DocThread-1]: index before flush _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 _3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[DW][DocThread-1]: startFullFlush
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[DW][DocThread-1]: anyChanges? numDocsInRam=17 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[DWFC][DocThread-1]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 16 deleted terms (unique count=16) bytesUsed=3728,
segment=_7, aborted=false, numDocsInRAM=17, deleteQueue=DWDQ: [ generation: 6 ]]
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flush postings as segment _7 numDocs=17
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: new segment has 0 deleted docs
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flushedFiles=[_7_Lucene50_0.tip, _7.nvm, _7.fnm, _7.fdt,
_7_Lucene50_0.pos, _7.nvd, _7_Lucene50_0.tim, _7.fdx, _7_Lucene50_0.doc]
[junit4] 2> 179108 T452 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flushed codec=Lucene50
[junit4] 2> 179109 T452 C114 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flushed: segment=_7 ramUsed=0.1 MB newFlushedSize(includes
docstores)=0.002 MB docs/MB=8,886.237
[junit4] 2> 179111 T452 C114 oasu.LoggingInfoStream.message
[DW][DocThread-1]: publishFlushedSegment seg-private updates=null
[junit4] 2> 179111 T452 C114 oasu.LoggingInfoStream.message
[IW][DocThread-1]: publishFlushedSegment
[junit4] 2> 179111 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: push deletes 17 deleted terms (unique count=17)
bytesUsed=1072 delGen=18 packetCount=1 totBytesUsed=1072
[junit4] 2> 179111 T452 C114 oasu.LoggingInfoStream.message
[IW][DocThread-1]: publish sets newSegment delGen=19 seg=_7(5.0.0):C17
[junit4] 2> 179112 T452 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: now checkpoint "_0(5.0.0):C145 _2(5.0.0):C1 _1(5.0.0):C1
_3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13 _7(5.0.0):C17" [8
segments ; isCommit = false]
[junit4] 2> 179112 T452 C114 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: 0 msec to checkpoint
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[IW][DocThread-1]: apply all deletes during flush
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: applyDeletes: infos=[_0(5.0.0):C145, _2(5.0.0):C1,
_1(5.0.0):C1, _3(5.0.0):C232, _5(5.0.0):C1, _4(5.0.0):C90, _6(5.0.0):C13,
_7(5.0.0):C17] packetCount=1
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: seg=_6(5.0.0):C13 segGen=16 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: seg=_4(5.0.0):C90 segGen=16 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: seg=_5(5.0.0):C1 segGen=16 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: seg=_3(5.0.0):C232 segGen=16 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: seg=_1(5.0.0):C1 segGen=16 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: seg=_2(5.0.0):C1 segGen=16 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: seg=_0(5.0.0):C145 segGen=16 coalesced
deletes=[CoalescedUpdates(termSets=1,queries=0,numericDVUpdates=0,binaryDVUpdates=0)]
newDelCount=0
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: applyDeletes took 0 msec
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: prune sis=segments_1: _0(5.0.0):C145 _2(5.0.0):C1
_1(5.0.0):C1 _3(5.0.0):C232 _5(5.0.0):C1 _4(5.0.0):C90 _6(5.0.0):C13
_7(5.0.0):C17 minGen=20 packetCount=1
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[BD][DocThread-1]: pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[DW][DocThread-1]: DocThread-1 finishFullFlush success=true
[junit4] 2> 179113 T452 C114 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: findMerges: 8 segments
[junit4] 2> 179113 T452
[...truncated too long message...]
eContainer.shutdown(CoreContainer.java:365)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.EmbeddedSolrServer.shutdown(EmbeddedSolrServer.java:249)
[junit4] 2> at
org.apache.solr.SolrJettyTestBase.afterSolrJettyTestBase(SolrJettyTestBase.java:90)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:483)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 179280 T446 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 179280 T446 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\index
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\index;done=false>>]
[junit4] 2> 179280 T446 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\index
[junit4] 2> 179280 T446 oasc.CachingDirectoryFactory.closeCacheValue
looking to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\;done=false>>]
[junit4] 2> 179280 T446 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\
[junit4] 2> 179280 T446 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 179282 T446 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=567817790
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {},
docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {},
locale=nl, timezone=Japan
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_20
(64-bit)/cpus=2,threads=1,free=33425664,total=102690816
[junit4] 2> NOTE: All tests run in this JVM: [SolrPingTest,
FacetFieldTest, SolrExampleStreamingBinaryTest, TestFastInputStream,
TestBatchUpdate, TestSpellCheckResponse, SolrParamTest, CloudSolrServerTest,
ConcurrentUpdateSolrServerTest, JettyWebappTest, MergeIndexesEmbeddedTest,
TestJavaBinCodec, LargeVolumeBinaryJettyTest, TestCoreAdmin,
ExternalHttpClientTest, QueryResponseTest, AnlysisResponseBaseTest,
TestRetryUtil, TestDocumentObjectBinder, SolrExampleJettyTest, TestHash,
FieldAnalysisResponseTest, LargeVolumeEmbeddedTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=LargeVolumeEmbeddedTest -Dtests.seed=C6AF373F8E6FDC52
-Dtests.slow=true -Dtests.locale=nl -Dtests.timezone=Japan
-Dtests.asserts=false -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s | LargeVolumeEmbeddedTest (suite) <<<
[junit4] > Throwable #1: 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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\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\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001\tlog
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001\init-core-data-001
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest-C6AF373F8E6FDC52-001
[junit4] > at
__randomizedtesting.SeedInfo.seed([C6AF373F8E6FDC52]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:289)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed in 2.74s, 1 test, 1 error <<< FAILURES!
[...truncated 96 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:529: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:477: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:203: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:508:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1363:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:970:
There were test failures: 52 suites, 329 tests, 1 suite-level error
Total time: 160 minutes 41 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_20
-XX:-UseCompressedOops -XX:+UseSerialGC (asserts: false)
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]
