Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4659/
Java: 64bit/jdk1.8.0_40 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.embedded.LargeVolumeEmbeddedTest
Error Message:
Some resources were not closed, shutdown, or released.
Stack Trace:
java.lang.AssertionError: Some resources were not closed, shutdown, or released.
at __randomizedtesting.SeedInfo.seed([4484DB0CD4EA898]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:234)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.embedded.LargeVolumeEmbeddedTest
Error Message:
Could not remove the following files (in the order of attempts):
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of
attempts):
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:286)
at
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:200)
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 11075 lines...]
[junit4] Suite: org.apache.solr.client.solrj.embedded.LargeVolumeEmbeddedTest
[junit4] 2> Creating dataDir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001
[junit4] 2> 11588 T32 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl
(false) and clientAuth (false)
[junit4] 2> 11763 T32 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 11764 T32 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\'
[junit4] 2> 11802 T32 oasc.SolrConfig.refreshRequestParams current version
of requestparams : -1
[junit4] 2> 11803 T32 oasc.SolrConfig.initLibs Adding specified lib dirs
to ClassLoader
[junit4] 2> 11803 T32 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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib).
[junit4] 2> 11805 T32 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 11806 T32 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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib).
[junit4] 2> 11806 T32 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 11807 T32 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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib).
[junit4] 2> 11807 T32 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 11808 T32 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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib).
[junit4] 2> 11808 T32 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 11820 T32 oasu.SolrIndexConfig.<init> IndexWriter infoStream
solr logging is enabled
[junit4] 2> 11822 T32 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 11843 T32 oasc.SolrConfig.<init> Loaded SolrConfig:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001/collection1/conf/solrconfig.xml
[junit4] 2> 11845 T32 oass.IndexSchema.readSchema Reading Solr Schema from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf\C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001/collection1/conf/schema.xml
[junit4] 2> 11855 T32 oass.IndexSchema.readSchema [null] Schema
name=example
[junit4] 2> 11981 T32 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 11983 T32 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path
/schema/analysis/stopwords/english
[junit4] 2> 11983 T32 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager
for path /schema/analysis/synonyms/english
[junit4] 2> 11997 T32 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 12001 T32 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 12027 T32 oasc.SolrResourceLoader.locateSolrHome JNDI not
configured for solr (NoInitialContextEx)
[junit4] 2> 12027 T32 oasc.SolrResourceLoader.locateSolrHome using system
property solr.solr.home:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001
[junit4] 2> 12027 T32 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\'
[junit4] 2> 12051 T32 oasc.CoreContainer.<init> New CoreContainer
1298978602
[junit4] 2> 12051 T32 oasc.CoreContainer.load Loading cores into
CoreContainer
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\]
[junit4] 2> 12051 T32 oasc.CoreContainer.load loading shared library:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\lib
[junit4] 2> 12051 T32 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: lib (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\lib).
[junit4] 2> 12059 T32 oashc.HttpShardHandlerFactory.getParameter Setting
socketTimeout to: 600000
[junit4] 2> 12059 T32 oashc.HttpShardHandlerFactory.getParameter Setting
urlScheme to: null
[junit4] 2> 12059 T32 oashc.HttpShardHandlerFactory.getParameter Setting
connTimeout to: 60000
[junit4] 2> 12059 T32 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnectionsPerHost to: 20
[junit4] 2> 12060 T32 oashc.HttpShardHandlerFactory.getParameter Setting
maxConnections to: 10000
[junit4] 2> 12060 T32 oashc.HttpShardHandlerFactory.getParameter Setting
corePoolSize to: 0
[junit4] 2> 12060 T32 oashc.HttpShardHandlerFactory.getParameter Setting
maximumPoolSize to: 2147483647
[junit4] 2> 12060 T32 oashc.HttpShardHandlerFactory.getParameter Setting
maxThreadIdleTime to: 5
[junit4] 2> 12060 T32 oashc.HttpShardHandlerFactory.getParameter Setting
sizeOfQueue to: -1
[junit4] 2> 12061 T32 oashc.HttpShardHandlerFactory.getParameter Setting
fairnessPolicy to: false
[junit4] 2> 12061 T32 oashc.HttpShardHandlerFactory.getParameter Setting
useRetries to: false
[junit4] 2> 12070 T32 oasu.UpdateShardHandler.<init> Creating
UpdateShardHandler HTTP client with params:
socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 12071 T32 oasl.LogWatcher.createWatcher SLF4J impl is
org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 12071 T32 oasl.LogWatcher.newRegisteredLogWatcher Registering
Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 12071 T32 oasc.CoreContainer.load Node Name: testNode
[junit4] 2> 12074 T32 oasc.CoreDescriptor.<init> CORE DESCRIPTOR:
{name=collection1,
config=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001/collection1/conf/solrconfig.xml,
transient=false,
schema=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001/collection1/conf/schema.xml,
loadOnStartup=true, instanceDir=collection1, collection=collection1,
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001, shard=shard1}
[junit4] 2> 12076 T33 oasc.SolrResourceLoader.<init> new
SolrResourceLoader for directory:
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\'
[junit4] 2> 12096 T33 oasc.SolrConfig.refreshRequestParams current version
of requestparams : -1
[junit4] 2> 12097 T33 oasc.SolrConfig.initLibs Adding specified lib dirs
to ClassLoader
[junit4] 2> 12097 T33 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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib).
[junit4] 2> 12097 T33 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 12097 T33 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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib).
[junit4] 2> 12098 T33 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 12098 T33 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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib).
[junit4] 2> 12098 T33 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 12098 T33 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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib).
[junit4] 2> 12098 T33 oasc.SolrResourceLoader.addToClassLoader WARN Can't
find (or read) directory to add to classloader: ../../../../dist/ (resolved as:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\..\..\..\..\dist).
[junit4] 2> 12110 T33 oasu.SolrIndexConfig.<init> IndexWriter infoStream
solr logging is enabled
[junit4] 2> 12111 T33 oasc.SolrConfig.<init> Using Lucene MatchVersion:
6.0.0
[junit4] 2> 12131 T33 oasc.SolrConfig.<init> Loaded SolrConfig:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001/collection1/conf/solrconfig.xml
[junit4] 2> 12131 T33 oass.IndexSchema.readSchema Reading Solr Schema from
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf\C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001/collection1/conf/schema.xml
[junit4] 2> 12139 T33 oass.IndexSchema.readSchema [collection1] Schema
name=example
[junit4] 2> 12254 T33 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 12257 T33 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path
/schema/analysis/stopwords/english
[junit4] 2> 12257 T33 oasr.RestManager$Registry.registerManagedResource
Registered ManagedResource impl
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager
for path /schema/analysis/synonyms/english
[junit4] 2> 12268 T33 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 12272 T33 oass.FileExchangeRateProvider.reload Reloading
exchange rates from file currency.xml
[junit4] 2> 12292 T33 oasc.CoreContainer.create Creating SolrCore
'collection1' using configuration from instancedir
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\
[junit4] 2> 12292 T33 c:collection1 oasc.SolrCore.initDirectoryFactory
org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 12293 T33 c:collection1 oasc.SolrCore.<init> [collection1]
Opening new SolrCore at
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\,
dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\
[junit4] 2> 12294 T33 c:collection1 oasc.JmxMonitoredMap.<init> No JMX
servers found, not exposing Solr information with JMX.
[junit4] 2> 12295 T33 c:collection1 oasc.SolrCore.initListeners
[collection1] Added SolrEventListener for newSearcher:
org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 12295 T33 c:collection1 oasc.SolrCore.initListeners
[collection1] Added SolrEventListener for firstSearcher:
org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher
warming in solrconfig.xml}]}
[junit4] 2> 12296 T33 c:collection1 oasc.CachingDirectoryFactory.get
return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\
[junit4] 2> 12296 T33 c:collection1 oasc.SolrCore.getNewIndexDir New index
directory detected: old=null
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\index/
[junit4] 2> 12296 T33 c:collection1 oasc.SolrCore.initIndex WARN
[collection1] Solr index directory
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\index' doesn't exist. Creating new
index...
[junit4] 2> 12296 T33 c:collection1 oasc.CachingDirectoryFactory.get
return new directory for
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\index
[junit4] 2> 12297 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: init: current segments file is "segments";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@1c8a409e
[junit4] 2> 12297 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: now checkpoint "" [0 segments ; isCommit =
false]
[junit4] 2> 12297 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: 0 msec to checkpoint
[junit4] 2> 12298 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: init: create=true
[junit4] 2> 12298 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@3ff23833
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@383b92dc)
[junit4] 2> index=
[junit4] 2> version=6.0.0
[junit4] 2>
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
[junit4] 2> ramBufferSizeMB=100.0
[junit4] 2> maxBufferedDocs=-1
[junit4] 2> maxBufferedDeleteTerms=-1
[junit4] 2> mergedSegmentWarmer=null
[junit4] 2>
delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
[junit4] 2> commit=null
[junit4] 2> openMode=CREATE
[junit4] 2>
similarity=org.apache.lucene.search.similarities.DefaultSimilarity
[junit4] 2> mergeScheduler=ConcurrentMergeScheduler:
maxThreadCount=-1, maxMergeCount=-1, ioThrottle=true
[junit4] 2> default WRITE_LOCK_TIMEOUT=1000
[junit4] 2> writeLockTimeout=1000
[junit4] 2> codec=Lucene50
[junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream
[junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10,
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0,
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2>
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@17611140
[junit4] 2> readerPooling=false
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@397c803f
[junit4] 2>
[junit4] 2> 12298 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: now flush at close
[junit4] 2> 12298 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: start flush: applyAllDeletes=true
[junit4] 2> 12298 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: index before flush
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-15-thread-1]: startFullFlush
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-15-thread-1]: coreLoadExecutor-15-thread-1
finishFullFlush success=true
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: apply all deletes during flush
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: now apply all deletes for all segments
maxDoc=0
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-15-thread-1]: prune sis=segments:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-15-thread-1]: initDynamicDefaults spins=false
maxThreadCount=1 maxMergeCount=6
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-15-thread-1]: updateMergeThreads ioThrottle=true
targetMBPerSec=10240.0 MB/sec
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-15-thread-1]: now merge
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-15-thread-1]: index:
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[MS][coreLoadExecutor-15-thread-1]: no more merges pending; now return
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: waitForMerges
[junit4] 2> 12299 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: waitForMerges done
[junit4] 2> 12300 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: commit: start
[junit4] 2> 12300 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: commit: enter lock
[junit4] 2> 12300 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: commit: now prepare
[junit4] 2> 12300 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: prepareCommit: flush
[junit4] 2> 12300 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: index before flush
[junit4] 2> 12300 T33 c:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-15-thread-1]: startFullFlush
[junit4] 2> 12300 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: apply all deletes during flush
[junit4] 2> 12300 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: now apply all deletes for all segments
maxDoc=0
[junit4] 2> 12301 T33 c:collection1 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-15-thread-1]: prune sis=segments:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 12301 T33 c:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-15-thread-1]: coreLoadExecutor-15-thread-1
finishFullFlush success=true
[junit4] 2> 12301 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: startCommit(): start
[junit4] 2> 12301 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: startCommit index= changeCount=1
[junit4] 2> 12301 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: done all syncs: []
[junit4] 2> 12301 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: commit: pendingCommit != null
[junit4] 2> 12302 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: now checkpoint "" [0 segments ; isCommit =
true]
[junit4] 2> 12303 T33 c:collection1 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3ff23833
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@383b92dc),segFN=segments_1,generation=1}
[junit4] 2> 12303 T33 c:collection1 oasc.SolrDeletionPolicy.updateCommits
newest commit generation = 1
[junit4] 2> 12303 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: 0 msec to checkpoint
[junit4] 2> 12303 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: commit: wrote segments file "segments_1"
[junit4] 2> 12303 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: commit: took 3.2 msec
[junit4] 2> 12303 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: commit: done
[junit4] 2> 12303 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: rollback
[junit4] 2> 12303 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: all running merges have aborted
[junit4] 2> 12304 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: rollback: done finish merges
[junit4] 2> 12304 T33 c:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-15-thread-1]: abort
[junit4] 2> 12304 T33 c:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-15-thread-1]: done abort success=true
[junit4] 2> 12304 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: rollback: infos=
[junit4] 2> 12305 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: now checkpoint "" [0 segments ; isCommit =
false]
[junit4] 2> 12305 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: 0 msec to checkpoint
[junit4] 2> 12305 T33 c:collection1 oasc.PluginBag.createPlugin
queryResponseWriter : 'velocity' created with startup=lazy
[junit4] 2> 12306 T33 c:collection1 oasr.XSLTResponseWriter.init
xsltCacheLifetimeSeconds=5
[junit4] 2> 12307 T33 c:collection1
oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined
as default, creating implicit default
[junit4] 2> 12315 T33 c:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 12318 T33 c:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 12319 T33 c:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 12319 T33 c:collection1 oashl.XMLLoader.init
xsltCacheLifetimeSeconds=60
[junit4] 2> 12322 T33 c:collection1 oasc.PluginBag.createPlugin
requestHandler : '/update/extract' created with startup=lazy
[junit4] 2> 12322 T33 c:collection1 oasc.PluginBag.createPlugin
requestHandler : '/analysis/field' created with startup=lazy
[junit4] 2> 12322 T33 c:collection1 oasc.PluginBag.createPlugin
requestHandler : '/analysis/document' created with startup=lazy
[junit4] 2> 12323 T33 c:collection1 oasc.PluginBag.createPlugin
requestHandler : '/spell' created with startup=lazy
[junit4] 2> 12323 T33 c:collection1 oasc.PluginBag.createPlugin
requestHandler : '/suggest' created with startup=lazy
[junit4] 2> 12323 T33 c:collection1 oasc.PluginBag.createPlugin
requestHandler : '/tvrh' created with startup=lazy
[junit4] 2> 12324 T33 c:collection1 oasc.PluginBag.createPlugin
requestHandler : '/terms' created with startup=lazy
[junit4] 2> 12324 T33 c:collection1 oasc.PluginBag.createPlugin
requestHandler : '/elevate' created with startup=lazy
[junit4] 2> 12324 T33 c:collection1
oasc.RequestHandlers.initHandlersFromConfig Registered paths:
/admin/mbeans,/browse,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/elevate,/update/json,/admin/threads,/query,/analysis/field,/analysis/document,/spell,/update/csv,/tvrh,/select,/admin/segments,/admin/system,/suggest,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/debug/dump,/terms,/update/extract
[junit4] 2> 12326 T33 c:collection1 oasc.SolrCore.initStatsCache Using
default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 12326 T33 c:collection1 oasu.UpdateHandler.<init> Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 12326 T33 c:collection1 oasu.UpdateLog.init Initializing
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10
[junit4] 2> 12327 T33 c:collection1 oasu.CommitTracker.<init> Hard
AutoCommit: if uncommited for 15000ms;
[junit4] 2> 12327 T33 c:collection1 oasu.CommitTracker.<init> Soft
AutoCommit: disabled
[junit4] 2> 12327 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: init: current segments file is
"segments_1";
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@1c8a409e
[junit4] 2> 12327 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: init: load commit "segments_1"
[junit4] 2> 12328 T33 c:collection1 oasc.SolrDeletionPolicy.onInit
SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3ff23833
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@383b92dc),segFN=segments_1,generation=1}
[junit4] 2> 12328 T33 c:collection1 oasc.SolrDeletionPolicy.updateCommits
newest commit generation = 1
[junit4] 2> 12328 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: now checkpoint "" [0 segments ; isCommit =
false]
[junit4] 2> 12328 T33 c:collection1 oasu.LoggingInfoStream.message
[IFD][coreLoadExecutor-15-thread-1]: 0 msec to checkpoint
[junit4] 2> 12328 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: init: create=false
[junit4] 2> 12329 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]:
[junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@3ff23833
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@383b92dc)
[junit4] 2> index=
[junit4] 2> version=6.0.0
[junit4] 2>
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
[junit4] 2> ramBufferSizeMB=100.0
[junit4] 2> maxBufferedDocs=-1
[junit4] 2> maxBufferedDeleteTerms=-1
[junit4] 2> mergedSegmentWarmer=null
[junit4] 2>
delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
[junit4] 2> commit=null
[junit4] 2> openMode=APPEND
[junit4] 2>
similarity=org.apache.lucene.search.similarities.DefaultSimilarity
[junit4] 2> mergeScheduler=ConcurrentMergeScheduler:
maxThreadCount=-1, maxMergeCount=-1, ioThrottle=true
[junit4] 2> default WRITE_LOCK_TIMEOUT=1000
[junit4] 2> writeLockTimeout=1000
[junit4] 2> codec=Lucene50
[junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream
[junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10,
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0,
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2>
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@6367bcf0
[junit4] 2> readerPooling=false
[junit4] 2> perThreadHardLimitMB=1945
[junit4] 2> useCompoundFile=false
[junit4] 2> commitOnClose=true
[junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@6ecf1aa3
[junit4] 2>
[junit4] 2> 12329 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: flush at getReader
[junit4] 2> 12329 T33 c:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-15-thread-1]: startFullFlush
[junit4] 2> 12329 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: apply all deletes during flush
[junit4] 2> 12329 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: now apply all deletes for all segments
maxDoc=0
[junit4] 2> 12329 T33 c:collection1 oasu.LoggingInfoStream.message
[BD][coreLoadExecutor-15-thread-1]: prune sis=segments_1:
minGen=9223372036854775807 packetCount=0
[junit4] 2> 12330 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: return reader version=1
reader=StandardDirectoryReader(segments_1:1:nrt)
[junit4] 2> 12330 T33 c:collection1 oasu.LoggingInfoStream.message
[DW][coreLoadExecutor-15-thread-1]: coreLoadExecutor-15-thread-1
finishFullFlush success=true
[junit4] 2> 12330 T33 c:collection1 oasu.LoggingInfoStream.message
[IW][coreLoadExecutor-15-thread-1]: getReader took 1 msec
[junit4] 2> 12330 T33 c:collection1 oass.SolrIndexSearcher.<init> Opening
Searcher@50a5f295[collection1] main
[junit4] 2> 12331 T33 c:collection1
oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage
initialized to use dir:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf
[junit4] 2> 12331 T33 c:collection1 oasr.RestManager.init Initializing
RestManager with initArgs:
{storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf}
[junit4] 2> 12331 T33 c:collection1 oasr.ManagedResourceStorage.load
Reading _rest_managed.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf
[junit4] 2> 12332 T33 c:collection1 oasr.ManagedResourceStorage.load
Loaded LinkedHashMap at path _rest_managed.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf
[junit4] 2> 12332 T33 c:collection1 oasr.ManagedResource.processStoredData
Loaded initArgs {} for /rest/managed
[junit4] 2> 12332 T33 c:collection1 oasr.RestManager.init Initializing 2
registered ManagedResources
[junit4] 2> 12332 T33 c:collection1 oasr.ManagedResourceStorage.load
Reading _schema_analysis_stopwords_english.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf
[junit4] 2> 12332 T33 c:collection1 oasr.ManagedResourceStorage.load
Loaded LinkedHashMap at path _schema_analysis_stopwords_english.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf
[junit4] 2> 12332 T33 c:collection1 oasr.ManagedResource.processStoredData
Loaded initArgs {ignoreCase=true} for /schema/analysis/stopwords/english
[junit4] 2> 12332 T33 c:collection1
oasrsa.ManagedWordSetResource.onManagedDataLoadedFromStorage Loaded 35 words
for /schema/analysis/stopwords/english
[junit4] 2> 12332 T33 c:collection1
oasr.ManagedResource.notifyObserversDuringInit Notified 1 observers of
/schema/analysis/stopwords/english
[junit4] 2> 12333 T33 c:collection1 oasr.ManagedResourceStorage.load
Reading _schema_analysis_synonyms_english.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf
[junit4] 2> 12333 T33 c:collection1 oasr.ManagedResourceStorage.load
Loaded LinkedHashMap at path _schema_analysis_synonyms_english.json using
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf
[junit4] 2> 12333 T33 c:collection1 oasr.ManagedResource.processStoredData
Loaded initArgs {ignoreCase=true,format=solr} for
/schema/analysis/synonyms/english
[junit4] 2> 12334 T33 c:collection1
oasrsa.ManagedSynonymFilterFactory$SynonymManager.onManagedDataLoadedFromStorage
Loaded 3 synonym mappings for /schema/analysis/synonyms/english
[junit4] 2> 12334 T33 c:collection1
oasr.ManagedResource.notifyObserversDuringInit Notified 1 observers of
/schema/analysis/synonyms/english
[junit4] 2> 12334 T33 c:collection1 oashc.SpellCheckComponent.inform
Initializing spell checkers
[junit4] 2> 12335 T33 c:collection1 oass.DirectSolrSpellChecker.init init:
{name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 12335 T33 c:collection1 oashc.SpellCheckComponent.inform No
queryConverter defined, using default converter
[junit4] 2> 12335 T33 c:collection1 oashc.SuggestComponent.inform
Initializing SuggestComponent
[junit4] 2> 12335 T33 c:collection1 oasss.SolrSuggester.init init:
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
[junit4] 2> 12336 T33 c:collection1 oasss.SolrSuggester.init Dictionary
loaded with params:
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
[junit4] 2> 12336 T33 c:collection1 oashc.QueryElevationComponent.inform
Loading QueryElevation from:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\tempDir-001\collection1\conf\elevate.xml
[junit4] 2> 12340 T33 c:collection1 oash.ReplicationHandler.inform Commits
will be reserved for 10000
[junit4] 2> 12341 T33 c:collection1 oasc.CoreContainer.registerCore
registering core: collection1
[junit4] 2> 12343 T32 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 12359 T32 oas.SolrTestCaseJ4.setUp ###Starting
testMultiThreaded
[junit4] 2> 12386 T34 c:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener sending requests to Searcher@50a5f295[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> ASYNC NEW_CORE C2 name=collection1
org.apache.solr.core.SolrCore@7b3f87a8
[junit4] 2> 12392 T34 c:collection1 C2 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=4
[junit4] 2> 12393 T34 c:collection1 oasc.QuerySenderListener.newSearcher
QuerySenderListener done.
[junit4] 2> 12393 T34 c:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: default
[junit4] 2> 12393 T34 c:collection1
oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index
for spellchecker: wordbreak
[junit4] 2> 12393 T34 c:collection1 oasc.SolrCore.registerSearcher
[collection1] Registered new searcher Searcher@50a5f295[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 12400 T32 C2 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 12401 T32 C2 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 12401 T32 C2 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
nrtIsCurrent: infoVersion matches: true; DW changes: true; BD changes: false
[junit4] 2> 12401 T32 C2 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
flush at getReader
[junit4] 2> 12401 T32 C2 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
startFullFlush
[junit4] 2> 12401 T32 C2 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
anyChanges? numDocsInRam=0 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 12402 T32 C2 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]: flush
naked frozen global deletes
[junit4] 2> 12405 T32 C2 oasu.LoggingInfoStream.message
[BD][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
push deletes 1 deleted queries bytesUsed=64 segmentPrivate?=false delGen=2
packetCount=1 totBytesUsed=64
[junit4] 2> 12406 T32 C2 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
flush: push buffered updates: 1 deleted queries bytesUsed=64
[junit4] 2> 12406 T32 C2 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
apply all deletes during flush
[junit4] 2> 12406 T32 C2 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
now apply all deletes for all segments maxDoc=0
[junit4] 2> 12406 T32 C2 oasu.LoggingInfoStream.message
[BD][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
prune sis=segments_1: minGen=9223372036854775807 packetCount=1
[junit4] 2> 12406 T32 C2 oasu.LoggingInfoStream.message
[BD][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 12406 T32 C2 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
return reader version=1 reader=StandardDirectoryReader(segments_1:1:nrt)
[junit4] 2> 12406 T32 C2 oasu.LoggingInfoStream.message
[DW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]
finishFullFlush success=true
[junit4] 2> 12407 T32 C2 oasu.LoggingInfoStream.message
[IW][TEST-LargeVolumeEmbeddedTest.testMultiThreaded-seed#[4484DB0CD4EA898]]:
getReader took 6 msec
[junit4] 2> 12411 T32 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {deleteByQuery=*:* (-1498108155118223360)} 0
48
[junit4] 2> 12413 T32 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 0
[junit4] 2> 12413 T32 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 1
[junit4] 2> 12413 T32 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 2
[junit4] 2> 12416 T32 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 3
[junit4] 2> 12416 T32 oascs.LargeVolumeTestBase.testMultiThreaded Started
thread: 4
[junit4] 2> 12530 T38 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T1:0 (1498108155171700736), T1:1
(1498108155183235073), T1:2 (1498108155184283648), T1:3 (1498108155184283649),
T1:4 (1498108155184283650), T1:5 (1498108155184283651), T1:6
(1498108155185332224), T1:7 (1498108155186380800), T1:8 (1498108155186380801),
T1:9 (1498108155186380802), ... (100 adds)]} 0 115
[junit4] 2> 12530 T38 C2 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 12532 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
commit: start
[junit4] 2> 12532 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
commit: enter lock
[junit4] 2> 12532 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
commit: now prepare
[junit4] 2> 12532 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
prepareCommit: flush
[junit4] 2> 12538 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
index before flush
[junit4] 2> 12538 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
startFullFlush
[junit4] 2> 12538 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
anyChanges? numDocsInRam=369 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 12538 T38 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-1]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 366 deleted terms (unique count=366) bytesUsed=61807,
segment=_0, aborted=false, numDocsInRAM=101, deleteQueue=DWDQ: [ generation: 2
]]
[junit4] 2> 12538 T38 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-1]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 358 deleted terms (unique count=358) bytesUsed=60453,
segment=_1, aborted=false, numDocsInRAM=49, deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 12539 T38 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-1]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 168 deleted terms (unique count=168) bytesUsed=28377,
segment=_2, aborted=false, numDocsInRAM=76, deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 12539 T38 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-1]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 341 deleted terms (unique count=341) bytesUsed=57592,
segment=_3, aborted=false, numDocsInRAM=96, deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 12539 T38 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-1]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 260 deleted terms (unique count=260) bytesUsed=43936,
segment=_4, aborted=false, numDocsInRAM=47, deleteQueue=DWDQ: [ generation: 2 ]]
[junit4] 2> 12543 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flush postings as segment _0 numDocs=101
[junit4] 2> 12545 T41 C2 oasu.LoggingInfoStream.message [DW][DocThread-4]:
DocumentsWriter has queued dwpt; will hijack this thread to flush pending
segment(s)
[junit4] 2> 12545 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: flush postings as segment _1 numDocs=49
[junit4] 2> 12546 T37 C2 oasu.LoggingInfoStream.message [DW][DocThread-0]:
DocumentsWriter has queued dwpt; will hijack this thread to flush pending
segment(s)
[junit4] 2> 12547 T37 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: flush postings as segment _2 numDocs=76
[junit4] 2> 12546 T40 C2 oasu.LoggingInfoStream.message [DW][DocThread-3]:
DocumentsWriter has queued dwpt; will hijack this thread to flush pending
segment(s)
[junit4] 2> 12548 T40 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: flush postings as segment _3 numDocs=96
[junit4] 2> 12546 T39 C2 oasu.LoggingInfoStream.message [DW][DocThread-2]:
DocumentsWriter has queued dwpt; will hijack this thread to flush pending
segment(s)
[junit4] 2> 12548 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flush postings as segment _4 numDocs=47
[junit4] 2> 12585 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has 0 deleted docs
[junit4] 2> 12585 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 12586 T39 C2 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> 12586 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed codec=Lucene50
[junit4] 2> 12586 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: new segment has 0 deleted docs
[junit4] 2> 12586 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 12586 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: 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> 12586 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: flushed codec=Lucene50
[junit4] 2> 12586 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: flushed: segment=_1 ramUsed=0.157 MB newFlushedSize=0.003
MB docs/MB=17,674.656
[junit4] 2> 12587 T41 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-4]: waitIfStalled: numFlushesPending: 0 netBytes: 611112
flushBytes: 611112 fullFlush: true
[junit4] 2> 12587 T41 C2 oasu.LoggingInfoStream.message [DW][DocThread-4]:
continue indexing after helping out flushing DocumentsWriter is healthy
[junit4] 2> 12588 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: findMerges: 0 segments
[junit4] 2> 12588 T41 C2 oasu.LoggingInfoStream.message [MS][DocThread-4]:
initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
[junit4] 2> 12589 T41 C2 oasu.LoggingInfoStream.message [MS][DocThread-4]:
now merge
[junit4] 2> 12589 T41 C2 oasu.LoggingInfoStream.message [MS][DocThread-4]:
index:
[junit4] 2> 12589 T41 C2 oasu.LoggingInfoStream.message [MS][DocThread-4]:
no more merges pending; now return
[junit4] 2> 12590 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed: segment=_4 ramUsed=0.141 MB newFlushedSize=0.003
MB docs/MB=17,538.46
[junit4] 2> 12590 T39 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-2]: waitIfStalled: numFlushesPending: 0 netBytes: 564754
flushBytes: 464464 fullFlush: true
[junit4] 2> 12590 T39 C2 oasu.LoggingInfoStream.message [DW][DocThread-2]:
continue indexing after helping out flushing DocumentsWriter is healthy
[junit4] 2> 12591 T39 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: findMerges: 0 segments
[junit4] 2> 12596 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: new segment has 0 deleted docs
[junit4] 2> 12598 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 12598 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: 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> 12598 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flushed codec=Lucene50
[junit4] 2> 12598 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flushed: segment=_0 ramUsed=0.16 MB newFlushedSize=0.004
MB docs/MB=24,738.654
[junit4] 2> 12600 T37 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: new segment has 0 deleted docs
[junit4] 2> 12600 T37 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 12600 T37 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: 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> 12600 T37 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: flushed codec=Lucene50
[junit4] 2> 12601 T37 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-0]: flushed: segment=_2 ramUsed=0.145 MB newFlushedSize=0.003
MB docs/MB=21,749.939
[junit4] 2> 12601 T37 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-0]: waitIfStalled: numFlushesPending: 0 netBytes: 369414
flushBytes: 163128 fullFlush: true
[junit4] 2> 12601 T37 C2 oasu.LoggingInfoStream.message [DW][DocThread-0]:
continue indexing after helping out flushing DocumentsWriter is healthy
[junit4] 2> 12601 T37 C2 oasu.LoggingInfoStream.message [DW][DocThread-0]:
publishFlushedSegment seg-private updates=null
[junit4] 2> 12602 T37 C2 oasu.LoggingInfoStream.message [IW][DocThread-0]:
publishFlushedSegment
[junit4] 2> 12602 T37 C2 oasu.LoggingInfoStream.message [BD][DocThread-0]:
push deletes 369 deleted terms (unique count=369) bytesUsed=2080
segmentPrivate?=false delGen=4 packetCount=1 totBytesUsed=2080
[junit4] 2> 12602 T37 C2 oasu.LoggingInfoStream.message [IW][DocThread-0]:
publish sets newSegment delGen=5 seg=_0(6.0.0):C101
[junit4] 2> 12602 T37 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: now checkpoint "_0(6.0.0):C101" [1 segments ; isCommit =
false]
[junit4] 2> 12602 T37 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: 0 msec to checkpoint
[junit4] 2> 12602 T37 C2 oasu.LoggingInfoStream.message [DW][DocThread-0]:
publishFlushedSegment seg-private updates=null
[junit4] 2> 12603 T37 C2 oasu.LoggingInfoStream.message [IW][DocThread-0]:
publishFlushedSegment
[junit4] 2> 12603 T37 C2 oasu.LoggingInfoStream.message [IW][DocThread-0]:
publish sets newSegment delGen=6 seg=_1(6.0.0):C49
[junit4] 2> 12603 T37 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: now checkpoint "_0(6.0.0):C101 _1(6.0.0):C49" [2 segments ;
isCommit = false]
[junit4] 2> 12604 T39 C2 oasu.LoggingInfoStream.message [MS][DocThread-2]:
now merge
[junit4] 2> 12604 T41 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T4:0 (1498108155190575104), T4:1
(1498108155223080960), T4:2 (1498108155223080962), T4:3 (1498108155223080964),
T4:4 (1498108155224129537), T4:5 (1498108155231469569), T4:6
(1498108155232518145), T4:7 (1498108155232518146), T4:8 (1498108155241955332),
T4:9 (1498108155244052481), ... (100 adds)]} 0 171
[junit4] 2> 12607 T37 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: 4 msec to checkpoint
[junit4] 2> 12607 T37 C2 oasu.LoggingInfoStream.message [DW][DocThread-0]:
publishFlushedSegment seg-private updates=null
[junit4] 2> 12607 T37 C2 oasu.LoggingInfoStream.message [IW][DocThread-0]:
publishFlushedSegment
[junit4] 2> 12607 T37 C2 oasu.LoggingInfoStream.message [IW][DocThread-0]:
publish sets newSegment delGen=7 seg=_2(6.0.0):C76
[junit4] 2> 12607 T37 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: now checkpoint "_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76"
[3 segments ; isCommit = false]
[junit4] 2> 12607 T37 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-0]: 0 msec to checkpoint
[junit4] 2> 12607 T37 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: findMerges: 3 segments
[junit4] 2> 12610 T40 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: new segment has 0 deleted docs
[junit4] 2> 12610 T40 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 12610 T40 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: 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> 12610 T40 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: flushed codec=Lucene50
[junit4] 2> 12611 T40 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-3]: flushed: segment=_3 ramUsed=0.157 MB newFlushedSize=0.004
MB docs/MB=24,534.072
[junit4] 2> 12611 T40 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-3]: waitIfStalled: numFlushesPending: 0 netBytes: 206615
flushBytes: 0 fullFlush: true
[junit4] 2> 12611 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
publishFlushedSegment seg-private updates=null
[junit4] 2> 12611 T40 C2 oasu.LoggingInfoStream.message [DW][DocThread-3]:
continue indexing after helping out flushing DocumentsWriter is healthy
[junit4] 2> 12611 T37 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_0(6.0.0):C101 size=0.004 MB [floored]
[junit4] 2> 12612 T37 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_2(6.0.0):C76 size=0.003 MB [floored]
[junit4] 2> 12612 T37 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: seg=_1(6.0.0):C49 size=0.003 MB [floored]
[junit4] 2> 12612 T37 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-0]: allowedSegmentCount=1 vs count=3 (eligible count=3)
tooBigCount=0
[junit4] 2> 12613 T39 C2 oasu.LoggingInfoStream.message [MS][DocThread-2]:
index: _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76
[junit4] 2> 12613 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
publishFlushedSegment
[junit4] 2> 12613 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
publish sets newSegment delGen=8 seg=_3(6.0.0):C96
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: now checkpoint "_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76
_3(6.0.0):C96" [4 segments ; isCommit = false]
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: 0 msec to checkpoint
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
publishFlushedSegment seg-private updates=null
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
publishFlushedSegment
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
publish sets newSegment delGen=9 seg=_4(6.0.0):C47
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: now checkpoint "_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76
_3(6.0.0):C96 _4(6.0.0):C47" [5 segments ; isCommit = false]
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: 0 msec to checkpoint
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
apply all deletes during flush
[junit4] 2> 12614 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
now apply all deletes for all segments maxDoc=403
[junit4] 2> 12615 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
applyDeletes: open segment readers took 0 msec
[junit4] 2> 12615 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
applyDeletes: infos=[_0(6.0.0):C101, _1(6.0.0):C49, _2(6.0.0):C76,
_3(6.0.0):C96, _4(6.0.0):C47] packetCount=1
[junit4] 2> 12616 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
applyDeletes took 1 msec for 5 segments, 0 newly deleted docs (query deletes),
0 visited terms, allDeleted=null
[junit4] 2> 12616 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
prune sis=segments_1: _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96
_4(6.0.0):C47 minGen=5 packetCount=1
[junit4] 2> 12616 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 12617 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
DocThread-1 finishFullFlush success=true
[junit4] 2> 12617 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: findMerges: 5 segments
[junit4] 2> 12618 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_0(6.0.0):C101 size=0.004 MB [floored]
[junit4] 2> 12619 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_3(6.0.0):C96 size=0.004 MB [floored]
[junit4] 2> 12619 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_2(6.0.0):C76 size=0.003 MB [floored]
[junit4] 2> 12619 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_1(6.0.0):C49 size=0.003 MB [floored]
[junit4] 2> 12619 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_4(6.0.0):C47 size=0.003 MB [floored]
[junit4] 2> 12620 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: allowedSegmentCount=1 vs count=5 (eligible count=5)
tooBigCount=0
[junit4] 2> 12620 T39 C2 oasu.LoggingInfoStream.message [MS][DocThread-2]:
no more merges pending; now return
[junit4] 2> 12627 T40 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T3:0 (1498108155177992192), T3:1
(1498108155224129538), T3:2 (1498108155225178112), T3:3 (1498108155225178113),
T3:4 (1498108155225178114), T3:5 (1498108155225178115), T3:6
(1498108155225178116), T3:7 (1498108155225178117), T3:8 (1498108155226226688),
T3:9 (1498108155230420992), ... (100 adds)]} 0 207
[junit4] 2> 12628 T38 C2 oasu.LoggingInfoStream.message [MS][DocThread-1]:
now merge
[junit4] 2> 12628 T38 C2 oasu.LoggingInfoStream.message [MS][DocThread-1]:
index: _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96 _4(6.0.0):C47
[junit4] 2> 12628 T38 C2 oasu.LoggingInfoStream.message [MS][DocThread-1]:
no more merges pending; now return
[junit4] 2> 12629 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
startCommit(): start
[junit4] 2> 12629 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
startCommit index=_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96
_4(6.0.0):C47 changeCount=13
[junit4] 2> 12629 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
done all syncs: [_3.si, _1.nvd, _0.nvd, _2_Lucene50_0.pos, _1.nvm, _1.fnm,
_4_Lucene50_0.doc, _1_Lucene50_0.tim, _2.nvd, _4_Lucene50_0.pos, _2.nvm,
_2.fnm, _1_Lucene50_0.tip, _2.si, _0_Lucene50_0.pos, _4_Lucene50_0.tip,
_4_Lucene50_0.tim, _4.fdt, _3_Lucene50_0.tim, _3.fdt, _3_Lucene50_0.tip,
_0.nvm, _0.fnm, _3.fdx, _0_Lucene50_0.doc, _1.si, _3_Lucene50_0.pos, _2.fdt,
_2.fdx, _2_Lucene50_0.tim, _2_Lucene50_0.tip, _4.fdx, _1_Lucene50_0.pos,
_3_Lucene50_0.doc, _1.fdx, _1.fdt, _0.si, _0_Lucene50_0.tim, _3.nvd, _4.nvm,
_4.fnm, _0.fdx, _3.nvm, _3.fnm, _0_Lucene50_0.tip, _4.nvd, _2_Lucene50_0.doc,
_0.fdt, _1_Lucene50_0.doc, _4.si]
[junit4] 2> 12630 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
commit: pendingCommit != null
[junit4] 2> 12630 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: now checkpoint "_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76
_3(6.0.0):C96 _4(6.0.0):C47" [5 segments ; isCommit = true]
[junit4] 2> 12630 T38 C2 oasc.SolrDeletionPolicy.onCommit
SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3ff23833
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@383b92dc),segFN=segments_1,generation=1}
[junit4] 2>
commit{dir=MockDirectoryWrapper(RAMDirectory@3ff23833
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@383b92dc),segFN=segments_2,generation=2}
[junit4] 2> 12631 T38 C2 oasc.SolrDeletionPolicy.updateCommits newest
commit generation = 2
[junit4] 2> 12631 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: deleteCommits: now decRef commit "segments_1"
[junit4] 2> 12631 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: delete "segments_1"
[junit4] 2> 12631 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: 1 msec to checkpoint
[junit4] 2> 12631 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
commit: wrote segments file "segments_2"
[junit4] 2> 12631 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
commit: took 111.3 msec
[junit4] 2> 12632 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
commit: done
[junit4] 2> 12632 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
anyChanges? numDocsInRam=90 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 12632 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
nrtIsCurrent: infoVersion matches: false; DW changes: true; BD changes: false
[junit4] 2> 12632 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
flush at getReader
[junit4] 2> 12633 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
startFullFlush
[junit4] 2> 12633 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
anyChanges? numDocsInRam=92 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 12633 T38 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-1]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 5 deleted terms (unique count=5) bytesUsed=845,
segment=_5, aborted=false, numDocsInRAM=6, deleteQueue=DWDQ: [ generation: 3 ]]
[junit4] 2> 12633 T38 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-1]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 85 deleted terms (unique count=85) bytesUsed=14365,
segment=_6, aborted=false, numDocsInRAM=86, deleteQueue=DWDQ: [ generation: 3 ]]
[junit4] 2> 12634 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flush postings as segment _5 numDocs=6
[junit4] 2> 12634 T39 C2 oasu.LoggingInfoStream.message [DW][DocThread-2]:
DocumentsWriter has queued dwpt; will hijack this thread to flush pending
segment(s)
[junit4] 2> 12634 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flush postings as segment _6 numDocs=86
[junit4] 2> 12638 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has 0 deleted docs
[junit4] 2> 12638 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 12639 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: 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> 12639 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed codec=Lucene50
[junit4] 2> 12639 T39 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-2]: flushed: segment=_6 ramUsed=0.114 MB newFlushedSize=0.003
MB docs/MB=24,584.933
[junit4] 2> 12640 T39 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-2]: waitIfStalled: numFlushesPending: 0 netBytes: 100861
flushBytes: 100861 fullFlush: true
[junit4] 2> 12640 T39 C2 oasu.LoggingInfoStream.message [DW][DocThread-2]:
continue indexing after helping out flushing DocumentsWriter is healthy
[junit4] 2> 12640 T39 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: findMerges: 5 segments
[junit4] 2> 12640 T39 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_0(6.0.0):C101 size=0.004 MB [floored]
[junit4] 2> 12640 T37 C2 oasu.LoggingInfoStream.message [MS][DocThread-0]:
now merge
[junit4] 2> 12640 T39 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_3(6.0.0):C96 size=0.004 MB [floored]
[junit4] 2> 12640 T39 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_2(6.0.0):C76 size=0.003 MB [floored]
[junit4] 2> 12646 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: new segment has 0 deleted docs
[junit4] 2> 12646 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 12646 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: 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> 12646 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flushed codec=Lucene50
[junit4] 2> 12647 T38 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-1]: flushed: segment=_5 ramUsed=0.11 MB newFlushedSize=0.002
MB docs/MB=3,888.415
[junit4] 2> 12647 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
publishFlushedSegment seg-private updates=null
[junit4] 2> 12654 T39 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_1(6.0.0):C49 size=0.003 MB [floored]
[junit4] 2> 12654 T39 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: seg=_4(6.0.0):C47 size=0.003 MB [floored]
[junit4] 2> 12654 T39 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-2]: allowedSegmentCount=1 vs count=5 (eligible count=5)
tooBigCount=0
[junit4] 2> 12654 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
publishFlushedSegment
[junit4] 2> 12654 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
push deletes 92 deleted terms (unique count=92) bytesUsed=1056
segmentPrivate?=false delGen=11 packetCount=1 totBytesUsed=1056
[junit4] 2> 12654 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
publish sets newSegment delGen=12 seg=_5(6.0.0):C6
[junit4] 2> 12655 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: now checkpoint "_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76
_3(6.0.0):C96 _4(6.0.0):C47 _5(6.0.0):C6" [6 segments ; isCommit = false]
[junit4] 2> 12656 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: 0 msec to checkpoint
[junit4] 2> 12656 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
publishFlushedSegment seg-private updates=null
[junit4] 2> 12656 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
publishFlushedSegment
[junit4] 2> 12657 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
publish sets newSegment delGen=13 seg=_6(6.0.0):C86
[junit4] 2> 12657 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: now checkpoint "_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76
_3(6.0.0):C96 _4(6.0.0):C47 _5(6.0.0):C6 _6(6.0.0):C86" [7 segments ; isCommit
= false]
[junit4] 2> 12657 T38 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-1]: 0 msec to checkpoint
[junit4] 2> 12658 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
apply all deletes during flush
[junit4] 2> 12658 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
now apply all deletes for all segments maxDoc=462
[junit4] 2> 12658 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
applyDeletes: open segment readers took 0 msec
[junit4] 2> 12659 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
applyDeletes: infos=[_0(6.0.0):C101, _1(6.0.0):C49, _2(6.0.0):C76,
_3(6.0.0):C96, _4(6.0.0):C47, _5(6.0.0):C6, _6(6.0.0):C86] packetCount=1
[junit4] 2> 12712 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
applyTermDeletes took 1.4 msec for 7 segments and 1 packets; 92 del terms
visited; 212 seg terms visited
[junit4] 2> 12714 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
applyDeletes: 0 new deleted documents
[junit4] 2> 12714 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
applyDeletes took 56 msec for 7 segments, 0 newly deleted docs (query deletes),
92 visited terms, allDeleted=null
[junit4] 2> 12715 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
prune sis=segments_1: _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96
_4(6.0.0):C47 _5(6.0.0):C6 _6(6.0.0):C86 minGen=14 packetCount=1
[junit4] 2> 12715 T38 C2 oasu.LoggingInfoStream.message [BD][DocThread-1]:
pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 12716 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
return reader version=16 reader=StandardDirectoryReader(segments_1:16:nrt
_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96 _4(6.0.0):C47
_5(6.0.0):C6 _6(6.0.0):C86)
[junit4] 2> 12716 T38 C2 oasu.LoggingInfoStream.message [DW][DocThread-1]:
DocThread-1 finishFullFlush success=true
[junit4] 2> 12716 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: findMerges: 7 segments
[junit4] 2> 12716 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_0(6.0.0):C101 size=0.004 MB [floored]
[junit4] 2> 12717 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_3(6.0.0):C96 size=0.004 MB [floored]
[junit4] 2> 12718 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_6(6.0.0):C86 size=0.003 MB [floored]
[junit4] 2> 12718 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_2(6.0.0):C76 size=0.003 MB [floored]
[junit4] 2> 12719 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_1(6.0.0):C49 size=0.003 MB [floored]
[junit4] 2> 12719 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_4(6.0.0):C47 size=0.003 MB [floored]
[junit4] 2> 12720 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: seg=_5(6.0.0):C6 size=0.001 MB [floored]
[junit4] 2> 12720 T38 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-1]: allowedSegmentCount=1 vs count=7 (eligible count=7)
tooBigCount=0
[junit4] 2> 12725 T37 C2 oasu.LoggingInfoStream.message [MS][DocThread-0]:
index: _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96 _4(6.0.0):C47
_5(6.0.0):C6 _6(6.0.0):C86
[junit4] 2> 12725 T37 C2 oasu.LoggingInfoStream.message [MS][DocThread-0]:
no more merges pending; now return
[junit4] 2> 12731 T37 C2 oasup.LogUpdateProcessor.finish [collection1]
webapp=null path=/update params={} {add=[T0:0 (1498108155183235072), T0:1
(1498108155190575105), T0:2 (1498108155190575106), T0:3 (1498108155190575107),
T0:4 (1498108155190575108), T0:5 (1498108155191623680), T0:6
(1498108155191623681), T0:7 (1498108155191623682), T0:8 (1498108155192672256),
T0:9 (1498108155192672257), ... (100 adds)]} 0 305
[junit4] 2> 12732 T38 C2 oasu.LoggingInfoStream.message [MS][DocThread-1]:
now merge
[junit4] 2> 12732 T38 C2 oasu.LoggingInfoStream.message [MS][DocThread-1]:
index: _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96 _4(6.0.0):C47
_5(6.0.0):C6 _6(6.0.0):C86
[junit4] 2> 12732 T38 C2 oasu.LoggingInfoStream.message [MS][DocThread-1]:
no more merges pending; now return
[junit4] 2> 12732 T38 C2 oasu.LoggingInfoStream.message [IW][DocThread-1]:
getReader took 100 msec
[junit4] 2> 12734 T38 C2 oass.SolrIndexSearcher.<init> Opening
Searcher@9dc6830[collection1] main
[junit4] 2> 12734 T38 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 12735 T41 C2 oasu.DirectUpdateHandler2.commit start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 12736 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
commit: start
[junit4] 2> 12736 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
commit: enter lock
[junit4] 2> 12736 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
commit: now prepare
[junit4] 2> 12736 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
prepareCommit: flush
[junit4] 2> 12737 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
index before flush _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96
_4(6.0.0):C47 _5(6.0.0):C6 _6(6.0.0):C86
[junit4] 2> 12737 T41 C2 oasu.LoggingInfoStream.message [DW][DocThread-4]:
startFullFlush
[junit4] 2> 12737 T41 C2 oasu.LoggingInfoStream.message [DW][DocThread-4]:
anyChanges? numDocsInRam=21 deletes=true hasTickets:false
pendingChangesInFullFlush: false
[junit4] 2> 12737 T41 C2 oasu.LoggingInfoStream.message
[DWFC][DocThread-4]: addFlushableState DocumentsWriterPerThread
[pendingDeletes=gen=0 20 deleted terms (unique count=20) bytesUsed=3380,
segment=_7, aborted=false, numDocsInRAM=21, deleteQueue=DWDQ: [ generation: 4 ]]
[junit4] 2> 12738 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: flush postings as segment _7 numDocs=21
[junit4] 2> 12741 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: new segment has 0 deleted docs
[junit4] 2> 12741 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: new segment has no vectors; norms; no docValues; prox;
freqs
[junit4] 2> 12741 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: 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> 12741 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: flushed codec=Lucene50
[junit4] 2> 12741 T41 C2 oasu.LoggingInfoStream.message
[DWPT][DocThread-4]: flushed: segment=_7 ramUsed=0.1 MB newFlushedSize=0.002 MB
docs/MB=10,241.905
[junit4] 2> 12741 T41 C2 oasu.LoggingInfoStream.message [DW][DocThread-4]:
publishFlushedSegment seg-private updates=null
[junit4] 2> 12741 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
publishFlushedSegment
[junit4] 2> 12742 T41 C2 oasu.LoggingInfoStream.message [BD][DocThread-4]:
push deletes 21 deleted terms (unique count=21) bytesUsed=1056
segmentPrivate?=false delGen=15 packetCount=1 totBytesUsed=1056
[junit4] 2> 12742 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
publish sets newSegment delGen=16 seg=_7(6.0.0):C21
[junit4] 2> 12743 T41 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-4]: now checkpoint "_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76
_3(6.0.0):C96 _4(6.0.0):C47 _5(6.0.0):C6 _6(6.0.0):C86 _7(6.0.0):C21" [8
segments ; isCommit = false]
[junit4] 2> 12744 T41 C2 oasu.LoggingInfoStream.message
[IFD][DocThread-4]: 0 msec to checkpoint
[junit4] 2> 12744 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
apply all deletes during flush
[junit4] 2> 12744 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
now apply all deletes for all segments maxDoc=482
[junit4] 2> 12744 T41 C2 oasu.LoggingInfoStream.message [BD][DocThread-4]:
applyDeletes: open segment readers took 0 msec
[junit4] 2> 12745 T41 C2 oasu.LoggingInfoStream.message [BD][DocThread-4]:
applyDeletes: infos=[_0(6.0.0):C101, _1(6.0.0):C49, _2(6.0.0):C76,
_3(6.0.0):C96, _4(6.0.0):C47, _5(6.0.0):C6, _6(6.0.0):C86, _7(6.0.0):C21]
packetCount=1
[junit4] 2> 12747 T41 C2 oasu.LoggingInfoStream.message [BD][DocThread-4]:
applyTermDeletes took 0.8 msec for 8 segments and 1 packets; 21 del terms
visited; 56 seg terms visited
[junit4] 2> 12748 T41 C2 oasu.LoggingInfoStream.message [BD][DocThread-4]:
applyDeletes: 0 new deleted documents
[junit4] 2> 12748 T41 C2 oasu.LoggingInfoStream.message [BD][DocThread-4]:
applyDeletes took 4 msec for 8 segments, 0 newly deleted docs (query deletes),
21 visited terms, allDeleted=null
[junit4] 2> 12748 T41 C2 oasu.LoggingInfoStream.message [BD][DocThread-4]:
prune sis=segments_1: _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96
_4(6.0.0):C47 _5(6.0.0):C6 _6(6.0.0):C86 _7(6.0.0):C21 minGen=17 packetCount=1
[junit4] 2> 12748 T41 C2 oasu.LoggingInfoStream.message [BD][DocThread-4]:
pruneDeletes: prune 1 packets; 0 packets remain
[junit4] 2> 12748 T41 C2 oasu.LoggingInfoStream.message [DW][DocThread-4]:
DocThread-4 finishFullFlush success=true
[junit4] 2> 12748 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: findMerges: 8 segments
[junit4] 2> 12749 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: seg=_0(6.0.0):C101 size=0.004 MB [floored]
[junit4] 2> 12750 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: seg=_3(6.0.0):C96 size=0.004 MB [floored]
[junit4] 2> 12750 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: seg=_6(6.0.0):C86 size=0.003 MB [floored]
[junit4] 2> 12750 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: seg=_2(6.0.0):C76 size=0.003 MB [floored]
[junit4] 2> 12750 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: seg=_1(6.0.0):C49 size=0.003 MB [floored]
[junit4] 2> 12750 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: seg=_4(6.0.0):C47 size=0.003 MB [floored]
[junit4] 2> 12751 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: seg=_7(6.0.0):C21 size=0.002 MB [floored]
[junit4] 2> 12752 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: seg=_5(6.0.0):C6 size=0.001 MB [floored]
[junit4] 2> 12752 T41 C2 oasu.LoggingInfoStream.message
[TMP][DocThread-4]: allowedSegmentCount=1 vs count=8 (eligible count=8)
tooBigCount=0
[junit4] 2> 12752 T41 C2 oasu.LoggingInfoStream.message [MS][DocThread-4]:
now merge
[junit4] 2> 12752 T41 C2 oasu.LoggingInfoStream.message [MS][DocThread-4]:
index: _0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96 _4(6.0.0):C47
_5(6.0.0):C6 _6(6.0.0):C86 _7(6.0.0):C21
[junit4] 2> 12752 T41 C2 oasu.LoggingInfoStream.message [MS][DocThread-4]:
no more merges pending; now return
[junit4] 2> 12752 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
startCommit(): start
[junit4] 2> 12753 T41 C2 oasu.LoggingInfoStream.message [IW][DocThread-4]:
startCommit index=_0(6.0.0):C101 _1(6.0.0):C49 _2(6.0.0):C76 _3(6.0.0):C96
_4(6.0.0):C47 _5(6.0.0):C6 _6(6.0.0):C86 _7(6.0.0):C21 changeCount=18
[...truncated too long message...]
2 C3 oasu.LoggingInfoStream.message
[IFD][SUITE-LargeVolumeEmbeddedTest-seed#[4484DB0CD4EA898]-worker]: 0 msec to
checkpoint
[junit4] 2> 13552 T32 oasc.SolrCore.closeSearcher [collection1] Closing
main searcher on request.
[junit4] 2> 13552 T32 oasc.CachingDirectoryFactory.close Closing
MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 13552 T32 oasc.CachingDirectoryFactory.closeCacheValue looking
to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\index
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\index;done=false>>]
[junit4] 2> 13552 T32 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\index
[junit4] 2> 13553 T32 oasc.CachingDirectoryFactory.closeCacheValue looking
to close
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\;done=false>>]
[junit4] 2> 13553 T32 oasc.CachingDirectoryFactory.close Closing
directory:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\
[junit4] 2> 13553 T32 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 13553 T32 oasc.CoreContainer.shutdown Shutting down
CoreContainer instance=1298978602
[junit4] 2> ObjectTracker found objects that were not released!!!
[junit4] 2>
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
[junit4] 2> at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:33)
[junit4] 2> at
org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:183)
[junit4] 2> at
org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:141)
[junit4] 2> at
org.apache.solr.update.UpdateLog.ensureLog(UpdateLog.java:852)
[junit4] 2> at
org.apache.solr.update.UpdateLog.add(UpdateLog.java:414)
[junit4] 2> at
org.apache.solr.update.UpdateLog.add(UpdateLog.java:400)
[junit4] 2> at
org.apache.solr.update.DirectUpdateHandler2.addDoc0(DirectUpdateHandler2.java:258)
[junit4] 2> at
org.apache.solr.update.DirectUpdateHandler2.addDoc(DirectUpdateHandler2.java:163)
[junit4] 2> at
org.apache.solr.update.processor.RunUpdateProcessor.processAdd(RunUpdateProcessorFactory.java:69)
[junit4] 2> at
org.apache.solr.update.processor.UpdateRequestProcessor.processAdd(UpdateRequestProcessor.java:51)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalAdd(DistributedUpdateProcessor.java:949)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1104)
[junit4] 2> at
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:705)
[junit4] 2> at
org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104)
[junit4] 2> at
org.apache.solr.handler.loader.XMLLoader.processUpdate(XMLLoader.java:250)
[junit4] 2> at
org.apache.solr.handler.loader.XMLLoader.load(XMLLoader.java:177)
[junit4] 2> at
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98)
[junit4] 2> at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143)
[junit4] 2> at
org.apache.solr.core.SolrCore.execute(SolrCore.java:1988)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.EmbeddedSolrServer.request(EmbeddedSolrServer.java:179)
[junit4] 2> at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:107)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:72)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:86)
[junit4] 2> at
org.apache.solr.client.solrj.LargeVolumeTestBase$DocThread.run(LargeVolumeTestBase.java:109)
[junit4] 2>
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {},
docValues:{}, sim=DefaultSimilarity, locale=fr_CA, timezone=Europe/Copenhagen
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_40
(64-bit)/cpus=3,threads=1,free=185171312,total=214958080
[junit4] 2> NOTE: All tests run in this JVM: [NoOpResponseParserTest,
LargeVolumeEmbeddedTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=LargeVolumeEmbeddedTest -Dtests.seed=4484DB0CD4EA898
-Dtests.slow=true -Dtests.locale=fr_CA -Dtests.timezone=Europe/Copenhagen
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | LargeVolumeEmbeddedTest (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: Some resources were
not closed, shutdown, or released.
[junit4] > at
__randomizedtesting.SeedInfo.seed([4484DB0CD4EA898]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:234)
[junit4] > at java.lang.Thread.run(Thread.java:745)Throwable #2:
java.io.IOException: Could not remove the following files (in the order of
attempts):
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog\tlog.0000000000000000002:
java.nio.file.FileSystemException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-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-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001\tlog
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001\init-core-data-001
[junit4] >
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001: java.nio.file.DirectoryNotEmptyException:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.embedded.LargeVolumeEmbeddedTest
4484DB0CD4EA898-001
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:286)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [4/57] on J1 in 2.20s, 1 test, 1 failure, 1 error <<<
FAILURES!
[...truncated 170 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:526: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:474: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:242:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:511:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1415:
The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:973:
There were test failures: 57 suites, 374 tests, 2 suite-level errors
Total time: 56 minutes 29 seconds
Build step 'Invoke Ant' marked build as failure
[description-setter] Description set: Java: 64bit/jdk1.8.0_40
-XX:+UseCompressedOops -XX:+UseG1GC
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]
