Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1937/
Java: 64bit/jdk-10 -XX:+UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest
Error Message:
Tlog size exceeds the max size bound. Tlog path:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_62E5ED7CC881B3D1-001/init-core-data-001/tlog/tlog.0000000000000000005,
tlog size: 1276
Stack Trace:
java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_62E5ED7CC881B3D1-001/init-core-data-001/tlog/tlog.0000000000000000005,
tlog size: 1276
at
__randomizedtesting.SeedInfo.seed([62E5ED7CC881B3D1:72AB0883B32F8A20]: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.deleteTest(MaxSizeAutoCommitTest.java:200)
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:844)
Build Log:
[...truncated 15313 lines...]
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] 2> 1950317 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[62E5ED7CC881B3D1]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_62E5ED7CC881B3D1-001/init-core-data-001
[junit4] 2> 1950318 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[62E5ED7CC881B3D1]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1950318 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[62E5ED7CC881B3D1]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 1950320 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting simpleTest
[junit4] 2> 1950320 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1950320 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1950335 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1950352 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1950427 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1950460 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1950468 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1950469 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1950470 INFO (coreLoadExecutor-9917-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1950470 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1950482 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1950490 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1950540 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1950544 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1950545 INFO (coreLoadExecutor-9917-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@c8c9efe
[junit4] 2> 1950545 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1950545 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_62E5ED7CC881B3D1-001/init-core-data-001/]
[junit4] 2> 1950545 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=564834558,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1950547 WARN (coreLoadExecutor-9917-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> 1950566 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1950566 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1950567 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1950567 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1950567 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1468166810,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1950568 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@73918494[collection1] main]
[junit4] 2> 1950568 WARN (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1950568 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1950569 INFO
(searcherExecutor-9918-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@73918494[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1950569 INFO (coreLoadExecutor-9917-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1600937881002573824
[junit4] 2> 1950570 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1950573 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1600937881004670976), 1 (1600937881005719552), 2 (1600937881005719553)]} 0 1
[junit4] 2> 1950776 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3
(1600937881217531904), 4 (1600937881218580480), 5 (1600937881218580481)]} 0 2
[junit4] 2> 1950979 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6
(1600937881430392832), 7 (1600937881430392833), 8 (1600937881432489984)]} 0 1
[junit4] 2> 1951183 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9
(1600937881643253760), 10 (1600937881644302336), 11 (1600937881645350912)]} 0 2
[junit4] 2> 1951386 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12
(1600937881857163264), 13 (1600937881857163265), 14 (1600937881858211840)]} 0 1
[junit4] 2> 1951588 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15
(1600937882068975616), 16 (1600937882070024192), 17 (1600937882070024193)]} 0 2
[junit4] 2> 1951791 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[18
(1600937882281836544), 19 (1600937882281836545), 20 (1600937882283933696)]} 0 2
[junit4] 2> 1951995 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[21
(1600937882494697472), 22 (1600937882495746048), 23 (1600937882496794624)]} 0 2
[junit4] 2> 1952198 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[24
(1600937882707558400), 25 (1600937882708606976), 26 (1600937882709655552)]} 0 2
[junit4] 2> 1952198 INFO (commitScheduler-9921-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1952198 INFO (commitScheduler-9921-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@b2be460 commitCommandVersion:0
[junit4] 2> 1952200 INFO (commitScheduler-9921-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5e6d71c5[collection1] realtime]
[junit4] 2> 1952200 INFO (commitScheduler-9921-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1952250 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[27
(1600937882764181504), 28 (1600937882764181505), 29 (1600937882765230080)]} 0 1
[junit4] 2> 1952451 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending simpleTest
[junit4] 2> 1952451 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1952451 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1300689919
[junit4] 2> 1952451 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 1952451 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1a12905f: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@320a4a11
[junit4] 2> 1952454 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 1952454 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5791d828: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@e8d399a
[junit4] 2> 1952456 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 1952456 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@563be4c2: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@4ed22314
[junit4] 2> 1952457 INFO (coreCloseExecutor-9923-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@9acc13a
[junit4] 2> 1952457 INFO (coreCloseExecutor-9923-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=9acc13a
[junit4] 2> 1952457 INFO (coreCloseExecutor-9923-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7f2098dc: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@784f45e2
[junit4] 2> 1952463 INFO (coreCloseExecutor-9923-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 1952463 INFO (coreCloseExecutor-9923-thread-1) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@b2be460 commitCommandVersion:0
[junit4] 2> 1952469 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest
{seed=[62E5ED7CC881B3D1:78B3824A283394D3]}
[junit4] 2> 1952470 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1952470 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1952489 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1952498 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1952587 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1952630 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1952635 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1952635 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1952637 INFO (coreLoadExecutor-9930-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1952637 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1952652 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1952662 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1952803 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1952810 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1952810 INFO (coreLoadExecutor-9930-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@c8c9efe
[junit4] 2> 1952810 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1952810 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_62E5ED7CC881B3D1-001/init-core-data-001/]
[junit4] 2> 1952812 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=564834558,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1952827 WARN (coreLoadExecutor-9930-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> 1952859 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1952860 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1952860 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1952860 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1952861 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1468166810,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1952861 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@713875fc[collection1] main]
[junit4] 2> 1952861 WARN (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1952862 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1952862 INFO (coreLoadExecutor-9930-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1600937883406958592
[junit4] 2> 1952864 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1952872 INFO
(searcherExecutor-9931-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@713875fc[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1952923 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1600937883410104320), 1 (1600937883410104321), 2 (1600937883411152896), 3
(1600937883411152897), 4 (1600937883412201472), 5 (1600937883412201473), 6
(1600937883413250048), 7 (1600937883413250049), 8 (1600937883414298624), 9
(1600937883415347200), ... (20 adds)]} 0 58
[junit4] 2> 1953131 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=266
[junit4] 2> 1953164 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20
(1600937883690074112), 21 (1600937883696365568), 22 (1600937883697414144), 23
(1600937883697414145), 24 (1600937883698462720), 25 (1600937883699511296), 26
(1600937883700559872), 27 (1600937883700559873), 28 (1600937883701608448), 29
(1600937883701608449), ... (20 adds)]} 0 32
[junit4] 2> 1953365 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=500
[junit4] 2> 1953382 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40
(1600937883934392320), 41 (1600937883935440896), 42 (1600937883936489472), 43
(1600937883936489473), 44 (1600937883937538048), 45 (1600937883938586624), 46
(1600937883939635200), 47 (1600937883939635201), 48 (1600937883940683776), 49
(1600937883940683777), ... (20 adds)]} 0 16
[junit4] 2> 1953583 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=718
[junit4] 2> 1953599 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60
(1600937884164030464), 61 (1600937884164030465), 62 (1600937884165079040), 63
(1600937884165079041), 64 (1600937884166127616), 65 (1600937884166127617), 66
(1600937884166127618), 67 (1600937884166127619), 68 (1600937884167176192), 69
(1600937884167176193), ... (20 adds)]} 0 15
[junit4] 2> 1953799 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=934
[junit4] 2> 1953817 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80
(1600937884390522880), 81 (1600937884390522881), 82 (1600937884391571456), 83
(1600937884391571457), 84 (1600937884392620032), 85 (1600937884392620033), 86
(1600937884393668608), 87 (1600937884393668609), 88 (1600937884394717184), 89
(1600937884396814336), ... (20 adds)]} 0 17
[junit4] 2> 1954017 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1152
[junit4] 2> 1954028 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100
(1600937884619112448), 101 (1600937884619112449), 102 (1600937884620161024),
103 (1600937884620161025), 104 (1600937884621209600), 105
(1600937884621209601), 106 (1600937884622258176), 107 (1600937884622258177),
108 (1600937884623306752), 109 (1600937884623306753), ... (20 adds)]} 0 10
[junit4] 2> 1954229 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1364
[junit4] 2> 1954248 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120
(1600937884840361984), 121 (1600937884840361985), 122 (1600937884841410560),
123 (1600937884841410561), 124 (1600937884842459136), 125
(1600937884842459137), 126 (1600937884843507712), 127 (1600937884843507713),
128 (1600937884844556288), 129 (1600937884844556289), ... (20 adds)]} 0 19
[junit4] 2> 1954248 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1954248 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3a7f319b commitCommandVersion:0
[junit4] 2> 1954249 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@51f46b41[collection1] realtime]
[junit4] 2> 1954249 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1954299 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1434
[junit4] 2> 1954308 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140
(1600937884913762304), 141 (1600937884913762305), 142 (1600937884914810880),
143 (1600937884914810881), 144 (1600937884914810882), 145
(1600937884915859456), 146 (1600937884915859457), 147 (1600937884915859458),
148 (1600937884916908032), 149 (1600937884916908033), ... (20 adds)]} 0 9
[junit4] 2> 1954509 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1644
[junit4] 2> 1954518 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160
(1600937885133963264), 161 (1600937885133963265), 162 (1600937885135011840),
163 (1600937885135011841), 164 (1600937885136060416), 165
(1600937885136060417), 166 (1600937885136060418), 167 (1600937885137108992),
168 (1600937885137108993), 169 (1600937885137108994), ... (20 adds)]} 0 8
[junit4] 2> 1954718 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1854
[junit4] 2> 1954733 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180
(1600937885354164224), 181 (1600937885354164225), 182 (1600937885356261376),
183 (1600937885356261377), 184 (1600937885357309952), 185
(1600937885357309953), 186 (1600937885359407104), 187 (1600937885359407105),
188 (1600937885361504256), 189 (1600937885361504257), ... (20 adds)]} 0 14
[junit4] 2> 1954934 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2069
[junit4] 2> 1954941 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200
(1600937885579608064), 201 (1600937885579608065), 202 (1600937885580656640),
203 (1600937885580656641), 204 (1600937885580656642), 205
(1600937885580656643), 206 (1600937885581705216), 207 (1600937885581705217),
208 (1600937885582753792), 209 (1600937885582753793), ... (20 adds)]} 0 7
[junit4] 2> 1955142 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2277
[junit4] 2> 1955150 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220
(1600937885797711872), 221 (1600937885797711873), 222 (1600937885798760448),
223 (1600937885798760449), 224 (1600937885799809024), 225
(1600937885799809025), 226 (1600937885799809026), 227 (1600937885799809027),
228 (1600937885800857600), 229 (1600937885800857601), ... (20 adds)]} 0 8
[junit4] 2> 1955351 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2486
[junit4] 2> 1955364 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240
(1600937886016864256), 241 (1600937886016864257), 242 (1600937886018961408),
243 (1600937886018961409), 244 (1600937886020009984), 245
(1600937886020009985), 246 (1600937886021058560), 247 (1600937886021058561),
248 (1600937886022107136), 249 (1600937886022107137), ... (20 adds)]} 0 12
[junit4] 2> 1955567 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2702
[junit4] 2> 1955585 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1955585 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3a7f319b commitCommandVersion:0
[junit4] 2> 1955587 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3eba9fc5[collection1] realtime]
[junit4] 2> 1955587 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1955594 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260
(1600937886243356672), 261 (1600937886250696704), 262 (1600937886252793856),
263 (1600937886252793857), 264 (1600937886253842432), 265
(1600937886253842433), 266 (1600937886255939584), 267 (1600937886255939585),
268 (1600937886256988160), 269 (1600937886256988161), ... (20 adds)]} 0 27
[junit4] 2> 1955795 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2930
[junit4] 2> 1955826 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280
(1600937886482432000), 281 (1600937886482432001), 282 (1600937886484529152),
283 (1600937886484529153), 284 (1600937886485577728), 285
(1600937886486626304), 286 (1600937886487674880), 287 (1600937886487674881),
288 (1600937886489772032), 289 (1600937886489772033), ... (20 adds)]} 0 30
[junit4] 2> 1956027 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=3162
[junit4] 2> 1956041 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300
(1600937886725701632), 301 (1600937886725701633), 302 (1600937886726750208),
303 (1600937886727798784), 304 (1600937886728847360), 305
(1600937886728847361), 306 (1600937886729895936), 307 (1600937886729895937),
308 (1600937886731993088), 309 (1600937886731993089), ... (20 adds)]} 0 13
[junit4] 2> 1956242 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=3377
[junit4] 2> 1956257 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320
(1600937886951145472), 321 (1600937886951145473), 322 (1600937886953242624),
323 (1600937886953242625), 324 (1600937886954291200), 325
(1600937886954291201), 326 (1600937886956388352), 327 (1600937886956388353),
328 (1600937886957436928), 329 (1600937886957436929), ... (20 adds)]} 0 15
[junit4] 2> 1956458 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=3593
[junit4] 2> 1956531 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340
(1600937887177637888), 341 (1600937887178686464), 342 (1600937887179735040),
343 (1600937887179735041), 344 (1600937887239503872), 345
(1600937887239503873), 346 (1600937887240552448), 347 (1600937887241601024),
348 (1600937887242649600), 349 (1600937887242649601), ... (20 adds)]} 0 72
[junit4] 2> 1956731 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=3867
[junit4] 2> 1956766 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360
(1600937887464947712), 361 (1600937887464947713), 362 (1600937887467044864),
363 (1600937887467044865), 364 (1600937887484870656), 365
(1600937887484870657), 366 (1600937887486967808), 367 (1600937887488016384),
368 (1600937887489064960), 369 (1600937887490113536), ... (20 adds)]} 0 34
[junit4] 2> 1956967 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=4102
[junit4] 2> 1956979 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380
(1600937887711363072), 381 (1600937887711363073), 382 (1600937887712411648),
383 (1600937887713460224), 384 (1600937887713460225), 385
(1600937887714508800), 386 (1600937887714508801), 387 (1600937887714508802),
388 (1600937887715557376), 389 (1600937887715557377), ... (20 adds)]} 0 12
[junit4] 2> 1957183 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=4318
[junit4] 2> 1957190 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1957190 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3a7f319b commitCommandVersion:0
[junit4] 2> 1957191 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@a540cf3[collection1] realtime]
[junit4] 2> 1957191 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1957200 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400
(1600937887938904064), 401 (1600937887938904065), 402 (1600937887939952640),
403 (1600937887939952641), 404 (1600937887941001216), 405
(1600937887941001217), 406 (1600937887942049792), 407 (1600937887942049793),
408 (1600937887943098368), 409 (1600937887943098369), ... (20 adds)]} 0 16
[junit4] 2> 1957401 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=4536
[junit4] 2> 1957460 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420
(1600937888166445056), 421 (1600937888167493632), 422 (1600937888168542208),
423 (1600937888168542209), 424 (1600937888169590784), 425
(1600937888170639360), 426 (1600937888171687936), 427 (1600937888171687937),
428 (1600937888172736512), 429 (1600937888172736513), ... (20 adds)]} 0 58
[junit4] 2> 1957661 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=4796
[junit4] 2> 1957674 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440
(1600937888439074816), 441 (1600937888439074817), 442 (1600937888441171968),
443 (1600937888441171969), 444 (1600937888442220544), 445
(1600937888442220545), 446 (1600937888443269120), 447 (1600937888443269121),
448 (1600937888444317696), 449 (1600937888444317697), ... (20 adds)]} 0 13
[junit4] 2> 1957875 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=5010
[junit4] 2> 1957885 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460
(1600937888663470080), 461 (1600937888663470081), 462 (1600937888664518656),
463 (1600937888664518657), 464 (1600937888665567232), 465
(1600937888665567233), 466 (1600937888666615808), 467 (1600937888666615809),
468 (1600937888667664384), 469 (1600937888667664385), ... (20 adds)]} 0 10
[junit4] 2> 1958086 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=5221
[junit4] 2> 1958097 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480
(1600937888884719616), 481 (1600937888884719617), 482 (1600937888885768192),
483 (1600937888885768193), 484 (1600937888886816768), 485
(1600937888886816769), 486 (1600937888887865344), 487 (1600937888887865345),
488 (1600937888887865346), 489 (1600937888887865347), ... (20 adds)]} 0 10
[junit4] 2> 1958297 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=5433
[junit4] 2> 1958314 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1600937889107017728), 501 (1600937889107017729), 502 (1600937889109114880),
503 (1600937889109114881), 504 (1600937889110163456), 505
(1600937889110163457), 506 (1600937889111212032), 507 (1600937889111212033),
508 (1600937889116454912), 509 (1600937889116454913), ... (20 adds)]} 0 16
[junit4] 2> 1958514 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=5650
[junit4] 2> 1958528 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520
(1600937889334558720), 521 (1600937889334558721), 522 (1600937889335607296),
523 (1600937889335607297), 524 (1600937889336655872), 525
(1600937889336655873), 526 (1600937889338753024), 527 (1600937889338753025),
528 (1600937889339801600), 529 (1600937889339801601), ... (20 adds)]} 0 13
[junit4] 2> 1958729 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=5864
[junit4] 2> 1958745 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1958745 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3a7f319b commitCommandVersion:0
[junit4] 2> 1958747 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540
(1600937889558953984), 541 (1600937889558953985), 542 (1600937889560002560),
543 (1600937889561051136), 544 (1600937889573634048), 545
(1600937889573634049), 546 (1600937889574682624), 547 (1600937889574682625),
548 (1600937889576779776), 549 (1600937889576779777), ... (20 adds)]} 0 17
[junit4] 2> 1958780 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@717a6be6[collection1] realtime]
[junit4] 2> 1958781 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1958948 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=6083
[junit4] 2> 1958960 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560
(1600937889788592128), 561 (1600937889788592129), 562 (1600937889790689280),
563 (1600937889790689281), 564 (1600937889791737856), 565
(1600937889791737857), 566 (1600937889792786432), 567 (1600937889792786433),
568 (1600937889793835008), 569 (1600937889793835009), ... (20 adds)]} 0 11
[junit4] 2> 1959161 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=6296
[junit4] 2> 1959172 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580
(1600937890011938816), 581 (1600937890011938817), 582 (1600937890012987392),
583 (1600937890012987393), 584 (1600937890014035968), 585
(1600937890014035969), 586 (1600937890015084544), 587 (1600937890015084545),
588 (1600937890016133120), 589 (1600937890016133121), ... (20 adds)]} 0 11
[junit4] 2> 1959373 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=6508
[junit4] 2> 1959381 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600
(1600937890234236928), 601 (1600937890234236929), 602 (1600937890235285504),
603 (1600937890235285505), 604 (1600937890236334080), 605
(1600937890236334081), 606 (1600937890237382656), 607 (1600937890237382657),
608 (1600937890237382658), 609 (1600937890237382659), ... (20 adds)]} 0 8
[junit4] 2> 1959582 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=6717
[junit4] 2> 1959592 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620
(1600937890453389312), 621 (1600937890453389313), 622 (1600937890454437888),
623 (1600937890454437889), 624 (1600937890455486464), 625
(1600937890455486465), 626 (1600937890456535040), 627 (1600937890456535041),
628 (1600937890456535042), 629 (1600937890457583616), ... (20 adds)]} 0 9
[junit4] 2> 1959793 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=6928
[junit4] 2> 1959804 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640
(1600937890674638848), 641 (1600937890674638849), 642 (1600937890675687424),
643 (1600937890675687425), 644 (1600937890676736000), 645
(1600937890676736001), 646 (1600937890677784576), 647 (1600937890677784577),
648 (1600937890678833152), 649 (1600937890678833153), ... (20 adds)]} 0 10
[junit4] 2> 1960004 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=7140
[junit4] 2> 1960014 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660
(1600937890896936960), 661 (1600937890896936961), 662 (1600937890897985536),
663 (1600937890897985537), 664 (1600937890899034112), 665
(1600937890899034113), 666 (1600937890900082688), 667 (1600937890900082689),
668 (1600937890901131264), 669 (1600937890901131265), ... (20 adds)]} 0 9
[junit4] 2> 1960215 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=7350
[junit4] 2> 1960217 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1960217 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3a7f319b commitCommandVersion:0
[junit4] 2> 1960219 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@48ee4298[collection1] realtime]
[junit4] 2> 1960220 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1960224 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680
(1600937891117137920), 681 (1600937891117137921), 682 (1600937891118186496),
683 (1600937891118186497), 684 (1600937891119235072), 685
(1600937891119235073), 686 (1600937891121332224), 687 (1600937891121332225),
688 (1600937891122380800), 689 (1600937891122380801), ... (20 adds)]} 0 9
[junit4] 2> 1960425 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=7560
[junit4] 2> 1960434 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[700
(1600937891337338880), 701 (1600937891338387456), 702 (1600937891338387457),
703 (1600937891338387458), 704 (1600937891339436032), 705
(1600937891340484608), 706 (1600937891340484609), 707 (1600937891340484610),
708 (1600937891341533184), 709 (1600937891342581760), ... (20 adds)]} 0 8
[junit4] 2> 1960634 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=7769
[junit4] 2> 1960643 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[720
(1600937891557539840), 721 (1600937891557539841), 722 (1600937891558588416),
723 (1600937891558588417), 724 (1600937891559636992), 725
(1600937891559636993), 726 (1600937891560685568), 727 (1600937891560685569),
728 (1600937891560685570), 729 (1600937891560685571), ... (20 adds)]} 0 8
[junit4] 2> 1960844 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=7979
[junit4] 2> 1960852 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[740
(1600937891776692224), 741 (1600937891776692225), 742 (1600937891777740800),
743 (1600937891777740801), 744 (1600937891778789376), 745
(1600937891778789377), 746 (1600937891778789378), 747 (1600937891779837952),
748 (1600937891779837953), 749 (1600937891779837954), ... (20 adds)]} 0 7
[junit4] 2> 1961052 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=8187
[junit4] 2> 1961064 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[760
(1600937891995844608), 761 (1600937891995844609), 762 (1600937892000038912),
763 (1600937892000038913), 764 (1600937892001087488), 765
(1600937892001087489), 766 (1600937892001087490), 767 (1600937892002136064),
768 (1600937892002136065), 769 (1600937892002136066), ... (20 adds)]} 0 11
[junit4] 2> 1961265 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=8400
[junit4] 2> 1961273 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[780
(1600937892218142720), 781 (1600937892218142721), 782 (1600937892219191296),
783 (1600937892219191297), 784 (1600937892220239872), 785
(1600937892220239873), 786 (1600937892220239874), 787 (1600937892220239875),
788 (1600937892221288448), 789 (1600937892221288449), ... (20 adds)]} 0 8
[junit4] 2> 1961474 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=8609
[junit4] 2> 1961485 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[800
(1600937892437295104), 801 (1600937892437295105), 802 (1600937892438343680),
803 (1600937892438343681), 804 (1600937892439392256), 805
(1600937892439392257), 806 (1600937892440440832), 807 (1600937892440440833),
808 (1600937892441489408), 809 (1600937892441489409), ... (20 adds)]} 0 10
[junit4] 2> 1961486 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1961486 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3a7f319b commitCommandVersion:0
[junit4] 2> 1961486 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1818e355[collection1] realtime]
[junit4] 2> 1961487 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1961535 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=8670
[junit4] 2> 1961543 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[820
(1600937892501258240), 821 (1600937892502306816), 822 (1600937892503355392),
823 (1600937892503355393), 824 (1600937892503355394), 825
(1600937892503355395), 826 (1600937892504403968), 827 (1600937892504403969),
828 (1600937892505452544), 829 (1600937892505452545), ... (20 adds)]} 0 8
[junit4] 2> 1961744 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=8879
[junit4] 2> 1961753 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[840
(1600937892720410624), 841 (1600937892720410625), 842 (1600937892721459200),
843 (1600937892721459201), 844 (1600937892722507776), 845
(1600937892722507777), 846 (1600937892723556352), 847 (1600937892723556353),
848 (1600937892723556354), 849 (1600937892723556355), ... (20 adds)]} 0 8
[junit4] 2> 1961954 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=9089
[junit4] 2> 1961963 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[860
(1600937892940611584), 861 (1600937892940611585), 862 (1600937892941660160),
863 (1600937892941660161), 864 (1600937892942708736), 865
(1600937892942708737), 866 (1600937892942708738), 867 (1600937892942708739),
868 (1600937892943757312), 869 (1600937892943757313), ... (20 adds)]} 0 9
[junit4] 2> 1962164 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=9299
[junit4] 2> 1962173 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[880
(1600937893160812544), 881 (1600937893160812545), 882 (1600937893161861120),
883 (1600937893161861121), 884 (1600937893162909696), 885
(1600937893162909697), 886 (1600937893163958272), 887 (1600937893163958273),
888 (1600937893165006848), 889 (1600937893165006849), ... (20 adds)]} 0 9
[junit4] 2> 1962374 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=9509
[junit4] 2> 1962383 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[900
(1600937893381013504), 901 (1600937893381013505), 902 (1600937893382062080),
903 (1600937893382062081), 904 (1600937893383110656), 905
(1600937893383110657), 906 (1600937893384159232), 907 (1600937893384159233),
908 (1600937893385207808), 909 (1600937893385207809), ... (20 adds)]} 0 8
[junit4] 2> 1962583 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=9719
[junit4] 2> 1962592 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[920
(1600937893601214464), 921 (1600937893601214465), 922 (1600937893602263040),
923 (1600937893602263041), 924 (1600937893603311616), 925
(1600937893603311617), 926 (1600937893604360192), 927 (1600937893604360193),
928 (1600937893605408768), 929 (1600937893605408769), ... (20 adds)]} 0 8
[junit4] 2> 1962793 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=9928
[junit4] 2> 1962799 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1962799 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3a7f319b commitCommandVersion:0
[junit4] 2> 1962800 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@39a6e58f[collection1] realtime]
[junit4] 2> 1962801 INFO (commitScheduler-9934-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1962801 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[940
(1600937893820366848), 941 (1600937893820366849), 942 (1600937893821415424),
943 (1600937893821415425), 944 (1600937893821415426), 945
(1600937893822464000), 946 (1600937893822464001), 947 (1600937893822464002),
948 (1600937893823512576), 949 (1600937893823512577), ... (20 adds)]} 0 8
[junit4] 2> 1963002 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=10137
[junit4] 2> 1963018 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[960
(1600937894039519232), 961 (1600937894039519233), 962 (1600937894040567808),
963 (1600937894040567809), 964 (1600937894041616384), 965
(1600937894041616385), 966 (1600937894042664960), 967 (1600937894042664961),
968 (1600937894042664962), 969 (1600937894042664963), ... (20 adds)]} 0 15
[junit4] 2> 1963218 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=10353
[junit4] 2> 1963227 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[980
(1600937894266011648), 981 (1600937894267060224), 982 (1600937894268108800),
983 (1600937894268108801), 984 (1600937894268108802), 985
(1600937894268108803), 986 (1600937894269157376), 987 (1600937894269157377),
988 (1600937894270205952), 989 (1600937894270205953), ... (20 adds)]} 0 8
[junit4] 2> 1963428 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=10563
[junit4] 2> 1963428 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1963428 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@3a7f319b commitCommandVersion:0
[junit4] 2> 1963428 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@784d884a[collection1] main]
[junit4] 2> 1963429 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1963430 INFO (searcherExecutor-9931-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@784d884a[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b6(7.4.0):C720)
Uninverting(_d4(7.4.0):c128) Uninverting(_f3(7.4.0):C128)
Uninverting(_fe(7.4.0):c20) Uninverting(_fd(7.4.0):C2)
Uninverting(_ff(7.4.0):C2)))}
[junit4] 2> 1963480 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.S.Request [collection1] webapp=null path=null
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=1000 status=0 QTime=10615
[junit4] 2> 1963481 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending endToEndTest
{seed=[62E5ED7CC881B3D1:78B3824A283394D3]}
[junit4] 2> 1963481 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1963481 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=471683033
[junit4] 2> 1963481 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 1963481 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@de2a453: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@5b7622da
[junit4] 2> 1963484 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 1963484 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5f6df0f3: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@e8d399a
[junit4] 2> 1963486 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 1963486 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@ed3df89: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@4ed22314
[junit4] 2> 1963487 INFO (coreCloseExecutor-9936-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5b6d2a6f
[junit4] 2> 1963487 INFO (coreCloseExecutor-9936-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=5b6d2a6f
[junit4] 2> 1963487 INFO (coreCloseExecutor-9936-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5d6da1fb: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@29f3772b
[junit4] 2> 1963494 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest
{seed=[62E5ED7CC881B3D1:CCE53EB61CF15FFF]}
[junit4] 2> 1963494 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1963494 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1963506 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1963514 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1963569 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1963590 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1963595 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1963595 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@c8c9efe
[junit4] 2> 1963596 INFO (coreLoadExecutor-9943-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 1963596 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1963606 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 1963613 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1963659 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1963663 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 1963664 INFO (coreLoadExecutor-9943-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@c8c9efe
[junit4] 2> 1963664 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 1963664 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_62E5ED7CC881B3D1-001/init-core-data-001/]
[junit4] 2> 1963664 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=564834558,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1963666 WARN (coreLoadExecutor-9943-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> 1963686 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1963686 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 1963686 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1963686 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1963687 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=1468166810,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1963687 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@68a70b86[collection1] main]
[junit4] 2> 1963687 WARN (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 1963688 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1963688 INFO
(searcherExecutor-9944-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@68a70b86[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1963688 INFO (coreLoadExecutor-9943-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1600937894758842368
[junit4] 2> 1963690 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1963702 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1600937894761988096), 1 (1600937894761988097), 2 (1600937894763036672), 3
(1600937894763036673), 4 (1600937894764085248), 5 (1600937894764085249), 6
(1600937894765133824), 7 (1600937894765133825), 8 (1600937894766182400), 9
(1600937894767230976), ... (20 adds)]} 0 11
[junit4] 2> 1963903 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=212
[junit4] 2> 1963911 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20
(1600937894985334784), 21 (1600937894985334785), 22 (1600937894986383360), 23
(1600937894986383361), 24 (1600937894986383362), 25 (1600937894987431936), 26
(1600937894987431937), 27 (1600937894987431938), 28 (1600937894988480512), 29
(1600937894988480513), ... (20 adds)]} 0 7
[junit4] 2> 1964111 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=420
[junit4] 2> 1964125 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40
(1600937895203438592), 41 (1600937895208681472), 42 (1600937895209730048), 43
(1600937895209730049), 44 (1600937895210778624), 45 (1600937895210778625), 46
(1600937895211827200), 47 (1600937895211827201), 48 (1600937895211827202), 49
(1600937895211827203), ... (20 adds)]} 0 13
[junit4] 2> 1964326 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=634
[junit4] 2> 1964336 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60
(1600937895427833856), 61 (1600937895427833857), 62 (1600937895428882432), 63
(1600937895428882433), 64 (1600937895429931008), 65 (1600937895429931009), 66
(1600937895430979584), 67 (1600937895430979585), 68 (1600937895430979586), 69
(1600937895430979587), ... (20 adds)]} 0 10
[junit4] 2> 1964537 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=846
[junit4] 2> 1964544 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80
(1600937895649083392), 81 (1600937895649083393), 82 (1600937895650131968), 83
(1600937895650131969), 84 (1600937895650131970), 85 (1600937895650131971), 86
(1600937895651180544), 87 (1600937895651180545), 88 (1600937895652229120), 89
(1600937895652229121), ... (20 adds)]} 0 7
[junit4] 2> 1964745 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1054
[junit4] 2> 1964756 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100
(1600937895867187200), 101 (1600937895867187201), 102 (1600937895869284352),
103 (1600937895869284353), 104 (1600937895870332928), 105
(1600937895870332929), 106 (1600937895871381504), 107 (1600937895871381505),
108 (1600937895872430080), 109 (1600937895872430081), ... (20 adds)]} 0 11
[junit4] 2> 1964957 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1266
[junit4] 2> 1964968 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120
(1600937896089485312), 121 (1600937896089485313), 122 (1600937896091582464),
123 (1600937896091582465), 124 (1600937896092631040), 125
(1600937896092631041), 126 (1600937896093679616), 127 (1600937896093679617),
128 (1600937896094728192), 129 (1600937896094728193), ... (20 adds)]} 0 10
[junit4] 2> 1964968 INFO (commitScheduler-9947-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1964968 INFO (commitScheduler-9947-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@424bf1f0 commitCommandVersion:0
[junit4] 2> 1964969 INFO (commitScheduler-9947-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@5c6937f[collection1] realtime]
[junit4] 2> 1964969 INFO (commitScheduler-9947-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1965018 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1327
[junit4] 2> 1965031 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140
(1600937896153448448), 141 (1600937896154497024), 142 (1600937896155545600),
143 (1600937896155545601), 144 (1600937896156594176), 145
(1600937896156594177), 146 (1600937896158691328), 147 (1600937896158691329),
148 (1600937896159739904), 149 (1600937896159739905), ... (20 adds)]} 0 12
[junit4] 2> 1965232 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1541
[junit4] 2> 1965242 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160
(1600937896377843712), 161 (1600937896377843713), 162 (1600937896378892288),
163 (1600937896378892289), 164 (1600937896379940864), 165
(1600937896379940865), 166 (1600937896380989440), 167 (1600937896380989441),
168 (1600937896382038016), 169 (1600937896382038017), ... (20 adds)]} 0 10
[junit4] 2> 1965443 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1752
[junit4] 2> 1965455 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180
(1600937896599093248), 181 (1600937896599093249), 182 (1600937896601190400),
183 (1600937896601190401), 184 (1600937896602238976), 185
(1600937896602238977), 186 (1600937896603287552), 187 (1600937896603287553),
188 (1600937896605384704), 189 (1600937896605384705), ... (20 adds)]} 0 11
[junit4] 2> 1965656 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=1965
[junit4] 2> 1965664 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200
(1600937896822439936), 201 (1600937896822439937), 202 (1600937896823488512),
203 (1600937896823488513), 204 (1600937896824537088), 205
(1600937896824537089), 206 (1600937896824537090), 207 (1600937896825585664),
208 (1600937896825585665), 209 (1600937896825585666), ... (20 adds)]} 0 7
[junit4] 2> 1965864 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2173
[junit4] 2> 1965873 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220
(1600937897040543744), 221 (1600937897041592320), 222 (1600937897041592321),
223 (1600937897042640896), 224 (1600937897042640897), 225
(1600937897042640898), 226 (1600937897043689472), 227 (1600937897043689473),
228 (1600937897044738048), 229 (1600937897044738049), ... (20 adds)]} 0 8
[junit4] 2> 1966073 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2382
[junit4] 2> 1966092 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240
(1600937897259696128), 241 (1600937897260744704), 242 (1600937897261793280),
243 (1600937897261793281), 244 (1600937897262841856), 245
(1600937897262841857), 246 (1600937897263890432), 247 (1600937897263890433),
248 (1600937897264939008), 249 (1600937897264939009), ... (20 adds)]} 0 18
[junit4] 2> 1966293 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2602
[junit4] 2> 1966300 INFO (commitScheduler-9947-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1966300 INFO (commitScheduler-9947-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@424bf1f0 commitCommandVersion:0
[junit4] 2> 1966302 INFO (commitScheduler-9947-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3ab15d01[collection1] realtime]
[junit4] 2> 1966302 INFO (commitScheduler-9947-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1966303 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260
(1600937897490382848), 261 (1600937897490382849), 262 (1600937897491431424),
263 (1600937897491431425), 264 (1600937897492480000), 265
(1600937897492480001), 266 (1600937897493528576), 267 (1600937897493528577),
268 (1600937897493528578), 269 (1600937897493528579), ... (20 adds)]} 0 9
[junit4] 2> 1966503 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=2812
[junit4] 2> 1966513 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280
(1600937897711632384), 281 (1600937897711632385), 282 (1600937897712680960),
283 (1600937897712680961), 284 (1600937897713729536), 285
(1600937897713729537), 286 (1600937897713729538), 287 (1600937897713729539),
288 (1600937897714778112), 289 (1600937897714778113), ... (20 adds)]} 0 9
[junit4] 2> 1966713 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=3022
[junit4] 2> 1966722 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300
(1600937897930784768), 301 (1600937897931833344), 302 (1600937897932881920),
303 (1600937897932881921), 304 (1600937897932881922), 305
(1600937897932881923), 306 (1600937897933930496), 307 (1600937897933930497),
308 (1600937897934979072), 309 (1600937897934979073), ... (20 adds)]} 0 8
[junit4] 2> 1966923 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=3232
[junit4] 2> 1966931 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320
(1600937898150985728), 321 (1600937898150985729), 322 (1600937898152034304),
323 (1600937898152034305), 324 (1600937898153082880), 325
(1600937898153082881), 326 (1600937898154131456), 327 (1600937898154131457),
328 (1600937898154131458), 329 (1600937898154131459), ... (20 adds)]} 0 7
[junit4] 2> 1967131 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=3440
[junit4] 2> 1967142 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340
(1600937898370138112), 341 (1600937898370138113), 342 (1600937898371186688),
343 (1600937898371186689), 344 (1600937898372235264), 345
(1600937898372235265), 346 (1600937898373283840), 347 (1600937898373283841),
348 (1600937898374332416), 349 (1600937898374332417), ... (20 adds)]} 0 10
[junit4] 2> 1967343 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
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=3652
[junit4] 2> 1967353 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360
(1600937898591387648), 361 (1600937898591387649), 362 (1600937898592436224),
363 (1600937898592436225), 364 (1600937898593484800), 365
(1600937898593484801), 366 (1600937898595581952), 367 (1600937898595581953),
368 (1600937898596630528), 369 (1600937898596630529), ... (20 adds)]} 0 10
[...truncated too long message...]
rocessorFactory [collection1] {delete=[75 (-1600938553190121472), 76
(-1600938553190121473), 77 (-1600938553190121474), 78 (-1600938553190121475),
79 (-1600938553190121476), 80 (-1600938553190121477), 81
(-1600938553190121478), 82 (-1600938553190121479), 83 (-1600938553190121480),
84 (-1600938553190121481), ... (15 deletes)]} 0 0
[junit4] 2> 75346 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[90
(-1600938553400885248), 91 (-1600938553400885249), 92 (-1600938553400885250),
93 (-1600938553400885251), 94 (-1600938553400885252), 95
(-1600938553400885253), 96 (-1600938553400885254), 97 (-1600938553400885255),
98 (-1600938553400885256), 99 (-1600938553400885257), ... (15 deletes)]} 0 0
[junit4] 2> 75347 INFO (commitScheduler-101-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 75347 INFO (commitScheduler-101-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@493a9a82 commitCommandVersion:0
[junit4] 2> 75348 INFO (commitScheduler-101-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1243aba1[collection1] realtime]
[junit4] 2> 75349 INFO (commitScheduler-101-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 75397 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[105
(-1600938553453314048), 106 (-1600938553454362624), 107 (-1600938553454362625),
108 (-1600938553454362626), 109 (-1600938553454362627), 110
(-1600938553454362628), 111 (-1600938553454362629), 112 (-1600938553454362630),
113 (-1600938553454362631), 114 (-1600938553454362632), ... (15 deletes)]} 0 0
[junit4] 2> 75597 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[120
(-1600938553664077824), 121 (-1600938553664077825), 122 (-1600938553664077826),
123 (-1600938553664077827), 124 (-1600938553664077828), 125
(-1600938553664077829), 126 (-1600938553664077830), 127 (-1600938553664077831),
128 (-1600938553664077832), 129 (-1600938553664077833), ... (15 deletes)]} 0 0
[junit4] 2> 75798 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[135
(-1600938553874841600), 136 (-1600938553874841601), 137 (-1600938553874841602),
138 (-1600938553874841603), 139 (-1600938553874841604), 140
(-1600938553874841605), 141 (-1600938553874841606), 142 (-1600938553874841607),
143 (-1600938553874841608), 144 (-1600938553874841609), ... (15 deletes)]} 0 0
[junit4] 2> 75999 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending deleteTest
[junit4] 2> 75999 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 75999 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=2142628136
[junit4] 2> 75999 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 75999 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@48b1b86a: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@3992428e
[junit4] 2> 76003 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 76003 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@26d8b2e6: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@77a193d7
[junit4] 2> 76003 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 76003 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[62E5ED7CC881B3D1]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@3d9baead: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@67361389
[junit4] 2> 76003 INFO (coreCloseExecutor-103-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@486452f0
[junit4] 2> 76004 INFO (coreCloseExecutor-103-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=486452f0
[junit4] 2> 76004 INFO (coreCloseExecutor-103-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@69c585bb: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@34750dc0
[junit4] 2> 76013 INFO (coreCloseExecutor-103-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 76013 INFO (coreCloseExecutor-103-thread-1) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@493a9a82 commitCommandVersion:0
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=MaxSizeAutoCommitTest -Dtests.method=deleteTest
-Dtests.seed=62E5ED7CC881B3D1 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.badapples=true -Dtests.locale=ug -Dtests.timezone=America/Louisville
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 2.47s J0 | MaxSizeAutoCommitTest.deleteTest <<<
[junit4] > Throwable #1: java.lang.AssertionError: Tlog size exceeds the
max size bound. Tlog path:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_62E5ED7CC881B3D1-001/init-core-data-001/tlog/tlog.0000000000000000005,
tlog size: 1276
[junit4] > at
__randomizedtesting.SeedInfo.seed([62E5ED7CC881B3D1:72AB0883B32F8A20]:0)
[junit4] > at
org.apache.solr.update.MaxSizeAutoCommitTest.getTlogFileSizes(MaxSizeAutoCommitTest.java:379)
[junit4] > at
org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest(MaxSizeAutoCommitTest.java:200)
[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:844)
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_62E5ED7CC881B3D1-001
[junit4] 2> NOTE: test params are: codec=Lucene70,
sim=RandomSimilarity(queryNorm=false): {}, locale=ug,
timezone=America/Louisville
[junit4] 2> NOTE: Linux 4.13.0-39-generic amd64/Oracle Corporation 10
(64-bit)/cpus=8,threads=1,free=423521568,total=530579456
[junit4] 2> NOTE: All tests run in this JVM: [MaxSizeAutoCommitTest]
[junit4] Completed [3/5 (1!)] on J0 in 75.02s, 8 tests, 1 failure <<<
FAILURES!
[...truncated 33 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1568: The
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092:
There were test failures: 5 suites, 40 tests, 1 failure [seed: 62E5ED7CC881B3D1]
Total time: 2 minutes 21 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 1/5 failed: org.apache.solr.update.MaxSizeAutoCommitTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting
ANT_1_8_2_HOME=/var/lib/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=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/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=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #1936
Recording test results
Setting
ANT_1_8_2_HOME=/var/lib/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=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
