Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/600/
Java: 64bit/jdk-11-ea+5 -XX:-UseCompressedOops -XX:+UseParallelGC
4 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.SampleTest
Error Message:
Could not remove the following files (in the order of attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001\init-core-data-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001\init-core-data-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001
Stack Trace:
java.io.IOException: Could not remove the following files (in the order of
attempts):
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001\init-core-data-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001\init-core-data-001
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001
at __randomizedtesting.SeedInfo.seed([3BA34723FCE4CA63]:0)
at org.apache.lucene.util.IOUtils.rm(IOUtils.java:318)
at
org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216)
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:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:841)
FAILED: org.apache.solr.update.MaxSizeAutoCommitTest.endToEndTest
{seed=[3BA34723FCE4CA63:66652C7DB4A6F514]}
Error Message:
Tlog size exceeds the max size bound. Tlog path:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.MaxSizeAutoCommitTest_3BA34723FCE4CA63-001\init-core-data-001\tlog\tlog.0000000000000000006,
tlog size: 5611
Stack Trace:
java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.MaxSizeAutoCommitTest_3BA34723FCE4CA63-001\init-core-data-001\tlog\tlog.0000000000000000006,
tlog size: 5611
at
__randomizedtesting.SeedInfo.seed([3BA34723FCE4CA63:66652C7DB4A6F514]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.update.MaxSizeAutoCommitTest.getTlogFileSizes(MaxSizeAutoCommitTest.java:379)
at
org.apache.solr.update.MaxSizeAutoCommitTest.endToEndTest(MaxSizeAutoCommitTest.java:231)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:841)
FAILED: org.apache.solr.common.util.TestTimeSource.testEpochTime
Error Message:
SimTimeSource:50.0 time diff=32565000
Stack Trace:
java.lang.AssertionError: SimTimeSource:50.0 time diff=32565000
at
__randomizedtesting.SeedInfo.seed([F5207A9F70897F60:CD4C09BAE459DD26]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.common.util.TestTimeSource.doTestEpochTime(TestTimeSource.java:48)
at
org.apache.solr.common.util.TestTimeSource.testEpochTime(TestTimeSource.java:32)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:841)
FAILED: org.apache.solr.common.util.TestTimeSource.testEpochTime
Error Message:
SimTimeSource:50.0 time diff=35260000
Stack Trace:
java.lang.AssertionError: SimTimeSource:50.0 time diff=35260000
at
__randomizedtesting.SeedInfo.seed([F5207A9F70897F60:CD4C09BAE459DD26]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.common.util.TestTimeSource.doTestEpochTime(TestTimeSource.java:48)
at
org.apache.solr.common.util.TestTimeSource.testEpochTime(TestTimeSource.java:32)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
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:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:841)
Build Log:
[...truncated 13166 lines...]
[junit4] Suite: org.apache.solr.SampleTest
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001\init-core-data-001
[junit4] 2> 610834 WARN (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=50 numCloses=50
[junit4] 2> 610834 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 610837 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 610837 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 610837 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 610841 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from
paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 610875 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 610885 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 610888 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 610968 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 610978 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 610978 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 610980 INFO (coreLoadExecutor-3379-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 611004 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 611048 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 611048 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 611048 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 611048 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
trusted=true
[junit4] 2> 611048 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 611066 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 611066 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001\init-core-data-001\]
[junit4] 2> 611091 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=41, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=88.30078125,
floorSegmentMB=2.1689453125, forceMergeDeletesPctAllowed=2.3266143128668757,
segmentsPerTier=47.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.14184174381831297
[junit4] 2> 611168 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=60
[junit4] 2> 611260 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 611260 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 611262 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=44, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 611263 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@7cc5a7c5[collection1] main]
[junit4] 2> 611264 WARN (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf;
switching to use InMemory storage instead.
[junit4] 2> 611265 INFO (coreLoadExecutor-3379-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 611265 INFO
(searcherExecutor-3380-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7cc5a7c5[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 611268 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 611283 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testAdvanced
[junit4] 2> 611286 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4059]} 0 2
[junit4] 2> 611290 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4059]} 0 1
[junit4] 2> 611290 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4055]} 0 0
[junit4] 2> 611290 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 611290 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7939c02f commitCommandVersion:0
[junit4] 2> 611367 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@be502af[collection1] main]
[junit4] 2> 611375 INFO (searcherExecutor-3380-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@be502af[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):c3)))}
[junit4] 2> 611375 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 611375 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 83
[junit4] 2> 611376 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 611376 WARN
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the
entire index! Use with care.
[junit4] 2> 611376 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 611376 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 611376 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 0
[junit4] 2> 611377 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null
params={q=subject:Hoss&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 611378 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null
params={q=Mack+Daddy&qt=/crazy_custom_qt&start=100&rows=200&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 611378 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null
params={q=Mack+Daddy&qt=/crazy_custom_qt&start=100&rows=200&version=2.2} hits=0
status=0 QTime=0
[junit4] 2> 611379 INFO
(TEST-SampleTest.testAdvanced-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testAdvanced
[junit4] 2> 611380 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testSimple
[junit4] 2> 611381 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4055]} 0 0
[junit4] 2> 611381 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{add=[4056]} 0 0
[junit4] 2> 611382 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 611382 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7939c02f commitCommandVersion:0
[junit4] 2> 611547 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@22fa0235[collection1] main]
[junit4] 2> 611549 INFO (searcherExecutor-3380-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@22fa0235[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):c3/1:delGen=1)
Uninverting(_1(7.4.0):c2)))}
[junit4] 2> 611555 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 611555 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{commit=} 0 173
[junit4] 2> 611556 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 611556 WARN
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the
entire index! Use with care.
[junit4] 2> 611586 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7939c02f commitCommandVersion:0
[junit4] 2> 611626 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5033120d[collection1] main]
[junit4] 2> 611628 INFO (searcherExecutor-3380-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@5033120d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.4.0):c4)))}
[junit4] 2> 611628 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 611631 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null
params={}{optimize=} 0 75
[junit4] 2> 611631 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ] o.a.s.c.S.Request
[collection1] webapp=null path=null
params={q=subject:Hoss&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 611633 INFO
(TEST-SampleTest.testSimple-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testSimple
[junit4] 2> 611634 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 611634 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=475217353
[junit4] 2> 611634 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 611634 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@70b3a4e6: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@4b862d1c
[junit4] 2> 611638 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 611638 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@401c4ab5: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@52c27796
[junit4] 2> 611641 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 611641 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1e0874e4: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@70b66e29
[junit4] 2> 611642 INFO (coreCloseExecutor-3384-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@3720dde6
[junit4] 2> 611642 INFO (coreCloseExecutor-3384-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=3720dde6
[junit4] 2> 611642 INFO (coreCloseExecutor-3384-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6227f112: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4fc5025d
[junit4] 2> 611654 INFO (SUITE-SampleTest-seed#[3BA34723FCE4CA63]-worker)
[ ] o.a.s.SolrTestCaseJ4
------------------------------------------------------- Done waiting for
tracked resources to be released
[junit4] 2> May 19, 2018 9:36:39 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are:
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=15477, maxDocsPerChunk=265, blockSize=2),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=15477, blockSize=2)), sim=RandomSimilarity(queryNorm=true): {},
locale=es-PR, timezone=Australia/NSW
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 11-ea
(64-bit)/cpus=3,threads=1,free=101288384,total=378535936
[junit4] 2> NOTE: All tests run in this JVM:
[DistributedFacetSimpleRefinementLongTailTest, TestMiniSolrCloudClusterSSL,
MultiThreadedOCPTest, SolrMetricsIntegrationTest, TestRemoteStreaming,
TestCollationField, CoreSorterTest, ScheduledTriggerIntegrationTest,
TestFaceting, TestPerFieldSimilarityWithDefaultOverride,
TestScoreJoinQPNoScore, TestCollectionsAPIViaSolrCloudCluster,
MigrateRouteKeyTest, AlternateDirectoryTest, ResponseBuilderTest,
AddBlockUpdateTest, CleanupOldIndexTest, TestNodeLostTrigger, CopyFieldTest,
TestFieldCacheVsDocValues, TestBinaryResponseWriter, RollingRestartTest,
TestTrie, TestFieldCache, ConfigSetsAPITest, TestStressInPlaceUpdates,
TestManagedSynonymGraphFilterFactory, TestBlobHandler,
TestTrackingShardHandlerFactory, TestIndexSearcher,
TestMultiValuedNumericRangeQuery, UnloadDistributedZkTest,
AsyncCallRequestStatusResponseTest, TestDownShardTolerantSearch,
TestSolrQueryResponse, TriggerCooldownIntegrationTest, TestCollectionAPIs,
DistributedFacetPivotSmallTest, SolrIndexSplitterTest,
MoveReplicaHDFSFailoverTest, BasicAuthStandaloneTest, TestSolr4Spatial2,
StatsReloadRaceTest, TestQueryTypes, ConjunctionSolrSpellCheckerTest,
VMParamsZkACLAndCredentialsProvidersTest, TestOmitPositions, TestCharFilters,
MetricUtilsTest, TestTolerantSearch, HttpSolrCallGetCoreTest,
TestSuggestSpellingConverter, TestSolrConfigHandlerConcurrent,
IndexSchemaRuntimeFieldTest, TlogReplayBufferedWhileIndexingTest,
TestManagedSchema, HighlighterMaxOffsetTest, TestCryptoKeys,
FastVectorHighlighterTest, HdfsDirectoryTest, FieldMutatingUpdateProcessorTest,
CurrencyFieldTypeTest, VersionInfoTest, TestPerFieldSimilarity,
TestLuceneIndexBackCompat, OverseerTaskQueueTest, ForceLeaderTest,
TestRawTransformer, TestManagedResourceStorage, SchemaApiFailureTest,
CdcrReplicationHandlerTest, TestCloudNestedDocsSort, SecurityConfHandlerTest,
BlockDirectoryTest, TestPayloadScoreQParserPlugin,
ChaosMonkeySafeLeaderWithPullReplicasTest, TestReRankQParserPlugin,
TestZkChroot, HdfsRecoveryZkTest, TestOverriddenPrefixQueryForCustomFieldType,
JSONWriterTest, TestRequestForwarding, HdfsTlogReplayBufferedWhileIndexingTest,
HdfsBasicDistributedZk2Test, TestDocTermOrds, SuggesterTSTTest,
TestFieldCacheSort, TestCloudRecovery, TestFunctionQuery, SampleTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SampleTest
-Dtests.seed=3BA34723FCE4CA63 -Dtests.slow=true -Dtests.locale=es-PR
-Dtests.timezone=Australia/NSW -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J0 | SampleTest (suite) <<<
[junit4] > Throwable #1: java.io.IOException: Could not remove the
following files (in the order of attempts):
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001\init-core-data-001:
java.nio.file.AccessDeniedException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001\init-core-data-001
[junit4] >
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001:
java.nio.file.DirectoryNotEmptyException:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.SampleTest_3BA34723FCE4CA63-001
[junit4] > at
__randomizedtesting.SeedInfo.seed([3BA34723FCE4CA63]:0)
[junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:318)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:841)
[junit4] Completed [190/805 (1!)] on J0 in 1.12s, 2 tests, 1 error <<<
FAILURES!
[...truncated 786 lines...]
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.MaxSizeAutoCommitTest_3BA34723FCE4CA63-001\init-core-data-001
[junit4] 2> 1628432 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[3BA34723FCE4CA63]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1628434 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[3BA34723FCE4CA63]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 1628434 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[3BA34723FCE4CA63]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1628436 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting deleteTest
[junit4] 2> 1628872 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1628873 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1628909 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1628942 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1629049 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1629154 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 1629174 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 1629174 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 1629176 INFO (coreLoadExecutor-7416-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1629178 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1629224 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1629237 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1629363 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1629383 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
trusted=true
[junit4] 2> 1629383 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 1629383 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1629384 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.MaxSizeAutoCommitTest_3BA34723FCE4CA63-001\init-core-data-001\]
[junit4] 2> 1629385 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.22476597657963115]
[junit4] 2> 1629388 WARN (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 1629499 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1629499 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1629502 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1629502 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1629502 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=26, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=8.7958984375,
floorSegmentMB=0.5703125, forceMergeDeletesPctAllowed=10.176889905600865,
segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1629502 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@469e0bef[collection1] main]
[junit4] 2> 1629502 WARN (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf;
switching to use InMemory storage instead.
[junit4] 2> 1629502 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1629502 INFO (coreLoadExecutor-7416-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1600931042082947072
[junit4] 2> 1629502 INFO
(searcherExecutor-7417-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@469e0bef[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1629502 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1629531 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1629531 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@54f44663 commitCommandVersion:0
[junit4] 2> 1629573 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7c6160b3[collection1] realtime]
[junit4] 2> 1629573 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1629573 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1629573 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@54f44663 commitCommandVersion:0
[junit4] 2> 1629613 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5818a9a3[collection1] realtime]
[junit4] 2> 1629613 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1629621 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1600931042082947073), 1 (1600931042082947074), 2 (1600931042082947075), 3
(1600931042082947076), 4 (1600931042082947077), 5 (1600931042082947078), 6
(1600931042098675712), 7 (1600931042098675713), 8 (1600931042098675714), 9
(1600931042098675715), ... (150 adds)]} 0 111
[junit4] 2> 1629873 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[0
(-1600931042466725888), 1 (-1600931042466725889), 2 (-1600931042466725890), 3
(-1600931042466725891), 4 (-1600931042466725892), 5 (-1600931042466725893), 6
(-1600931042466725894), 7 (-1600931042466725895), 8 (-1600931042466725896), 9
(-1600931042466725897), ... (15 deletes)]} 0 5
[junit4] 2> 1630077 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[15
(-1600931042685878272), 16 (-1600931042685878273), 17 (-1600931042685878274),
18 (-1600931042685878275), 19 (-1600931042685878276), 20
(-1600931042685878277), 21 (-1600931042685878278), 22 (-1600931042685878279),
23 (-1600931042685878280), 24 (-1600931042685878281), ... (15 deletes)]} 0 0
[junit4] 2> 1630079 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1630079 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@54f44663 commitCommandVersion:0
[junit4] 2> 1630081 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3c8b8a0e[collection1] realtime]
[junit4] 2> 1630086 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1630134 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[30
(-1600931042739355648), 31 (-1600931042741452800), 32 (-1600931042742501376),
33 (-1600931042742501377), 34 (-1600931042742501378), 35
(-1600931042742501379), 36 (-1600931042742501380), 37 (-1600931042742501381),
38 (-1600931042742501382), 39 (-1600931042742501383), ... (15 deletes)]} 0 6
[junit4] 2> 1630349 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[45
(-1600931042970042368), 46 (-1600931042970042369), 47 (-1600931042970042370),
48 (-1600931042970042371), 49 (-1600931042970042372), 50
(-1600931042970042373), 51 (-1600931042970042374), 52 (-1600931042970042375),
53 (-1600931042970042376), 54 (-1600931042970042377), ... (15 deletes)]} 0 1
[junit4] 2> 1630552 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[60
(-1600931043183951872), 61 (-1600931043183951873), 62 (-1600931043183951874),
63 (-1600931043183951875), 64 (-1600931043183951876), 65
(-1600931043183951877), 66 (-1600931043183951878), 67 (-1600931043183951879),
68 (-1600931043183951880), 69 (-1600931043183951881), ... (15 deletes)]} 0 0
[junit4] 2> 1630758 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[75
(-1600931043399958528), 76 (-1600931043399958529), 77 (-1600931043399958530),
78 (-1600931043399958531), 79 (-1600931043399958532), 80
(-1600931043399958533), 81 (-1600931043399958534), 82 (-1600931043399958535),
83 (-1600931043399958536), 84 (-1600931043399958537), ... (15 deletes)]} 0 0
[junit4] 2> 1630773 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1630773 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@54f44663 commitCommandVersion:0
[junit4] 2> 1630774 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3be5df69[collection1] realtime]
[junit4] 2> 1630777 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1630812 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[90
(-1600931043454484480), 91 (-1600931043455533056), 92 (-1600931043455533057),
93 (-1600931043455533058), 94 (-1600931043455533059), 95
(-1600931043455533060), 96 (-1600931043455533061), 97 (-1600931043455533062),
98 (-1600931043455533063), 99 (-1600931043455533064), ... (15 deletes)]} 0 3
[junit4] 2> 1631019 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[105
(-1600931043669442560), 106 (-1600931043669442561), 107 (-1600931043669442562),
108 (-1600931043669442563), 109 (-1600931043669442564), 110
(-1600931043669442565), 111 (-1600931043669442566), 112 (-1600931043669442567),
113 (-1600931043669442568), 114 (-1600931043669442569), ... (15 deletes)]} 0 3
[junit4] 2> 1631220 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[120
(-1600931043884400640), 121 (-1600931043884400641), 122 (-1600931043884400642),
123 (-1600931043884400643), 124 (-1600931043884400644), 125
(-1600931043884400645), 126 (-1600931043884400646), 127 (-1600931043884400647),
128 (-1600931043884400648), 129 (-1600931043884400649), ... (15 deletes)]} 0 0
[junit4] 2> 1631424 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[135
(-1600931044098310144), 136 (-1600931044098310145), 137 (-1600931044098310146),
138 (-1600931044098310147), 139 (-1600931044098310148), 140
(-1600931044098310149), 141 (-1600931044098310150), 142 (-1600931044098310151),
143 (-1600931044098310152), 144 (-1600931044098310153), ... (15 deletes)]} 0 0
[junit4] 2> 1631426 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1631426 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@54f44663 commitCommandVersion:0
[junit4] 2> 1631426 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@135ab691[collection1] realtime]
[junit4] 2> 1631426 INFO (commitScheduler-7420-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1631476 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending deleteTest
[junit4] 2> 1631476 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1631476 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=534273628
[junit4] 2> 1631476 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 1631476 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6046b366: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@73ce3961
[junit4] 2> 1631482 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 1631482 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@66da4652: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@52c27796
[junit4] 2> 1631486 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 1631487 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@53cd343e: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@70b66e29
[junit4] 2> 1631503 INFO (coreCloseExecutor-7422-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@28de2181
[junit4] 2> 1631503 INFO (coreCloseExecutor-7422-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=28de2181
[junit4] 2> 1631503 INFO (coreCloseExecutor-7422-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2304d2f7: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@52e20d1f
[junit4] 2> 1631555 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest
{seed=[3BA34723FCE4CA63:21F528151C56ED61]}
[junit4] 2> 1631555 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1631587 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1631631 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1631654 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1631752 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1631866 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 1631877 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 1631877 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 1631879 INFO (coreLoadExecutor-7429-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1631886 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib,
/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1631921 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1631922 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1632040 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1632058 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1,
trusted=true
[junit4] 2> 1632058 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1f9d0ca
[junit4] 2> 1632058 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1632058 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.update.MaxSizeAutoCommitTest_3BA34723FCE4CA63-001\init-core-data-001\]
[junit4] 2> 1632060 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.22476597657963115]
[junit4] 2> 1632081 WARN (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler
{type = requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 1632210 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1632210 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1632213 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1632213 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1632213 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=26, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=8.7958984375,
floorSegmentMB=0.5703125, forceMergeDeletesPctAllowed=10.176889905600865,
segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1632213 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@54476297[collection1] main]
[junit4] 2> 1632213 WARN (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1\conf;
switching to use InMemory storage instead.
[junit4] 2> 1632213 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1632213 INFO (coreLoadExecutor-7429-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1600931044925636608
[junit4] 2> 1632213 INFO
(searcherExecutor-7430-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@54476297[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1632213 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1632224 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1600931044925636609), 1 (1600931044936122368), 2 (1600931044936122369), 3
(1600931044936122370), 4 (1600931044936122371), 5 (1600931044936122372), 6
(1600931044936122373), 7 (1600931044936122374), 8 (1600931044936122375), 9
(1600931044936122376), ... (20 adds)]} 0 4
[junit4] 2> 1632436 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=215
[junit4] 2> 1632520 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20
(1600931045246500864), 21 (1600931045246500865), 22 (1600931045246500866), 23
(1600931045246500867), 24 (1600931045246500868), 25 (1600931045246500869), 26
(1600931045246500870), 27 (1600931045246500871), 28 (1600931045246500872), 29
(1600931045246500873), ... (20 adds)]} 0 1
[junit4] 2> 1632758 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=538
[junit4] 2> 1632760 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40
(1600931045497110528), 41 (1600931045498159104), 42 (1600931045498159105), 43
(1600931045498159106), 44 (1600931045498159107), 45 (1600931045498159108), 46
(1600931045498159109), 47 (1600931045498159110), 48 (1600931045498159111), 49
(1600931045498159112), ... (20 adds)]} 0 1
[junit4] 2> 1632965 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=745
[junit4] 2> 1632967 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60
(1600931045714165760), 61 (1600931045714165761), 62 (1600931045714165762), 63
(1600931045714165763), 64 (1600931045714165764), 65 (1600931045714165765), 66
(1600931045714165766), 67 (1600931045714165767), 68 (1600931045714165768), 69
(1600931045716262912), ... (20 adds)]} 0 4
[junit4] 2> 1633224 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1003
[junit4] 2> 1633226 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80
(1600931045985746944), 81 (1600931045986795520), 82 (1600931045986795521), 83
(1600931045986795522), 84 (1600931045986795523), 85 (1600931045986795524), 86
(1600931045986795525), 87 (1600931045986795526), 88 (1600931045986795527), 89
(1600931045986795528), ... (20 adds)]} 0 1
[junit4] 2> 1633486 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1265
[junit4] 2> 1633488 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100
(1600931046260473856), 101 (1600931046260473857), 102 (1600931046261522432),
103 (1600931046261522433), 104 (1600931046261522434), 105
(1600931046261522435), 106 (1600931046261522436), 107 (1600931046261522437),
108 (1600931046261522438), 109 (1600931046261522439), ... (20 adds)]} 0 1
[junit4] 2> 1633689 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1470
[junit4] 2> 1633703 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120
(1600931046473334784), 121 (1600931046475431936), 122 (1600931046475431937),
123 (1600931046475431938), 124 (1600931046475431939), 125
(1600931046475431940), 126 (1600931046482771968), 127 (1600931046482771969),
128 (1600931046482771970), 129 (1600931046482771971), ... (20 adds)]} 0 12
[junit4] 2> 1633710 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1633710 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1210f955 commitCommandVersion:0
[junit4] 2> 1633710 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6751bec1[collection1] realtime]
[junit4] 2> 1633710 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1633769 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1549
[junit4] 2> 1633785 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140
(1600931046557220864), 141 (1600931046559318016), 142 (1600931046559318017),
143 (1600931046559318018), 144 (1600931046559318019), 145
(1600931046559318020), 146 (1600931046559318021), 147 (1600931046559318022),
148 (1600931046559318023), 149 (1600931046559318024), ... (20 adds)]} 0 15
[junit4] 2> 1634030 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1811
[junit4] 2> 1634035 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160
(1600931046830899200), 161 (1600931046835093504), 162 (1600931046835093505),
163 (1600931046835093506), 164 (1600931046835093507), 165
(1600931046835093508), 166 (1600931046835093509), 167 (1600931046835093510),
168 (1600931046835093511), 169 (1600931046836142080), ... (20 adds)]} 0 4
[junit4] 2> 1634263 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2043
[junit4] 2> 1634266 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180
(1600931047077314560), 181 (1600931047077314561), 182 (1600931047077314562),
183 (1600931047077314563), 184 (1600931047077314564), 185
(1600931047077314565), 186 (1600931047077314566), 187 (1600931047077314567),
188 (1600931047077314568), 189 (1600931047077314569), ... (20 adds)]} 0 1
[junit4] 2> 1634478 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2257
[junit4] 2> 1634484 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200
(1600931047301709824), 201 (1600931047301709825), 202 (1600931047301709826),
203 (1600931047301709827), 204 (1600931047301709828), 205
(1600931047301709829), 206 (1600931047301709830), 207 (1600931047301709831),
208 (1600931047301709832), 209 (1600931047305904128), ... (20 adds)]} 0 5
[junit4] 2> 1634713 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2493
[junit4] 2> 1634716 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220
(1600931047547076608), 221 (1600931047549173760), 222 (1600931047549173761),
223 (1600931047549173762), 224 (1600931047549173763), 225
(1600931047549173764), 226 (1600931047549173765), 227 (1600931047549173766),
228 (1600931047549173767), 229 (1600931047549173768), ... (20 adds)]} 0 1
[junit4] 2> 1634941 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2720
[junit4] 2> 1634943 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240
(1600931047786151936), 241 (1600931047787200512), 242 (1600931047787200513),
243 (1600931047787200514), 244 (1600931047787200515), 245
(1600931047787200516), 246 (1600931047788249088), 247 (1600931047788249089),
248 (1600931047788249090), 249 (1600931047788249091), ... (20 adds)]} 0 1
[junit4] 2> 1635147 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2927
[junit4] 2> 1635152 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1635152 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1210f955 commitCommandVersion:0
[junit4] 2> 1635154 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260
(1600931048003207168), 261 (1600931048003207169), 262 (1600931048003207170),
263 (1600931048003207171), 264 (1600931048003207172), 265
(1600931048003207173), 266 (1600931048003207174), 267 (1600931048003207175),
268 (1600931048003207176), 269 (1600931048003207177), ... (20 adds)]} 0 6
[junit4] 2> 1635155 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@22393fc1[collection1] realtime]
[junit4] 2> 1635155 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1635373 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3154
[junit4] 2> 1635376 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280
(1600931048241233920), 281 (1600931048241233921), 282 (1600931048241233922),
283 (1600931048241233923), 284 (1600931048241233924), 285
(1600931048241233925), 286 (1600931048241233926), 287 (1600931048241233927),
288 (1600931048241233928), 289 (1600931048241233929), ... (20 adds)]} 0 1
[junit4] 2> 1635578 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3358
[junit4] 2> 1635580 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300
(1600931048455143424), 301 (1600931048455143425), 302 (1600931048455143426),
303 (1600931048455143427), 304 (1600931048455143428), 305
(1600931048455143429), 306 (1600931048455143430), 307 (1600931048455143431),
308 (1600931048455143432), 309 (1600931048455143433), ... (20 adds)]} 0 0
[junit4] 2> 1635782 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3562
[junit4] 2> 1635783 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320
(1600931048669052928), 321 (1600931048669052929), 322 (1600931048669052930),
323 (1600931048669052931), 324 (1600931048669052932), 325
(1600931048669052933), 326 (1600931048669052934), 327 (1600931048669052935),
328 (1600931048669052936), 329 (1600931048669052937), ... (20 adds)]} 0 0
[junit4] 2> 1635986 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3766
[junit4] 2> 1635990 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340
(1600931048881913856), 341 (1600931048881913857), 342 (1600931048881913858),
343 (1600931048881913859), 344 (1600931048881913860), 345
(1600931048881913861), 346 (1600931048882962432), 347 (1600931048886108160),
348 (1600931048886108161), 349 (1600931048886108162), ... (20 adds)]} 0 4
[junit4] 2> 1636193 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3972
[junit4] 2> 1636194 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360
(1600931049098969088), 361 (1600931049098969089), 362 (1600931049098969090),
363 (1600931049098969091), 364 (1600931049098969092), 365
(1600931049098969093), 366 (1600931049098969094), 367 (1600931049098969095),
368 (1600931049098969096), 369 (1600931049098969097), ... (20 adds)]} 0 0
[junit4] 2> 1636397 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4176
[junit4] 2> 1636398 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380
(1600931049312878592), 381 (1600931049312878593), 382 (1600931049312878594),
383 (1600931049312878595), 384 (1600931049312878596), 385
(1600931049312878597), 386 (1600931049312878598), 387 (1600931049312878599),
388 (1600931049312878600), 389 (1600931049313927168), ... (20 adds)]} 0 1
[junit4] 2> 1636601 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4381
[junit4] 2> 1636604 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1636604 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1210f955 commitCommandVersion:0
[junit4] 2> 1636608 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400
(1600931049526788096), 401 (1600931049526788097), 402 (1600931049526788098),
403 (1600931049527836672), 404 (1600931049527836673), 405
(1600931049527836674), 406 (1600931049527836675), 407 (1600931049527836676),
408 (1600931049527836677), 409 (1600931049527836678), ... (20 adds)]} 0 6
[junit4] 2> 1636609 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@60cb379f[collection1] realtime]
[junit4] 2> 1636609 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1636817 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4597
[junit4] 2> 1636819 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420
(1600931049754329088), 421 (1600931049754329089), 422 (1600931049754329090),
423 (1600931049754329091), 424 (1600931049754329092), 425
(1600931049754329093), 426 (1600931049754329094), 427 (1600931049754329095),
428 (1600931049754329096), 429 (1600931049754329097), ... (20 adds)]} 0 1
[junit4] 2> 1637022 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4802
[junit4] 2> 1637023 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440
(1600931049968238592), 441 (1600931049968238593), 442 (1600931049968238594),
443 (1600931049968238595), 444 (1600931049969287168), 445
(1600931049969287169), 446 (1600931049969287170), 447 (1600931049969287171),
448 (1600931049969287172), 449 (1600931049969287173), ... (20 adds)]} 0 1
[junit4] 2> 1637227 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5006
[junit4] 2> 1637230 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460
(1600931050183196672), 461 (1600931050183196673), 462 (1600931050183196674),
463 (1600931050183196675), 464 (1600931050183196676), 465
(1600931050183196677), 466 (1600931050184245248), 467 (1600931050184245249),
468 (1600931050184245250), 469 (1600931050184245251), ... (20 adds)]} 0 2
[junit4] 2> 1637433 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5213
[junit4] 2> 1637439 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480
(1600931050400251904), 481 (1600931050400251905), 482 (1600931050400251906),
483 (1600931050400251907), 484 (1600931050400251908), 485
(1600931050404446208), 486 (1600931050405494784), 487 (1600931050405494785),
488 (1600931050405494786), 489 (1600931050405494787), ... (20 adds)]} 0 5
[junit4] 2> 1637647 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5427
[junit4] 2> 1637649 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1600931050624647168), 501 (1600931050624647169), 502 (1600931050624647170),
503 (1600931050625695744), 504 (1600931050625695745), 505
(1600931050625695746), 506 (1600931050625695747), 507 (1600931050625695748),
508 (1600931050625695749), 509 (1600931050625695750), ... (20 adds)]} 0 1
[junit4] 2> 1637853 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5633
[junit4] 2> 1637854 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520
(1600931050839605248), 521 (1600931050839605249), 522 (1600931050839605250),
523 (1600931050840653824), 524 (1600931050840653825), 525
(1600931050840653826), 526 (1600931050840653827), 527 (1600931050840653828),
528 (1600931050840653829), 529 (1600931050840653830), ... (20 adds)]} 0 1
[junit4] 2> 1638057 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5836
[junit4] 2> 1638062 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1638062 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1210f955 commitCommandVersion:0
[junit4] 2> 1638067 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3affc2bd[collection1] realtime]
[junit4] 2> 1638067 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540
(1600931051053514752), 541 (1600931051054563328), 542 (1600931051054563329),
543 (1600931051054563330), 544 (1600931051054563331), 545
(1600931051054563332), 546 (1600931051054563333), 547 (1600931051054563334),
548 (1600931051054563335), 549 (1600931051054563336), ... (20 adds)]} 0 10
[junit4] 2> 1638068 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1638278 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6057
[junit4] 2> 1638289 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560
(1600931051285250048), 561 (1600931051285250049), 562 (1600931051285250050),
563 (1600931051285250051), 564 (1600931051285250052), 565
(1600931051286298624), 566 (1600931051286298625), 567 (1600931051286298626),
568 (1600931051286298627), 569 (1600931051286298628), ... (20 adds)]} 0 10
[junit4] 2> 1638492 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6271
[junit4] 2> 1638493 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580
(1600931051509645312), 581 (1600931051510693888), 582 (1600931051510693889),
583 (1600931051510693890), 584 (1600931051510693891), 585
(1600931051510693892), 586 (1600931051510693893), 587 (1600931051510693894),
588 (1600931051510693895), 589 (1600931051510693896), ... (20 adds)]} 0 1
[junit4] 2> 1638697 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6476
[junit4] 2> 1638697 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600
(1600931051724603392), 601 (1600931051724603393), 602 (1600931051724603394),
603 (1600931051724603395), 604 (1600931051724603396), 605
(1600931051724603397), 606 (1600931051724603398), 607 (1600931051724603399),
608 (1600931051724603400), 609 (1600931051724603401), ... (20 adds)]} 0 1
[junit4] 2> 1638904 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6683
[junit4] 2> 1638925 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620
(1600931051941658624), 621 (1600931051941658625), 622 (1600931051941658626),
623 (1600931051962630144), 624 (1600931051963678720), 625
(1600931051963678721), 626 (1600931051963678722), 627 (1600931051963678723),
628 (1600931051963678724), 629 (1600931051963678725), ... (20 adds)]} 0 21
[junit4] 2> 1639146 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6925
[junit4] 2> 1639147 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640
(1600931052196462592), 641 (1600931052196462593), 642 (1600931052196462594),
643 (1600931052196462595), 644 (1600931052196462596), 645
(1600931052196462597), 646 (1600931052196462598), 647 (1600931052196462599),
648 (1600931052196462600), 649 (1600931052196462601), ... (20 adds)]} 0 1
[junit4] 2> 1639350 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7130
[junit4] 2> 1639353 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660
(1600931052409323520), 661 (1600931052411420672), 662 (1600931052411420673),
663 (1600931052411420674), 664 (1600931052411420675), 665
(1600931052411420676), 666 (1600931052411420677), 667 (1600931052411420678),
668 (1600931052411420679), 669 (1600931052411420680), ... (20 adds)]} 0 1
[junit4] 2> 1639556 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3BA34723FCE4CA63]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7335
[junit4] 2> 1639559 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1639559 INFO (commitScheduler-7433-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndex
[...truncated too long message...]
urce_F5207A9F70897F60-001
[junit4] 2> NOTE: test params are: codec=CheapBastard,
sim=RandomSimilarity(queryNorm=true): {}, locale=mn, timezone=Pacific/Galapagos
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 11-ea
(64-bit)/cpus=3,threads=1,free=399983600,total=469237760
[junit4] 2> NOTE: All tests run in this JVM: [RawValueEvaluatorTest,
CloudSolrClientBuilderTest, ArcTangentEvaluatorTest,
HttpSolrClientSSLAuthConPoolTest, SolrDocumentTest, OrEvaluatorTest,
GetByIdTest, DocumentAnalysisResponseTest, GraphExpressionTest,
CubedRootEvaluatorTest, OperationsTest, DivideEvaluatorTest,
SolrExampleStreamingTest, SolrExampleEmbeddedTest, JDBCStreamTest,
NormalizeEvaluatorTest, SolrZkClientTest, FieldValueEvaluatorTest,
RegressionEvaluatorTest, TestJavaBinCodec, HyperbolicCosineEvaluatorTest,
AscEvaluatorTest, TestRetryUtil, HttpSolrClientBuilderTest,
StreamExpressionParserTest, HyperbolicTangentEvaluatorTest, TestBatchUpdate,
TestV2Request, TestHash, AbsoluteValueEvaluatorTest, TestCoreAdmin,
TestCloudSolrClientConnections, AnlysisResponseBaseTest,
GreaterThanEqualToEvaluatorTest, TestSuggesterResponse, AndEvaluatorTest,
TestDocumentObjectBinder, SolrExampleXMLTest, SolrExampleStreamingBinaryTest,
SolrExampleJettyTest, LargeVolumeBinaryJettyTest, JettyWebappTest,
LargeVolumeEmbeddedTest, TestSpellCheckResponse, LargeVolumeJettyTest,
TestSolrProperties, SolrParamTest, TermsResponseTest, MergeIndexesEmbeddedTest,
TestEmbeddedSolrServer, QueryResponseTest, SolrQueryTest, ContentStreamTest,
ModifiableSolrParamsTest, TestXMLEscaping, TestUpdateRequestCodec,
FieldAnalysisResponseTest, ClientUtilsTest, NamedListTest,
UsingSolrJRefGuideExamplesTest, CollectionAdminRequestRequiredParamsTest,
SolrSchemalessExampleTest, TestLBHttpSolrClient, TestSolrJErrorHandling,
TestPolicy, BasicHttpSolrClientTest, CloudSolrClientMultiConstructorTest,
CloudSolrClientTest, ConcurrentUpdateSolrClientBuilderTest, JdbcDriverTest,
JdbcTest, SelectWithEvaluatorsTest, StreamExpressionTest,
TestCollectionStateWatchers, CommonAdminParamsTest, ShardParamsTest,
JsonValidatorTest, TestJsonRecordReader, TestTimeSource]
[junit4] Completed [152/152 (1!)] on J0 in 10.04s, 1 test, 1 failure <<<
FAILURES!
[...truncated 42815 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/600/consoleText
[repro] Revision: 1e661ed97aed0cc77869b01134d80c761c6b5295
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr\core
[repro] MaxSizeAutoCommitTest
[repro] SampleTest
[repro] solr\solrj
[repro] TestTimeSource
[repro] ant compile-test
[...truncated 3342 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10
-Dtests.class="*.MaxSizeAutoCommitTest|*.SampleTest" -Dtests.showOutput=onerror
"-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"
-Dtests.seed=3BA34723FCE4CA63 -Dtests.slow=true -Dtests.locale=de-BE
-Dtests.timezone=Asia/Macao -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 135 lines...]
[repro] ant compile-test
[...truncated 447 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.TestTimeSource" -Dtests.showOutput=onerror
"-Dargs=-XX:-UseCompressedOops -XX:+UseParallelGC"
-Dtests.seed=F5207A9F70897F60 -Dtests.slow=true -Dtests.locale=mn
-Dtests.timezone=Pacific/Galapagos -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[...truncated 36 lines...]
[junit4] Suite: org.apache.solr.common.util.TestTimeSource
[junit4] 2> SLF4J: Class path contains multiple SLF4J bindings.
[junit4] 2> SLF4J: Found binding in
[jar:file:/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/solrj/test-lib/log4j-slf4j-impl-2.11.0.jar!/org/slf4j/impl/StaticLoggerBinder.class]
[junit4] 2> SLF4J: Found binding in
[jar:file:/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/lib/log4j-slf4j-impl-2.11.0.jar!/org/slf4j/impl/StaticLoggerBinder.class]
[junit4] 2> SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings
for an explanation.
[junit4] 2> SLF4J: Actual binding is of type
[org.apache.logging.slf4j.Log4jLoggerFactory]
[junit4] 2> 12210 INFO
(SUITE-TestTimeSource-seed#[F5207A9F70897F60]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.common.util.TestTimeSource_F5207A9F70897F60-001\init-core-data-001
[junit4] 2> 12431 INFO
(SUITE-TestTimeSource-seed#[F5207A9F70897F60]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 12499 INFO
(SUITE-TestTimeSource-seed#[F5207A9F70897F60]-worker) [ ] o.e.j.u.log
Logging initialized @12576ms to org.eclipse.jetty.util.log.Slf4jLog
[junit4] 2> 12517 INFO
(SUITE-TestTimeSource-seed#[F5207A9F70897F60]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 12957 INFO
(TEST-TestTimeSource.testEpochTime-seed#[F5207A9F70897F60]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testEpochTime
[junit4] 2> 23021 INFO
(TEST-TestTimeSource.testEpochTime-seed#[F5207A9F70897F60]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testEpochTime
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestTimeSource
-Dtests.method=testEpochTime -Dtests.seed=F5207A9F70897F60 -Dtests.slow=true
-Dtests.badapples=true -Dtests.locale=mn -Dtests.timezone=Pacific/Galapagos
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 10.2s J0 | TestTimeSource.testEpochTime <<<
[junit4] > Throwable #1: java.lang.AssertionError: SimTimeSource:50.0
time diff=32565000
[junit4] > at
__randomizedtesting.SeedInfo.seed([F5207A9F70897F60:CD4C09BAE459DD26]:0)
[junit4] > at
org.apache.solr.common.util.TestTimeSource.doTestEpochTime(TestTimeSource.java:48)
[junit4] > at
org.apache.solr.common.util.TestTimeSource.testEpochTime(TestTimeSource.java:32)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:841)
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-solrj\test\J0\temp\solr.common.util.TestTimeSource_F5207A9F70897F60-001
[junit4] 2> NOTE: test params are: codec=CheapBastard,
sim=RandomSimilarity(queryNorm=true): {}, locale=mn, timezone=Pacific/Galapagos
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 11-ea
(64-bit)/cpus=3,threads=1,free=69348080,total=130023424
[junit4] 2> NOTE: All tests run in this JVM: [TestTimeSource]
[junit4] Completed [2/5 (1!)] on J0 in 21.07s, 1 test, 1 failure <<<
FAILURES!
[...truncated 23 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\common-build.xml:1568:
The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\common-build.xml:1092:
There were test failures: 5 suites, 5 tests, 1 failure [seed: F5207A9F70897F60]
Total time: 47 seconds
[repro] Setting last failure code to 1
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.SampleTest
[repro] 0/5 failed: org.apache.solr.update.MaxSizeAutoCommitTest
[repro] 1/5 failed: org.apache.solr.common.util.TestTimeSource
[repro] Exiting with code 1
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>IF EXIST lucene\build move
/y lucene\build lucene\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>IF EXIST solr\build move /y
solr\build solr\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>IF EXIST lucene\build.orig
move /y lucene\build.orig lucene\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>IF EXIST solr\build.orig
move /y solr\build.orig solr\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows>exit 0
Archiving artifacts
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all
warnings.
<Git Blamer> GIT_COMMIT=1e661ed97aed0cc77869b01134d80c761c6b5295,
workspace=C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows
[WARNINGS] Computing warning deltas based on reference build #599
Recording test results
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting
ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
