Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22102/
Java: 64bit/jdk-10.0.1 -XX:-UseCompressedOops -XX:+UseG1GC
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-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_4C7CA07B3C9FB254-001/init-core-data-001/tlog/tlog.0000000000000000003,
tlog size: 1302
Stack Trace:
java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_4C7CA07B3C9FB254-001/init-core-data-001/tlog/tlog.0000000000000000003,
tlog size: 1302
at
__randomizedtesting.SeedInfo.seed([4C7CA07B3C9FB254:5C32458447318BA5]: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 12566 lines...]
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_4C7CA07B3C9FB254-001/init-core-data-001
[junit4] 2> 118682 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[4C7CA07B3C9FB254]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 118683 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[4C7CA07B3C9FB254]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 118683 INFO
(SUITE-MaxSizeAutoCommitTest-seed#[4C7CA07B3C9FB254]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 118684 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting deleteTest
[junit4] 2> 119011 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 119012 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 119088 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 119137 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 119348 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 119529 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 119559 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 119559 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 119569 INFO (coreLoadExecutor-396-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 119569 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 119606 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 119620 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 119772 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 119795 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 119796 INFO (coreLoadExecutor-396-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@2799f001
[junit4] 2> 119801 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 119801 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_4C7CA07B3C9FB254-001/init-core-data-001/]
[junit4] 2> 119803 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=13, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 119805 WARN (coreLoadExecutor-396-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> 119868 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 119868 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 119869 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 119869 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 119870 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=23, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=95.505859375,
floorSegmentMB=1.1455078125, forceMergeDeletesPctAllowed=26.920283778454852,
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 119871 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@79b7b472[collection1] main]
[junit4] 2> 119871 WARN (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 119872 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 119872 INFO (coreLoadExecutor-396-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1601452396925419520
[junit4] 2> 119874 INFO
(searcherExecutor-397-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@79b7b472[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 119875 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 119908 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 119909 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bb72d5c commitCommandVersion:0
[junit4] 2> 120009 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3dd520c1[collection1] realtime]
[junit4] 2> 120009 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 120009 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 120009 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bb72d5c commitCommandVersion:0
[junit4] 2> 120135 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3a5192a[collection1] realtime]
[junit4] 2> 120136 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 120136 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 120136 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bb72d5c commitCommandVersion:0
[junit4] 2> 120149 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1601452396931710976), 1 (1601452396933808128), 2 (1601452396934856704), 3
(1601452396935905280), 4 (1601452396935905281), 5 (1601452396941148160), 6
(1601452396942196736), 7 (1601452396943245312), 8 (1601452396944293888), 9
(1601452396945342464), ... (150 adds)]} 0 273
[junit4] 2> 120179 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@953c35d[collection1] realtime]
[junit4] 2> 120179 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 120351 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[0
(-1601452397426638848), 1 (-1601452397427687424), 2 (-1601452397427687425), 3
(-1601452397427687426), 4 (-1601452397427687427), 5 (-1601452397427687428), 6
(-1601452397427687429), 7 (-1601452397427687430), 8 (-1601452397427687431), 9
(-1601452397427687432), ... (15 deletes)]} 0 1
[junit4] 2> 120564 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[15
(-1601452397649985536), 16 (-1601452397649985537), 17 (-1601452397649985538),
18 (-1601452397649985539), 19 (-1601452397649985540), 20
(-1601452397649985541), 21 (-1601452397649985542), 22 (-1601452397649985543),
23 (-1601452397649985544), 24 (-1601452397651034112), ... (15 deletes)]} 0 1
[junit4] 2> 120767 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[30
(-1601452397860749312), 31 (-1601452397861797888), 32 (-1601452397862846464),
33 (-1601452397862846465), 34 (-1601452397862846466), 35
(-1601452397862846467), 36 (-1601452397862846468), 37 (-1601452397862846469),
38 (-1601452397863895040), 39 (-1601452397863895041), ... (15 deletes)]} 0 2
[junit4] 2> 120972 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[45
(-1601452398077804544), 46 (-1601452398077804545), 47 (-1601452398077804546),
48 (-1601452398077804547), 49 (-1601452398077804548), 50
(-1601452398077804549), 51 (-1601452398077804550), 52 (-1601452398077804551),
53 (-1601452398077804552), 54 (-1601452398078853120), ... (15 deletes)]} 0 1
[junit4] 2> 120972 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 120972 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bb72d5c commitCommandVersion:0
[junit4] 2> 120986 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@71ee5c3d[collection1] realtime]
[junit4] 2> 120993 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 121024 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[60
(-1601452398131281920), 61 (-1601452398132330496), 62 (-1601452398132330497),
63 (-1601452398132330498), 64 (-1601452398132330499), 65
(-1601452398132330500), 66 (-1601452398132330501), 67 (-1601452398132330502),
68 (-1601452398132330503), 69 (-1601452398132330504), ... (15 deletes)]} 0 1
[junit4] 2> 121225 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[75
(-1601452398344142848), 76 (-1601452398344142849), 77 (-1601452398344142850),
78 (-1601452398344142851), 79 (-1601452398344142852), 80
(-1601452398344142853), 81 (-1601452398344142854), 82 (-1601452398344142855),
83 (-1601452398344142856), 84 (-1601452398344142857), ... (15 deletes)]} 0 1
[junit4] 2> 121427 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[90
(-1601452398554906624), 91 (-1601452398554906625), 92 (-1601452398554906626),
93 (-1601452398554906627), 94 (-1601452398554906628), 95
(-1601452398554906629), 96 (-1601452398555955200), 97 (-1601452398555955201),
98 (-1601452398555955202), 99 (-1601452398555955203), ... (15 deletes)]} 0 1
[junit4] 2> 121629 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[105
(-1601452398766718976), 106 (-1601452398766718977), 107 (-1601452398766718978),
108 (-1601452398766718979), 109 (-1601452398766718980), 110
(-1601452398766718981), 111 (-1601452398766718982), 112 (-1601452398766718983),
113 (-1601452398766718984), 114 (-1601452398766718985), ... (15 deletes)]} 0 1
[junit4] 2> 121630 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 121630 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bb72d5c commitCommandVersion:0
[junit4] 2> 121646 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@51032aa3[collection1] realtime]
[junit4] 2> 121647 INFO (commitScheduler-400-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 121680 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[120
(-1601452398820196352), 121 (-1601452398820196353), 122 (-1601452398821244928),
123 (-1601452398821244929), 124 (-1601452398821244930), 125
(-1601452398821244931), 126 (-1601452398821244932), 127 (-1601452398821244933),
128 (-1601452398821244934), 129 (-1601452398821244935), ... (15 deletes)]} 0 1
[junit4] 2> 121882 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[135
(-1601452399032008704), 136 (-1601452399032008705), 137 (-1601452399032008706),
138 (-1601452399032008707), 139 (-1601452399032008708), 140
(-1601452399032008709), 141 (-1601452399032008710), 142 (-1601452399032008711),
143 (-1601452399032008712), 144 (-1601452399032008713), ... (15 deletes)]} 0 1
[junit4] 2> 122083 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending deleteTest
[junit4] 2> 122083 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 122083 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1184197301
[junit4] 2> 122083 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 122083 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2c0043e5: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@4c154c87
[junit4] 2> 122088 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 122088 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@e9b1255: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@7e0877b4
[junit4] 2> 122091 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 122091 INFO
(TEST-MaxSizeAutoCommitTest.deleteTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1766dca7: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@d8c25d3
[junit4] 2> 122092 INFO (coreCloseExecutor-402-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@36e954
[junit4] 2> 122092 INFO (coreCloseExecutor-402-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=36e954
[junit4] 2> 122093 INFO (coreCloseExecutor-402-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1a85be47: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@2dedfe7f
[junit4] 2> 122111 INFO (coreCloseExecutor-402-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 122111 INFO (coreCloseExecutor-402-thread-1) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@bb72d5c commitCommandVersion:0
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=MaxSizeAutoCommitTest -Dtests.method=deleteTest
-Dtests.seed=4C7CA07B3C9FB254 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=sr-BA -Dtests.timezone=Asia/Macau -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 3.47s J1 | MaxSizeAutoCommitTest.deleteTest <<<
[junit4] > Throwable #1: java.lang.AssertionError: Tlog size exceeds the
max size bound. Tlog path:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_4C7CA07B3C9FB254-001/init-core-data-001/tlog/tlog.0000000000000000003,
tlog size: 1302
[junit4] > at
__randomizedtesting.SeedInfo.seed([4C7CA07B3C9FB254:5C32458447318BA5]: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> 122161 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest
{seed=[4C7CA07B3C9FB254:562ACF4DDC2D9556]}
[junit4] 2> 122161 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 122162 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 122194 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 122210 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 122407 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 122484 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 122493 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 122493 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 122501 INFO (coreLoadExecutor-409-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 122501 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 122547 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 122586 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 122772 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 122806 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 122806 INFO (coreLoadExecutor-409-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@2799f001
[junit4] 2> 122806 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 122806 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_4C7CA07B3C9FB254-001/init-core-data-001/]
[junit4] 2> 122809 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=13, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 122830 WARN (coreLoadExecutor-409-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> 122891 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 122891 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 122892 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 122892 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 122893 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=23, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=95.505859375,
floorSegmentMB=1.1455078125, forceMergeDeletesPctAllowed=26.920283778454852,
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 122894 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2c487abe[collection1] main]
[junit4] 2> 122894 WARN (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 122895 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 122895 INFO (coreLoadExecutor-409-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1601452400095264768
[junit4] 2> 122898 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 122930 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1601452400099459072), 1 (1601452400112041984), 2 (1601452400113090560), 3
(1601452400113090561), 4 (1601452400113090562), 5 (1601452400115187712), 6
(1601452400116236288), 7 (1601452400116236289), 8 (1601452400118333440), 9
(1601452400118333441), ... (20 adds)]} 0 30
[junit4] 2> 122937 INFO
(searcherExecutor-410-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2c487abe[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 123131 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=231
[junit4] 2> 123214 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20
(1601452400422420480), 21 (1601452400423469056), 22 (1601452400423469057), 23
(1601452400424517632), 24 (1601452400424517633), 25 (1601452400424517634), 26
(1601452400425566208), 27 (1601452400425566209), 28 (1601452400425566210), 29
(1601452400425566211), ... (20 adds)]} 0 6
[junit4] 2> 123415 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=515
[junit4] 2> 123422 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40
(1601452400640524288), 41 (1601452400641572864), 42 (1601452400641572865), 43
(1601452400641572866), 44 (1601452400641572867), 45 (1601452400641572868), 46
(1601452400645767168), 47 (1601452400646815744), 48 (1601452400646815745), 49
(1601452400646815746), ... (20 adds)]} 0 7
[junit4] 2> 123629 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=729
[junit4] 2> 123632 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60
(1601452400864919552), 61 (1601452400864919553), 62 (1601452400865968128), 63
(1601452400865968129), 64 (1601452400865968130), 65 (1601452400865968131), 66
(1601452400865968132), 67 (1601452400865968133), 68 (1601452400865968134), 69
(1601452400865968135), ... (20 adds)]} 0 2
[junit4] 2> 123835 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=935
[junit4] 2> 123838 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80
(1601452401080926208), 81 (1601452401081974784), 82 (1601452401081974785), 83
(1601452401081974786), 84 (1601452401081974787), 85 (1601452401081974788), 86
(1601452401083023360), 87 (1601452401083023361), 88 (1601452401083023362), 89
(1601452401083023363), ... (20 adds)]} 0 3
[junit4] 2> 124039 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1140
[junit4] 2> 124042 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100
(1601452401295884288), 101 (1601452401295884289), 102 (1601452401295884290),
103 (1601452401295884291), 104 (1601452401295884292), 105
(1601452401296932864), 106 (1601452401296932865), 107 (1601452401296932866),
108 (1601452401296932867), 109 (1601452401296932868), ... (20 adds)]} 0 2
[junit4] 2> 124243 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1343
[junit4] 2> 124263 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120
(1601452401509793792), 121 (1601452401509793793), 122 (1601452401509793794),
123 (1601452401509793795), 124 (1601452401510842368), 125
(1601452401510842369), 126 (1601452401510842370), 127 (1601452401510842371),
128 (1601452401510842372), 129 (1601452401510842373), ... (20 adds)]} 0 19
[junit4] 2> 124265 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 124265 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2b37c485 commitCommandVersion:0
[junit4] 2> 124313 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1413
[junit4] 2> 124317 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140
(1601452401582145536), 141 (1601452401584242688), 142 (1601452401584242689),
143 (1601452401584242690), 144 (1601452401584242691), 145
(1601452401585291264), 146 (1601452401585291265), 147 (1601452401585291266),
148 (1601452401585291267), 149 (1601452401585291268), ... (20 adds)]} 0 3
[junit4] 2> 124332 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@f506277[collection1] realtime]
[junit4] 2> 124332 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 124521 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1621
[junit4] 2> 124524 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160
(1601452401800249344), 161 (1601452401801297920), 162 (1601452401801297921),
163 (1601452401801297922), 164 (1601452401802346496), 165
(1601452401802346497), 166 (1601452401802346498), 167 (1601452401802346499),
168 (1601452401802346500), 169 (1601452401802346501), ... (20 adds)]} 0 2
[junit4] 2> 124727 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1828
[junit4] 2> 124730 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180
(1601452402017304576), 181 (1601452402017304577), 182 (1601452402017304578),
183 (1601452402017304579), 184 (1601452402017304580), 185
(1601452402017304581), 186 (1601452402018353152), 187 (1601452402018353153),
188 (1601452402018353154), 189 (1601452402018353155), ... (20 adds)]} 0 2
[junit4] 2> 124931 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=2031
[junit4] 2> 124935 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200
(1601452402230165504), 201 (1601452402231214080), 202 (1601452402231214081),
203 (1601452402231214082), 204 (1601452402231214083), 205
(1601452402231214084), 206 (1601452402231214085), 207 (1601452402233311232),
208 (1601452402233311233), 209 (1601452402233311234), ... (20 adds)]} 0 3
[junit4] 2> 125136 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=2236
[junit4] 2> 125147 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220
(1601452402446172160), 221 (1601452402449317888), 222 (1601452402449317889),
223 (1601452402449317890), 224 (1601452402450366464), 225
(1601452402450366465), 226 (1601452402450366466), 227 (1601452402450366467),
228 (1601452402450366468), 229 (1601452402450366469), ... (20 adds)]} 0 10
[junit4] 2> 125347 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=2448
[junit4] 2> 125352 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240
(1601452402667421696), 241 (1601452402667421697), 242 (1601452402670567424),
243 (1601452402670567425), 244 (1601452402670567426), 245
(1601452402670567427), 246 (1601452402670567428), 247 (1601452402670567429),
248 (1601452402670567430), 249 (1601452402671616000), ... (20 adds)]} 0 4
[junit4] 2> 125556 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=2657
[junit4] 2> 125559 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260
(1601452402886574080), 261 (1601452402886574081), 262 (1601452402886574082),
263 (1601452402886574083), 264 (1601452402887622656), 265
(1601452402887622657), 266 (1601452402887622658), 267 (1601452402887622659),
268 (1601452402887622660), 269 (1601452402887622661), ... (20 adds)]} 0 2
[junit4] 2> 125563 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 125563 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2b37c485 commitCommandVersion:0
[junit4] 2> 125580 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@51dde84e[collection1] realtime]
[junit4] 2> 125581 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 125610 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=2710
[junit4] 2> 125613 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280
(1601452402942148608), 281 (1601452402943197184), 282 (1601452402943197185),
283 (1601452402944245760), 284 (1601452402944245761), 285
(1601452402944245762), 286 (1601452402944245763), 287 (1601452402944245764),
288 (1601452402944245765), 289 (1601452402944245766), ... (20 adds)]} 0 2
[junit4] 2> 125817 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=2917
[junit4] 2> 125818 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300
(1601452403159203840), 301 (1601452403159203841), 302 (1601452403159203842),
303 (1601452403160252416), 304 (1601452403160252417), 305
(1601452403160252418), 306 (1601452403160252419), 307 (1601452403160252420),
308 (1601452403160252421), 309 (1601452403160252422), ... (20 adds)]} 0 1
[junit4] 2> 126023 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=3123
[junit4] 2> 126025 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320
(1601452403375210496), 321 (1601452403376259072), 322 (1601452403376259073),
323 (1601452403376259074), 324 (1601452403376259075), 325
(1601452403376259076), 326 (1601452403376259077), 327 (1601452403376259078),
328 (1601452403376259079), 329 (1601452403376259080), ... (20 adds)]} 0 1
[junit4] 2> 126237 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=3337
[junit4] 2> 126239 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340
(1601452403599605760), 341 (1601452403599605761), 342 (1601452403599605762),
343 (1601452403599605763), 344 (1601452403600654336), 345
(1601452403600654337), 346 (1601452403600654338), 347 (1601452403600654339),
348 (1601452403600654340), 349 (1601452403600654341), ... (20 adds)]} 0 1
[junit4] 2> 126443 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=3543
[junit4] 2> 126445 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360
(1601452403815612416), 361 (1601452403815612417), 362 (1601452403816660992),
363 (1601452403816660993), 364 (1601452403816660994), 365
(1601452403816660995), 366 (1601452403816660996), 367 (1601452403816660997),
368 (1601452403816660998), 369 (1601452403816660999), ... (20 adds)]} 0 1
[junit4] 2> 126646 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=3746
[junit4] 2> 126647 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380
(1601452404028473344), 381 (1601452404028473345), 382 (1601452404028473346),
383 (1601452404028473347), 384 (1601452404028473348), 385
(1601452404028473349), 386 (1601452404028473350), 387 (1601452404029521920),
388 (1601452404029521921), 389 (1601452404029521922), ... (20 adds)]} 0 1
[junit4] 2> 126849 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=3949
[junit4] 2> 126851 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400
(1601452404241334272), 401 (1601452404241334273), 402 (1601452404241334274),
403 (1601452404242382848), 404 (1601452404242382849), 405
(1601452404242382850), 406 (1601452404242382851), 407 (1601452404242382852),
408 (1601452404242382853), 409 (1601452404243431424), ... (20 adds)]} 0 2
[junit4] 2> 126852 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 126852 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2b37c485 commitCommandVersion:0
[junit4] 2> 126879 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4edb1bfc[collection1] realtime]
[junit4] 2> 126879 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 126902 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=4002
[junit4] 2> 126905 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420
(1601452404296908800), 421 (1601452404299005952), 422 (1601452404299005953),
423 (1601452404299005954), 424 (1601452404299005955), 425
(1601452404299005956), 426 (1601452404299005957), 427 (1601452404299005958),
428 (1601452404299005959), 429 (1601452404299005960), ... (20 adds)]} 0 2
[junit4] 2> 127113 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=4214
[junit4] 2> 127115 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440
(1601452404519206912), 441 (1601452404519206913), 442 (1601452404519206914),
443 (1601452404519206915), 444 (1601452404519206916), 445
(1601452404519206917), 446 (1601452404519206918), 447 (1601452404519206919),
448 (1601452404519206920), 449 (1601452404520255488), ... (20 adds)]} 0 1
[junit4] 2> 127317 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=4417
[junit4] 2> 127319 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460
(1601452404732067840), 461 (1601452404733116416), 462 (1601452404733116417),
463 (1601452404733116418), 464 (1601452404733116419), 465
(1601452404733116420), 466 (1601452404733116421), 467 (1601452404733116422),
468 (1601452404733116423), 469 (1601452404733116424), ... (20 adds)]} 0 1
[junit4] 2> 127520 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=4620
[junit4] 2> 127529 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480
(1601452404944928768), 481 (1601452404944928769), 482 (1601452404945977344),
483 (1601452404945977345), 484 (1601452404945977346), 485
(1601452404945977347), 486 (1601452404945977348), 487 (1601452404945977349),
488 (1601452404945977350), 489 (1601452404945977351), ... (20 adds)]} 0 8
[junit4] 2> 127730 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=4830
[junit4] 2> 127732 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500
(1601452405165129728), 501 (1601452405166178304), 502 (1601452405166178305),
503 (1601452405166178306), 504 (1601452405166178307), 505
(1601452405166178308), 506 (1601452405166178309), 507 (1601452405166178310),
508 (1601452405166178311), 509 (1601452405166178312), ... (20 adds)]} 0 1
[junit4] 2> 127937 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=5037
[junit4] 2> 127938 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520
(1601452405382184960), 521 (1601452405382184961), 522 (1601452405382184962),
523 (1601452405382184963), 524 (1601452405383233536), 525
(1601452405383233537), 526 (1601452405383233538), 527 (1601452405383233539),
528 (1601452405383233540), 529 (1601452405383233541), ... (20 adds)]} 0 1
[junit4] 2> 128139 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=5240
[junit4] 2> 128142 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540
(1601452405595045888), 541 (1601452405595045889), 542 (1601452405595045890),
543 (1601452405595045891), 544 (1601452405595045892), 545
(1601452405595045893), 546 (1601452405595045894), 547 (1601452405595045895),
548 (1601452405596094464), 549 (1601452405596094465), ... (20 adds)]} 0 2
[junit4] 2> 128144 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 128144 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2b37c485 commitCommandVersion:0
[junit4] 2> 128176 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7b5ec897[collection1] realtime]
[junit4] 2> 128176 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 128192 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=5292
[junit4] 2> 128195 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560
(1601452405650620416), 561 (1601452405651668992), 562 (1601452405651668993),
563 (1601452405651668994), 564 (1601452405651668995), 565
(1601452405651668996), 566 (1601452405651668997), 567 (1601452405651668998),
568 (1601452405651668999), 569 (1601452405651669000), ... (20 adds)]} 0 2
[junit4] 2> 128397 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=5497
[junit4] 2> 128399 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580
(1601452405864529920), 581 (1601452405865578496), 582 (1601452405865578497),
583 (1601452405865578498), 584 (1601452405865578499), 585
(1601452405865578500), 586 (1601452405865578501), 587 (1601452405865578502),
588 (1601452405865578503), 589 (1601452405865578504), ... (20 adds)]} 0 1
[junit4] 2> 128600 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=5700
[junit4] 2> 128602 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600
(1601452406077390848), 601 (1601452406078439424), 602 (1601452406078439425),
603 (1601452406078439426), 604 (1601452406078439427), 605
(1601452406078439428), 606 (1601452406078439429), 607 (1601452406078439430),
608 (1601452406078439431), 609 (1601452406078439432), ... (20 adds)]} 0 1
[junit4] 2> 128807 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=5907
[junit4] 2> 128808 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620
(1601452406294446080), 621 (1601452406294446081), 622 (1601452406294446082),
623 (1601452406294446083), 624 (1601452406294446084), 625
(1601452406294446085), 626 (1601452406294446086), 627 (1601452406294446087),
628 (1601452406294446088), 629 (1601452406294446089), ... (20 adds)]} 0 1
[junit4] 2> 129009 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=6109
[junit4] 2> 129010 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640
(1601452406506258432), 641 (1601452406507307008), 642 (1601452406507307009),
643 (1601452406507307010), 644 (1601452406507307011), 645
(1601452406507307012), 646 (1601452406507307013), 647 (1601452406507307014),
648 (1601452406507307015), 649 (1601452406507307016), ... (20 adds)]} 0 1
[junit4] 2> 129211 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=6312
[junit4] 2> 129213 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660
(1601452406719119360), 661 (1601452406719119361), 662 (1601452406719119362),
663 (1601452406719119363), 664 (1601452406719119364), 665
(1601452406719119365), 666 (1601452406719119366), 667 (1601452406719119367),
668 (1601452406719119368), 669 (1601452406719119369), ... (20 adds)]} 0 1
[junit4] 2> 129413 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=6514
[junit4] 2> 129415 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680
(1601452406930931712), 681 (1601452406930931713), 682 (1601452406930931714),
683 (1601452406930931715), 684 (1601452406930931716), 685
(1601452406930931717), 686 (1601452406930931718), 687 (1601452406930931719),
688 (1601452406930931720), 689 (1601452406930931721), ... (20 adds)]} 0 1
[junit4] 2> 129416 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 129416 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2b37c485 commitCommandVersion:0
[junit4] 2> 129423 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@2f0d1641[collection1] realtime]
[junit4] 2> 129423 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 129465 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=6566
[junit4] 2> 129467 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[700
(1601452406985457664), 701 (1601452406985457665), 702 (1601452406985457666),
703 (1601452406985457667), 704 (1601452406985457668), 705
(1601452406986506240), 706 (1601452406986506241), 707 (1601452406986506242),
708 (1601452406986506243), 709 (1601452406986506244), ... (20 adds)]} 0 1
[junit4] 2> 129668 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=6768
[junit4] 2> 129669 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[720
(1601452407197270016), 721 (1601452407197270017), 722 (1601452407197270018),
723 (1601452407197270019), 724 (1601452407197270020), 725
(1601452407198318592), 726 (1601452407198318593), 727 (1601452407198318594),
728 (1601452407198318595), 729 (1601452407198318596), ... (20 adds)]} 0 1
[junit4] 2> 129870 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=6970
[junit4] 2> 129871 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[740
(1601452407409082368), 741 (1601452407410130944), 742 (1601452407410130945),
743 (1601452407410130946), 744 (1601452407410130947), 745
(1601452407410130948), 746 (1601452407410130949), 747 (1601452407410130950),
748 (1601452407410130951), 749 (1601452407410130952), ... (20 adds)]} 0 1
[junit4] 2> 130072 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=7173
[junit4] 2> 130074 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[760
(1601452407621943296), 761 (1601452407621943297), 762 (1601452407621943298),
763 (1601452407621943299), 764 (1601452407621943300), 765
(1601452407621943301), 766 (1601452407621943302), 767 (1601452407621943303),
768 (1601452407621943304), 769 (1601452407621943305), ... (20 adds)]} 0 1
[junit4] 2> 130274 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=7375
[junit4] 2> 130276 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[780
(1601452407833755648), 781 (1601452407833755649), 782 (1601452407833755650),
783 (1601452407833755651), 784 (1601452407833755652), 785
(1601452407833755653), 786 (1601452407833755654), 787 (1601452407833755655),
788 (1601452407833755656), 789 (1601452407833755657), ... (20 adds)]} 0 1
[junit4] 2> 130477 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=7577
[junit4] 2> 130478 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[800
(1601452408045568000), 801 (1601452408045568001), 802 (1601452408045568002),
803 (1601452408045568003), 804 (1601452408045568004), 805
(1601452408045568005), 806 (1601452408045568006), 807 (1601452408045568007),
808 (1601452408045568008), 809 (1601452408046616576), ... (20 adds)]} 0 1
[junit4] 2> 130679 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=7779
[junit4] 2> 130690 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[820
(1601452408257380352), 821 (1601452408257380353), 822 (1601452408257380354),
823 (1601452408257380355), 824 (1601452408258428928), 825
(1601452408258428929), 826 (1601452408258428930), 827 (1601452408258428931),
828 (1601452408267866112), 829 (1601452408267866113), ... (20 adds)]} 0 10
[junit4] 2> 130690 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 130690 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2b37c485 commitCommandVersion:0
[junit4] 2> 130698 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b4e8252[collection1] realtime]
[junit4] 2> 130698 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 130740 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=7840
[junit4] 2> 130742 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[840
(1601452408321343488), 841 (1601452408322392064), 842 (1601452408322392065),
843 (1601452408323440640), 844 (1601452408323440641), 845
(1601452408323440642), 846 (1601452408323440643), 847 (1601452408323440644),
848 (1601452408323440645), 849 (1601452408323440646), ... (20 adds)]} 0 1
[junit4] 2> 130944 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=8045
[junit4] 2> 130948 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[860
(1601452408537350144), 861 (1601452408538398720), 862 (1601452408538398721),
863 (1601452408538398722), 864 (1601452408538398723), 865
(1601452408538398724), 866 (1601452408538398725), 867 (1601452408538398726),
868 (1601452408538398727), 869 (1601452408538398728), ... (20 adds)]} 0 1
[junit4] 2> 131149 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=8249
[junit4] 2> 131150 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[880
(1601452408750211072), 881 (1601452408750211073), 882 (1601452408750211074),
883 (1601452408750211075), 884 (1601452408750211076), 885
(1601452408750211077), 886 (1601452408750211078), 887 (1601452408750211079),
888 (1601452408750211080), 889 (1601452408751259648), ... (20 adds)]} 0 1
[junit4] 2> 131351 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=8451
[junit4] 2> 131352 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[900
(1601452408962023424), 901 (1601452408962023425), 902 (1601452408962023426),
903 (1601452408962023427), 904 (1601452408962023428), 905
(1601452408962023429), 906 (1601452408962023430), 907 (1601452408963072000),
908 (1601452408963072001), 909 (1601452408963072002), ... (20 adds)]} 0 0
[junit4] 2> 131553 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=8653
[junit4] 2> 131554 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[920
(1601452409173835776), 921 (1601452409173835777), 922 (1601452409173835778),
923 (1601452409173835779), 924 (1601452409173835780), 925
(1601452409173835781), 926 (1601452409173835782), 927 (1601452409173835783),
928 (1601452409173835784), 929 (1601452409174884352), ... (20 adds)]} 0 1
[junit4] 2> 131755 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=8855
[junit4] 2> 131756 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[940
(1601452409385648128), 941 (1601452409385648129), 942 (1601452409385648130),
943 (1601452409385648131), 944 (1601452409385648132), 945
(1601452409385648133), 946 (1601452409385648134), 947 (1601452409386696704),
948 (1601452409386696705), 949 (1601452409386696706), ... (20 adds)]} 0 0
[junit4] 2> 131957 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=9057
[junit4] 2> 131958 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[960
(1601452409597460480), 961 (1601452409597460481), 962 (1601452409597460482),
963 (1601452409597460483), 964 (1601452409597460484), 965
(1601452409597460485), 966 (1601452409597460486), 967 (1601452409597460487),
968 (1601452409598509056), 969 (1601452409598509057), ... (20 adds)]} 0 1
[junit4] 2> 131959 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 131959 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2b37c485 commitCommandVersion:0
[junit4] 2> 131970 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@e1df48b[collection1] realtime]
[junit4] 2> 131971 INFO (commitScheduler-413-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 132009 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=9109
[junit4] 2> 132011 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[980
(1601452409651986432), 981 (1601452409653035008), 982 (1601452409653035009),
983 (1601452409653035010), 984 (1601452409653035011), 985
(1601452409653035012), 986 (1601452409653035013), 987 (1601452409653035014),
988 (1601452409654083584), 989 (1601452409654083585), ... (20 adds)]} 0 2
[junit4] 2> 132212 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=9312
[junit4] 2> 132212 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 132212 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@2b37c485 commitCommandVersion:0
[junit4] 2> 132217 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@40612b5f[collection1] main]
[junit4] 2> 132218 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 132218 INFO (searcherExecutor-410-thread-1) [ ]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@40612b5f[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C140)
Uninverting(_1(8.0.0):C20) Uninverting(_2(8.0.0):C120)
Uninverting(_3(8.0.0):C140) Uninverting(_4(8.0.0):C140)
Uninverting(_5(8.0.0):C140) Uninverting(_6(8.0.0):C140)
Uninverting(_7(8.0.0):C140) Uninverting(_8(8.0.0):C20)))}
[junit4] 2> 132269 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=9369
[junit4] 2> 132273 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending endToEndTest
{seed=[4C7CA07B3C9FB254:562ACF4DDC2D9556]}
[junit4] 2> 132273 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 132273 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1975024626
[junit4] 2> 132273 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 132273 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@6f86492e: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@2c17f0c3
[junit4] 2> 132278 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 132278 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4749922d: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@7e0877b4
[junit4] 2> 132281 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 132281 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7317a22: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@d8c25d3
[junit4] 2> 132281 INFO (coreCloseExecutor-415-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@43362831
[junit4] 2> 132281 INFO (coreCloseExecutor-415-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=43362831
[junit4] 2> 132282 INFO (coreCloseExecutor-415-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2f444eb0: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7ed1b6e1
[junit4] 2> 132305 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest
{seed=[4C7CA07B3C9FB254:E27C73B1E8EF5E7A]}
[junit4] 2> 132305 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 132306 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 132350 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 132357 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 132420 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 132507 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 132515 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 132516 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2799f001
[junit4] 2> 132517 INFO (coreLoadExecutor-422-thread-1) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 132517 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader,
from paths:
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib,
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 132534 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 132545 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 132653 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 132664 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1,
trusted=true
[junit4] 2> 132664 INFO (coreLoadExecutor-422-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@2799f001
[junit4] 2> 132664 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 132664 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_4C7CA07B3C9FB254-001/init-core-data-001/]
[junit4] 2> 132666 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=13, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 132670 WARN (coreLoadExecutor-422-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> 132710 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 132710 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 132712 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 132712 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 132713 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=23, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=95.505859375,
floorSegmentMB=1.1455078125, forceMergeDeletesPctAllowed=26.920283778454852,
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 132713 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@35d81b21[collection1] main]
[junit4] 2> 132714 WARN (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 132714 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 132714 INFO (coreLoadExecutor-422-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1601452410391232512
[junit4] 2> 132717 INFO
(searcherExecutor-423-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@35d81b21[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 132717 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 132720 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1601452410395426816), 1 (1601452410397523968), 2 (1601452410397523969), 3
(1601452410397523970), 4 (1601452410397523971), 5 (1601452410397523972), 6
(1601452410397523973), 7 (1601452410397523974), 8 (1601452410397523975), 9
(1601452410397523976), ... (20 adds)]} 0 2
[junit4] 2> 132921 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=203
[junit4] 2> 132924 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20
(1601452410610384896), 21 (1601452410610384897), 22 (1601452410610384898), 23
(1601452410610384899), 24 (1601452410610384900), 25 (1601452410610384901), 26
(1601452410610384902), 27 (1601452410610384903), 28 (1601452410610384904), 29
(1601452410610384905), ... (20 adds)]} 0 1
[junit4] 2> 133125 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=406
[junit4] 2> 133126 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40
(1601452410822197248), 41 (1601452410822197249), 42 (1601452410822197250), 43
(1601452410822197251), 44 (1601452410822197252), 45 (1601452410822197253), 46
(1601452410822197254), 47 (1601452410822197255), 48 (1601452410823245824), 49
(1601452410823245825), ... (20 adds)]} 0 1
[junit4] 2> 133327 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=609
[junit4] 2> 133328 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60
(1601452411034009600), 61 (1601452411034009601), 62 (1601452411034009602), 63
(1601452411035058176), 64 (1601452411035058177), 65 (1601452411035058178), 66
(1601452411035058179), 67 (1601452411035058180), 68 (1601452411035058181), 69
(1601452411035058182), ... (20 adds)]} 0 1
[junit4] 2> 133531 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=813
[junit4] 2> 133532 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80
(1601452411247919104), 81 (1601452411247919105), 82 (1601452411247919106), 83
(1601452411247919107), 84 (1601452411247919108), 85 (1601452411248967680), 86
(1601452411248967681), 87 (1601452411248967682), 88 (1601452411248967683), 89
(1601452411248967684), ... (20 adds)]} 0 1
[junit4] 2> 133733 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1015
[junit4] 2> 133734 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100
(1601452411459731456), 101 (1601452411460780032), 102 (1601452411460780033),
103 (1601452411460780034), 104 (1601452411460780035), 105
(1601452411460780036), 106 (1601452411460780037), 107 (1601452411460780038),
108 (1601452411460780039), 109 (1601452411460780040), ... (20 adds)]} 0 1
[junit4] 2> 133937 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1218
[junit4] 2> 133938 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120
(1601452411673640960), 121 (1601452411673640961), 122 (1601452411673640962),
123 (1601452411673640963), 124 (1601452411673640964), 125
(1601452411673640965), 126 (1601452411673640966), 127 (1601452411673640967),
128 (1601452411674689536), 129 (1601452411674689537), ... (20 adds)]} 0 1
[junit4] 2> 133939 INFO (commitScheduler-426-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 133939 INFO (commitScheduler-426-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@579e08b commitCommandVersion:0
[junit4] 2> 133945 INFO (commitScheduler-426-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@4d1b7874[collection1] realtime]
[junit4] 2> 133946 INFO (commitScheduler-426-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 133989 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1271
[junit4] 2> 133991 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140
(1601452411728166912), 141 (1601452411729215488), 142 (1601452411729215489),
143 (1601452411729215490), 144 (1601452411729215491), 145
(1601452411729215492), 146 (1601452411729215493), 147 (1601452411729215494),
148 (1601452411730264064), 149 (1601452411730264065), ... (20 adds)]} 0 1
[junit4] 2> 134192 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1473
[junit4] 2> 134193 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160
(1601452411941027840), 161 (1601452411941027841), 162 (1601452411941027842),
163 (1601452411941027843), 164 (1601452411941027844), 165
(1601452411941027845), 166 (1601452411942076416), 167 (1601452411942076417),
168 (1601452411942076418), 169 (1601452411942076419), ... (20 adds)]} 0 1
[junit4] 2> 134394 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1676
[junit4] 2> 134395 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180
(1601452412152840192), 181 (1601452412152840193), 182 (1601452412152840194),
183 (1601452412152840195), 184 (1601452412152840196), 185
(1601452412153888768), 186 (1601452412153888769), 187 (1601452412153888770),
188 (1601452412153888771), 189 (1601452412153888772), ... (20 adds)]} 0 1
[junit4] 2> 134596 INFO
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[4C7CA07B3C9FB254]) [ ]
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=1878
[junit4] 2> 134598 INFO (TEST-MaxSizeAutoCommitTest.endToEn
[...truncated too long message...]
.ManagedResourceStorage Cannot write to config directory
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf;
switching to use InMemory storage instead.
[junit4] 2> 176911 INFO (coreLoadExecutor-487-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 176912 INFO
(searcherExecutor-488-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@43f3ed3c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 176912 INFO (coreLoadExecutor-487-thread-1) [
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1601452456736194560
[junit4] 2> 176915 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 176917 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0
(1601452456740388864), 1 (1601452456741437440), 2 (1601452456741437441)]} 0 2
[junit4] 2> 177118 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3
(1601452456952201216), 4 (1601452456952201217), 5 (1601452456952201218)]} 0 0
[junit4] 2> 177319 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6
(1601452457162964992), 7 (1601452457162964993), 8 (1601452457162964994)]} 0 0
[junit4] 2> 177521 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9
(1601452457373728768), 10 (1601452457373728769), 11 (1601452457374777344)]} 0 0
[junit4] 2> 177721 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12
(1601452457584492544), 13 (1601452457584492545), 14 (1601452457584492546)]} 0 0
[junit4] 2> 177922 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15
(1601452457795256320), 16 (1601452457795256321), 17 (1601452457795256322)]} 0 0
[junit4] 2> 178123 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[18
(1601452458006020096), 19 (1601452458006020097), 20 (1601452458006020098)]} 0 0
[junit4] 2> 178324 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[21
(1601452458216783872), 22 (1601452458216783873), 23 (1601452458216783874)]} 0 0
[junit4] 2> 178526 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[24
(1601452458427547648), 25 (1601452458427547649), 26 (1601452458427547650)]} 0 0
[junit4] 2> 178526 INFO (commitScheduler-491-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 178527 INFO (commitScheduler-491-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@339143fe commitCommandVersion:0
[junit4] 2> 178564 INFO (commitScheduler-491-thread-1) [ ]
o.a.s.s.SolrIndexSearcher Opening [Searcher@60aa97d6[collection1] realtime]
[junit4] 2> 178564 INFO (commitScheduler-491-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 178577 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[27
(1601452458481025024), 28 (1601452458482073600), 29 (1601452458482073601)]} 0 0
[junit4] 2> 178778 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending simpleTest
[junit4] 2> 178778 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 178778 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1732010593
[junit4] 2> 178778 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 178778 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@42a704d6: rootName = null,
domain = solr.node, service url = null, agent id = null] for registry solr.node
/ com.codahale.metrics.MetricRegistry@34ea54e7
[junit4] 2> 178782 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 178782 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7ca3151f: rootName = null,
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm /
com.codahale.metrics.MetricRegistry@7e0877b4
[junit4] 2> 178785 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 178785 INFO
(TEST-MaxSizeAutoCommitTest.simpleTest-seed#[4C7CA07B3C9FB254]) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@50f78e17: rootName = null,
domain = solr.jetty, service url = null, agent id = null] for registry
solr.jetty / com.codahale.metrics.MetricRegistry@d8c25d3
[junit4] 2> 178796 INFO (coreCloseExecutor-493-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@71610e30
[junit4] 2> 178797 INFO (coreCloseExecutor-493-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=71610e30
[junit4] 2> 178797 INFO (coreCloseExecutor-493-thread-1) [
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@55a04270: rootName = null,
domain = solr.core.collection1, service url = null, agent id = null] for
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4b4b247e
[junit4] 2> 178843 INFO (coreCloseExecutor-493-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 178844 INFO (coreCloseExecutor-493-thread-1) [
x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@339143fe commitCommandVersion:0
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.MaxSizeAutoCommitTest_4C7CA07B3C9FB254-001
[junit4] 2> May 25, 2018 4:01:18 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval),
id=PostingsFormat(name=Asserting)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70),
_version_=DocValuesFormat(name=Direct),
intDefault=DocValuesFormat(name=Direct), id_i1=DocValuesFormat(name=Direct),
range_facet_i_dv=DocValuesFormat(name=Lucene70),
intDvoDefault=DocValuesFormat(name=Lucene70),
range_facet_l=DocValuesFormat(name=Lucene70),
timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=943,
maxMBSortInHeap=7.036506418387999,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1cc3ff40),
locale=sr-BA, timezone=Asia/Macau
[junit4] 2> NOTE: Linux 4.13.0-41-generic amd64/Oracle Corporation 10.0.1
(64-bit)/cpus=8,threads=1,free=282693632,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [HdfsBasicDistributedZkTest,
TestCloudPseudoReturnFields, SimplePostToolTest, SuggesterFSTTest,
TestFunctionQuery, DocExpirationUpdateProcessorFactoryTest, SearchHandlerTest,
DistribJoinFromCollectionTest, DirectSolrConnectionTest, TestCloudConsistency,
ExplicitHLLTest, TestZkChroot, MaxSizeAutoCommitTest]
[junit4] Completed [59/809 (1!)] on J1 in 60.55s, 8 tests, 1 failure <<<
FAILURES!
[...truncated 46397 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22102/consoleText
[repro] Revision: 18ad8d137afa8e2017f4121ddced4d630b1c86a1
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] Repro line: ant test -Dtestcase=MaxSizeAutoCommitTest
-Dtests.method=deleteTest -Dtests.seed=4C7CA07B3C9FB254 -Dtests.multiplier=3
-Dtests.slow=true -Dtests.locale=sr-BA -Dtests.timezone=Asia/Macau
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] MaxSizeAutoCommitTest
[repro] ant compile-test
[...truncated 3303 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5
-Dtests.class="*.MaxSizeAutoCommitTest" -Dtests.showOutput=onerror
"-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=4C7CA07B3C9FB254
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sr-BA
-Dtests.timezone=Asia/Macau -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[...truncated 111 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.update.MaxSizeAutoCommitTest
[repro] Exiting with code 0
[...truncated 40 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
