Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1920/
Java: 64bit/jdk-9.0.4 -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-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_A569C2CBB7547EDE-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-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_A569C2CBB7547EDE-001/init-core-data-001/tlog/tlog.0000000000000000003,
 tlog size: 1302
        at 
__randomizedtesting.SeedInfo.seed([A569C2CBB7547EDE:B5272734CCFA472F]: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 14988 lines...]
   [junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_A569C2CBB7547EDE-001/init-core-data-001
   [junit4]   2> 2444896 WARN  
(SUITE-MaxSizeAutoCommitTest-seed#[A569C2CBB7547EDE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7
   [junit4]   2> 2444896 INFO  
(SUITE-MaxSizeAutoCommitTest-seed#[A569C2CBB7547EDE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 2444897 INFO  
(SUITE-MaxSizeAutoCommitTest-seed#[A569C2CBB7547EDE]-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> 2444897 INFO  
(SUITE-MaxSizeAutoCommitTest-seed#[A569C2CBB7547EDE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2444898 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest 
{seed=[A569C2CBB7547EDE:BF3FADFD57E659DC]}
   [junit4]   2> 2444911 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 2444912 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2444934 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 2444946 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 2445045 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2445080 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c638a0
   [junit4]   2> 2445089 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c638a0
   [junit4]   2> 2445090 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c638a0
   [junit4]   2> 2445091 INFO  (coreLoadExecutor-4849-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2445091 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2445109 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 2445119 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2445185 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2445190 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 2445191 INFO  (coreLoadExecutor-4849-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@43c638a0
   [junit4]   2> 2445191 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2445191 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_A569C2CBB7547EDE-001/init-core-data-001/]
   [junit4]   2> 2445192 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 2445193 WARN  (coreLoadExecutor-4849-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> 2445228 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2445228 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2445229 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2445229 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2445231 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4797348965298033]
   [junit4]   2> 2445231 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@538826d5[collection1] main]
   [junit4]   2> 2445231 WARN  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 2445231 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2445232 INFO  
(searcherExecutor-4850-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@538826d5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2445232 INFO  (coreLoadExecutor-4849-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1600727415979507712
   [junit4]   2> 2445235 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 2445239 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1600727415983702016), 1 (1600727415984750592), 2 (1600727415985799168), 3 
(1600727415985799169), 4 (1600727415985799170), 5 (1600727415985799171), 6 
(1600727415985799172), 7 (1600727415985799173), 8 (1600727415985799174), 9 
(1600727415985799175), ... (20 adds)]} 0 3
   [junit4]   2> 2445440 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=204
   [junit4]   2> 2445442 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 
(1600727416198660096), 21 (1600727416198660097), 22 (1600727416198660098), 23 
(1600727416198660099), 24 (1600727416199708672), 25 (1600727416199708673), 26 
(1600727416199708674), 27 (1600727416199708675), 28 (1600727416199708676), 29 
(1600727416199708677), ... (20 adds)]} 0 1
   [junit4]   2> 2445643 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=407
   [junit4]   2> 2445644 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 
(1600727416410472448), 41 (1600727416411521024), 42 (1600727416411521025), 43 
(1600727416411521026), 44 (1600727416411521027), 45 (1600727416411521028), 46 
(1600727416411521029), 47 (1600727416411521030), 48 (1600727416411521031), 49 
(1600727416411521032), ... (20 adds)]} 0 1
   [junit4]   2> 2445845 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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> 2445846 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 
(1600727416623333376), 61 (1600727416623333377), 62 (1600727416623333378), 63 
(1600727416623333379), 64 (1600727416623333380), 65 (1600727416623333381), 66 
(1600727416623333382), 67 (1600727416623333383), 68 (1600727416623333384), 69 
(1600727416623333385), ... (20 adds)]} 0 1
   [junit4]   2> 2446049 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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> 2446050 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 
(1600727416836194304), 81 (1600727416837242880), 82 (1600727416837242881), 83 
(1600727416837242882), 84 (1600727416837242883), 85 (1600727416837242884), 86 
(1600727416837242885), 87 (1600727416837242886), 88 (1600727416837242887), 89 
(1600727416837242888), ... (20 adds)]} 0 1
   [junit4]   2> 2446251 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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> 2446252 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 
(1600727417048006656), 101 (1600727417049055232), 102 (1600727417049055233), 
103 (1600727417049055234), 104 (1600727417049055235), 105 
(1600727417049055236), 106 (1600727417049055237), 107 (1600727417049055238), 
108 (1600727417049055239), 109 (1600727417049055240), ... (20 adds)]} 0 0
   [junit4]   2> 2446453 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1217
   [junit4]   2> 2446454 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 
(1600727417259819008), 121 (1600727417259819009), 122 (1600727417259819010), 
123 (1600727417259819011), 124 (1600727417259819012), 125 
(1600727417259819013), 126 (1600727417259819014), 127 (1600727417259819015), 
128 (1600727417260867584), 129 (1600727417260867585), ... (20 adds)]} 0 1
   [junit4]   2> 2446455 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2446455 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7c6a6a20 commitCommandVersion:0
   [junit4]   2> 2446459 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@90f9430[collection1] realtime]
   [junit4]   2> 2446459 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2446505 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1269
   [junit4]   2> 2446506 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 
(1600727417314344960), 141 (1600727417315393536), 142 (1600727417315393537), 
143 (1600727417315393538), 144 (1600727417315393539), 145 
(1600727417315393540), 146 (1600727417315393541), 147 (1600727417315393542), 
148 (1600727417315393543), 149 (1600727417315393544), ... (20 adds)]} 0 1
   [junit4]   2> 2446707 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1471
   [junit4]   2> 2446708 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160 
(1600727417526157312), 161 (1600727417527205888), 162 (1600727417527205889), 
163 (1600727417527205890), 164 (1600727417527205891), 165 
(1600727417527205892), 166 (1600727417527205893), 167 (1600727417527205894), 
168 (1600727417527205895), 169 (1600727417527205896), ... (20 adds)]} 0 0
   [junit4]   2> 2446909 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1673
   [junit4]   2> 2446913 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180 
(1600727417737969664), 181 (1600727417737969665), 182 (1600727417737969666), 
183 (1600727417737969667), 184 (1600727417737969668), 185 
(1600727417737969669), 186 (1600727417737969670), 187 (1600727417737969671), 
188 (1600727417739018240), 189 (1600727417742163968), ... (20 adds)]} 0 3
   [junit4]   2> 2447114 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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> 2447115 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200 
(1600727417952927744), 201 (1600727417952927745), 202 (1600727417952927746), 
203 (1600727417952927747), 204 (1600727417952927748), 205 
(1600727417952927749), 206 (1600727417952927750), 207 (1600727417952927751), 
208 (1600727417952927752), 209 (1600727417952927753), ... (20 adds)]} 0 0
   [junit4]   2> 2447316 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2080
   [junit4]   2> 2447316 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220 
(1600727418164740096), 221 (1600727418164740097), 222 (1600727418164740098), 
223 (1600727418164740099), 224 (1600727418164740100), 225 
(1600727418164740101), 226 (1600727418164740102), 227 (1600727418164740103), 
228 (1600727418164740104), 229 (1600727418164740105), ... (20 adds)]} 0 0
   [junit4]   2> 2447517 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2282
   [junit4]   2> 2447518 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240 
(1600727418376552448), 241 (1600727418376552449), 242 (1600727418376552450), 
243 (1600727418376552451), 244 (1600727418376552452), 245 
(1600727418376552453), 246 (1600727418376552454), 247 (1600727418376552455), 
248 (1600727418376552456), 249 (1600727418376552457), ... (20 adds)]} 0 0
   [junit4]   2> 2447719 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2483
   [junit4]   2> 2447720 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260 
(1600727418588364800), 261 (1600727418588364801), 262 (1600727418588364802), 
263 (1600727418588364803), 264 (1600727418588364804), 265 
(1600727418588364805), 266 (1600727418588364806), 267 (1600727418588364807), 
268 (1600727418588364808), 269 (1600727418588364809), ... (20 adds)]} 0 0
   [junit4]   2> 2447721 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2447721 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7c6a6a20 commitCommandVersion:0
   [junit4]   2> 2447727 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@114494a2[collection1] realtime]
   [junit4]   2> 2447727 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2447771 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2535
   [junit4]   2> 2447772 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280 
(1600727418641842176), 281 (1600727418642890752), 282 (1600727418642890753), 
283 (1600727418642890754), 284 (1600727418642890755), 285 
(1600727418642890756), 286 (1600727418642890757), 287 (1600727418642890758), 
288 (1600727418642890759), 289 (1600727418642890760), ... (20 adds)]} 0 1
   [junit4]   2> 2447973 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2737
   [junit4]   2> 2447974 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300 
(1600727418853654528), 301 (1600727418853654529), 302 (1600727418853654530), 
303 (1600727418853654531), 304 (1600727418853654532), 305 
(1600727418853654533), 306 (1600727418853654534), 307 (1600727418853654535), 
308 (1600727418853654536), 309 (1600727418853654537), ... (20 adds)]} 0 0
   [junit4]   2> 2448174 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2939
   [junit4]   2> 2448175 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320 
(1600727419065466880), 321 (1600727419065466881), 322 (1600727419065466882), 
323 (1600727419065466883), 324 (1600727419065466884), 325 
(1600727419065466885), 326 (1600727419065466886), 327 (1600727419065466887), 
328 (1600727419065466888), 329 (1600727419065466889), ... (20 adds)]} 0 0
   [junit4]   2> 2448376 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3140
   [junit4]   2> 2448377 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340 
(1600727419276230656), 341 (1600727419276230657), 342 (1600727419276230658), 
343 (1600727419276230659), 344 (1600727419276230660), 345 
(1600727419276230661), 346 (1600727419276230662), 347 (1600727419276230663), 
348 (1600727419276230664), 349 (1600727419276230665), ... (20 adds)]} 0 0
   [junit4]   2> 2448577 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3342
   [junit4]   2> 2448578 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360 
(1600727419488043008), 361 (1600727419488043009), 362 (1600727419488043010), 
363 (1600727419488043011), 364 (1600727419488043012), 365 
(1600727419488043013), 366 (1600727419488043014), 367 (1600727419488043015), 
368 (1600727419488043016), 369 (1600727419488043017), ... (20 adds)]} 0 0
   [junit4]   2> 2448779 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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> 2448780 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380 
(1600727419698806784), 381 (1600727419698806785), 382 (1600727419699855360), 
383 (1600727419699855361), 384 (1600727419699855362), 385 
(1600727419699855363), 386 (1600727419699855364), 387 (1600727419699855365), 
388 (1600727419699855366), 389 (1600727419699855367), ... (20 adds)]} 0 0
   [junit4]   2> 2448981 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3745
   [junit4]   2> 2448982 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400 
(1600727419910619136), 401 (1600727419911667712), 402 (1600727419911667713), 
403 (1600727419911667714), 404 (1600727419911667715), 405 
(1600727419911667716), 406 (1600727419911667717), 407 (1600727419911667718), 
408 (1600727419911667719), 409 (1600727419911667720), ... (20 adds)]} 0 0
   [junit4]   2> 2448983 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2448983 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7c6a6a20 commitCommandVersion:0
   [junit4]   2> 2448986 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@11c83387[collection1] realtime]
   [junit4]   2> 2448987 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2449033 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3797
   [junit4]   2> 2449034 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420 
(1600727419965145088), 421 (1600727419966193664), 422 (1600727419966193665), 
423 (1600727419966193666), 424 (1600727419966193667), 425 
(1600727419966193668), 426 (1600727419966193669), 427 (1600727419966193670), 
428 (1600727419966193671), 429 (1600727419966193672), ... (20 adds)]} 0 1
   [junit4]   2> 2449235 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3999
   [junit4]   2> 2449236 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440 
(1600727420176957440), 441 (1600727420176957441), 442 (1600727420176957442), 
443 (1600727420176957443), 444 (1600727420176957444), 445 
(1600727420178006016), 446 (1600727420178006017), 447 (1600727420178006018), 
448 (1600727420178006019), 449 (1600727420178006020), ... (20 adds)]} 0 0
   [junit4]   2> 2449437 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=4201
   [junit4]   2> 2449438 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460 
(1600727420388769792), 461 (1600727420388769793), 462 (1600727420388769794), 
463 (1600727420388769795), 464 (1600727420388769796), 465 
(1600727420388769797), 466 (1600727420388769798), 467 (1600727420388769799), 
468 (1600727420388769800), 469 (1600727420388769801), ... (20 adds)]} 0 0
   [junit4]   2> 2449638 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=4402
   [junit4]   2> 2449639 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480 
(1600727420599533568), 481 (1600727420600582144), 482 (1600727420600582145), 
483 (1600727420600582146), 484 (1600727420600582147), 485 
(1600727420600582148), 486 (1600727420600582149), 487 (1600727420600582150), 
488 (1600727420600582151), 489 (1600727420600582152), ... (20 adds)]} 0 0
   [junit4]   2> 2449840 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=4604
   [junit4]   2> 2449841 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1600727420811345920), 501 (1600727420811345921), 502 (1600727420811345922), 
503 (1600727420811345923), 504 (1600727420811345924), 505 
(1600727420811345925), 506 (1600727420811345926), 507 (1600727420811345927), 
508 (1600727420811345928), 509 (1600727420811345929), ... (20 adds)]} 0 0
   [junit4]   2> 2450042 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=4806
   [junit4]   2> 2450042 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520 
(1600727421023158272), 521 (1600727421023158273), 522 (1600727421023158274), 
523 (1600727421023158275), 524 (1600727421023158276), 525 
(1600727421023158277), 526 (1600727421023158278), 527 (1600727421023158279), 
528 (1600727421023158280), 529 (1600727421023158281), ... (20 adds)]} 0 0
   [junit4]   2> 2450251 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5015
   [junit4]   2> 2450252 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540 
(1600727421242310656), 541 (1600727421242310657), 542 (1600727421242310658), 
543 (1600727421242310659), 544 (1600727421242310660), 545 
(1600727421242310661), 546 (1600727421242310662), 547 (1600727421242310663), 
548 (1600727421243359232), 549 (1600727421243359233), ... (20 adds)]} 0 0
   [junit4]   2> 2450253 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2450253 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7c6a6a20 commitCommandVersion:0
   [junit4]   2> 2450255 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@50e22ae4[collection1] realtime]
   [junit4]   2> 2450255 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2450302 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5066
   [junit4]   2> 2450304 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560 
(1600727421296836608), 561 (1600727421296836609), 562 (1600727421296836610), 
563 (1600727421296836611), 564 (1600727421296836612), 565 
(1600727421296836613), 566 (1600727421296836614), 567 (1600727421296836615), 
568 (1600727421296836616), 569 (1600727421296836617), ... (20 adds)]} 0 1
   [junit4]   2> 2450504 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5268
   [junit4]   2> 2450505 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580 
(1600727421507600384), 581 (1600727421508648960), 582 (1600727421508648961), 
583 (1600727421508648962), 584 (1600727421508648963), 585 
(1600727421508648964), 586 (1600727421508648965), 587 (1600727421508648966), 
588 (1600727421508648967), 589 (1600727421508648968), ... (20 adds)]} 0 0
   [junit4]   2> 2450706 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5470
   [junit4]   2> 2450707 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600 
(1600727421719412736), 601 (1600727421719412737), 602 (1600727421719412738), 
603 (1600727421719412739), 604 (1600727421719412740), 605 
(1600727421719412741), 606 (1600727421719412742), 607 (1600727421719412743), 
608 (1600727421719412744), 609 (1600727421719412745), ... (20 adds)]} 0 0
   [junit4]   2> 2450907 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5671
   [junit4]   2> 2450908 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620 
(1600727421931225088), 621 (1600727421931225089), 622 (1600727421931225090), 
623 (1600727421931225091), 624 (1600727421931225092), 625 
(1600727421931225093), 626 (1600727421931225094), 627 (1600727421931225095), 
628 (1600727421931225096), 629 (1600727421931225097), ... (20 adds)]} 0 0
   [junit4]   2> 2451109 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5873
   [junit4]   2> 2451110 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640 
(1600727422141988864), 641 (1600727422141988865), 642 (1600727422141988866), 
643 (1600727422141988867), 644 (1600727422141988868), 645 
(1600727422141988869), 646 (1600727422141988870), 647 (1600727422141988871), 
648 (1600727422141988872), 649 (1600727422141988873), ... (20 adds)]} 0 0
   [junit4]   2> 2451311 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=6075
   [junit4]   2> 2451311 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660 
(1600727422353801216), 661 (1600727422353801217), 662 (1600727422353801218), 
663 (1600727422353801219), 664 (1600727422353801220), 665 
(1600727422353801221), 666 (1600727422353801222), 667 (1600727422353801223), 
668 (1600727422353801224), 669 (1600727422353801225), ... (20 adds)]} 0 0
   [junit4]   2> 2451512 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=6276
   [junit4]   2> 2451513 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680 
(1600727422564564992), 681 (1600727422565613568), 682 (1600727422565613569), 
683 (1600727422565613570), 684 (1600727422565613571), 685 
(1600727422565613572), 686 (1600727422565613573), 687 (1600727422565613574), 
688 (1600727422565613575), 689 (1600727422565613576), ... (20 adds)]} 0 0
   [junit4]   2> 2451514 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2451514 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7c6a6a20 commitCommandVersion:0
   [junit4]   2> 2451517 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@27ba0537[collection1] realtime]
   [junit4]   2> 2451518 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2451564 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=6328
   [junit4]   2> 2451565 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[700 
(1600727422619090944), 701 (1600727422619090945), 702 (1600727422619090946), 
703 (1600727422619090947), 704 (1600727422619090948), 705 
(1600727422620139520), 706 (1600727422620139521), 707 (1600727422620139522), 
708 (1600727422620139523), 709 (1600727422620139524), ... (20 adds)]} 0 1
   [junit4]   2> 2451767 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=6531
   [junit4]   2> 2451767 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[720 
(1600727422831951872), 721 (1600727422831951873), 722 (1600727422831951874), 
723 (1600727422831951875), 724 (1600727422831951876), 725 
(1600727422831951877), 726 (1600727422831951878), 727 (1600727422831951879), 
728 (1600727422831951880), 729 (1600727422831951881), ... (20 adds)]} 0 0
   [junit4]   2> 2451968 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=6732
   [junit4]   2> 2451969 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[740 
(1600727423043764224), 741 (1600727423043764225), 742 (1600727423043764226), 
743 (1600727423043764227), 744 (1600727423043764228), 745 
(1600727423043764229), 746 (1600727423043764230), 747 (1600727423043764231), 
748 (1600727423043764232), 749 (1600727423043764233), ... (20 adds)]} 0 0
   [junit4]   2> 2452170 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=6934
   [junit4]   2> 2452171 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[760 
(1600727423254528000), 761 (1600727423254528001), 762 (1600727423254528002), 
763 (1600727423254528003), 764 (1600727423254528004), 765 
(1600727423254528005), 766 (1600727423254528006), 767 (1600727423254528007), 
768 (1600727423254528008), 769 (1600727423254528009), ... (20 adds)]} 0 0
   [junit4]   2> 2452372 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=7136
   [junit4]   2> 2452372 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[780 
(1600727423466340352), 781 (1600727423466340353), 782 (1600727423466340354), 
783 (1600727423466340355), 784 (1600727423466340356), 785 
(1600727423466340357), 786 (1600727423466340358), 787 (1600727423466340359), 
788 (1600727423466340360), 789 (1600727423466340361), ... (20 adds)]} 0 0
   [junit4]   2> 2452573 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=7337
   [junit4]   2> 2452574 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[800 
(1600727423677104128), 801 (1600727423678152704), 802 (1600727423678152705), 
803 (1600727423678152706), 804 (1600727423678152707), 805 
(1600727423678152708), 806 (1600727423678152709), 807 (1600727423678152710), 
808 (1600727423678152711), 809 (1600727423678152712), ... (20 adds)]} 0 0
   [junit4]   2> 2452775 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=7539
   [junit4]   2> 2452776 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[820 
(1600727423888916480), 821 (1600727423888916481), 822 (1600727423888916482), 
823 (1600727423888916483), 824 (1600727423888916484), 825 
(1600727423888916485), 826 (1600727423888916486), 827 (1600727423888916487), 
828 (1600727423889965056), 829 (1600727423889965057), ... (20 adds)]} 0 0
   [junit4]   2> 2452778 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2452778 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7c6a6a20 commitCommandVersion:0
   [junit4]   2> 2452788 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@656f8462[collection1] realtime]
   [junit4]   2> 2452788 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2452826 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=7590
   [junit4]   2> 2452828 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[840 
(1600727423943442432), 841 (1600727423943442433), 842 (1600727423943442434), 
843 (1600727423943442435), 844 (1600727423943442436), 845 
(1600727423943442437), 846 (1600727423943442438), 847 (1600727423943442439), 
848 (1600727423943442440), 849 (1600727423943442441), ... (20 adds)]} 0 1
   [junit4]   2> 2453028 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=7793
   [junit4]   2> 2453029 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[860 
(1600727424155254784), 861 (1600727424155254785), 862 (1600727424155254786), 
863 (1600727424155254787), 864 (1600727424155254788), 865 
(1600727424155254789), 866 (1600727424155254790), 867 (1600727424155254791), 
868 (1600727424155254792), 869 (1600727424155254793), ... (20 adds)]} 0 0
   [junit4]   2> 2453230 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=7994
   [junit4]   2> 2453230 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[880 
(1600727424366018560), 881 (1600727424366018561), 882 (1600727424366018562), 
883 (1600727424366018563), 884 (1600727424366018564), 885 
(1600727424366018565), 886 (1600727424366018566), 887 (1600727424366018567), 
888 (1600727424366018568), 889 (1600727424366018569), ... (20 adds)]} 0 0
   [junit4]   2> 2453431 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=8195
   [junit4]   2> 2453432 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[900 
(1600727424576782336), 901 (1600727424577830912), 902 (1600727424577830913), 
903 (1600727424577830914), 904 (1600727424577830915), 905 
(1600727424577830916), 906 (1600727424577830917), 907 (1600727424577830918), 
908 (1600727424577830919), 909 (1600727424577830920), ... (20 adds)]} 0 0
   [junit4]   2> 2453633 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=8397
   [junit4]   2> 2453634 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[920 
(1600727424788594688), 921 (1600727424788594689), 922 (1600727424788594690), 
923 (1600727424788594691), 924 (1600727424788594692), 925 
(1600727424788594693), 926 (1600727424788594694), 927 (1600727424788594695), 
928 (1600727424788594696), 929 (1600727424788594697), ... (20 adds)]} 0 0
   [junit4]   2> 2453834 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=8599
   [junit4]   2> 2453835 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[940 
(1600727425000407040), 941 (1600727425000407041), 942 (1600727425000407042), 
943 (1600727425000407043), 944 (1600727425000407044), 945 
(1600727425000407045), 946 (1600727425000407046), 947 (1600727425000407047), 
948 (1600727425000407048), 949 (1600727425000407049), ... (20 adds)]} 0 0
   [junit4]   2> 2454036 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=8801
   [junit4]   2> 2454037 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[960 
(1600727425212219392), 961 (1600727425212219393), 962 (1600727425212219394), 
963 (1600727425212219395), 964 (1600727425212219396), 965 
(1600727425212219397), 966 (1600727425212219398), 967 (1600727425212219399), 
968 (1600727425212219400), 969 (1600727425212219401), ... (20 adds)]} 0 0
   [junit4]   2> 2454038 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2454038 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7c6a6a20 commitCommandVersion:0
   [junit4]   2> 2454042 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7fef3700[collection1] realtime]
   [junit4]   2> 2454042 INFO  (commitScheduler-4853-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2454088 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=8852
   [junit4]   2> 2454089 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[980 
(1600727425265696768), 981 (1600727425266745344), 982 (1600727425266745345), 
983 (1600727425266745346), 984 (1600727425266745347), 985 
(1600727425266745348), 986 (1600727425266745349), 987 (1600727425266745350), 
988 (1600727425266745351), 989 (1600727425266745352), ... (20 adds)]} 0 1
   [junit4]   2> 2454290 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=9054
   [junit4]   2> 2454290 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2454290 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7c6a6a20 commitCommandVersion:0
   [junit4]   2> 2454292 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4e672b7b[collection1] main]
   [junit4]   2> 2454293 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2454294 INFO  (searcherExecutor-4850-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4e672b7b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):C140)
 Uninverting(_1(7.4.0):C140) Uninverting(_2(7.4.0):C140) 
Uninverting(_3(7.4.0):C140) Uninverting(_4(7.4.0):C140) 
Uninverting(_5(7.4.0):C140) Uninverting(_6(7.4.0):C140) 
Uninverting(_7(7.4.0):C20)))}
   [junit4]   2> 2454345 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=9109
   [junit4]   2> 2454346 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending endToEndTest 
{seed=[A569C2CBB7547EDE:BF3FADFD57E659DC]}
   [junit4]   2> 2454346 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 2454346 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=380873477
   [junit4]   2> 2454347 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 2454347 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4407f74d: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@972dbbf
   [junit4]   2> 2454352 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 2454352 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@c99793: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@77cce185
   [junit4]   2> 2454357 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 2454357 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@41be21d2: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@4bff5841
   [junit4]   2> 2454357 INFO  (coreCloseExecutor-4855-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6ec9de65
   [junit4]   2> 2454357 INFO  (coreCloseExecutor-4855-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=6ec9de65
   [junit4]   2> 2454357 INFO  (coreCloseExecutor-4855-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6423c20a: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@62b1dbf0
   [junit4]   2> 2454370 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest 
{seed=[A569C2CBB7547EDE:B691101632492F0]}
   [junit4]   2> 2454370 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 2454371 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2454388 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 2454398 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 2454495 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2454539 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c638a0
   [junit4]   2> 2454549 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c638a0
   [junit4]   2> 2454549 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c638a0
   [junit4]   2> 2454553 INFO  (coreLoadExecutor-4862-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 2454553 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib,
 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 2454613 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 2454635 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2455019 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 2455028 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 2455028 INFO  (coreLoadExecutor-4862-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@43c638a0
   [junit4]   2> 2455028 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2455028 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_A569C2CBB7547EDE-001/init-core-data-001/]
   [junit4]   2> 2455030 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 2455033 WARN  (coreLoadExecutor-4862-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> 2455072 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2455072 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2455073 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2455073 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2455074 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4797348965298033]
   [junit4]   2> 2455075 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6a7cf070[collection1] main]
   [junit4]   2> 2455075 WARN  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 2455076 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 2455076 INFO  (coreLoadExecutor-4862-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1600727426301689856
   [junit4]   2> 2455078 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 2455080 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1600727426304835584), 1 (1600727426304835585), 2 (1600727426304835586), 3 
(1600727426305884160), 4 (1600727426305884161), 5 (1600727426305884162), 6 
(1600727426305884163), 7 (1600727426305884164), 8 (1600727426305884165), 9 
(1600727426305884166), ... (20 adds)]} 0 1
   [junit4]   2> 2455081 INFO  
(searcherExecutor-4863-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6a7cf070[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2455281 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=202
   [junit4]   2> 2455283 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 
(1600727426517696512), 21 (1600727426517696513), 22 (1600727426517696514), 23 
(1600727426517696515), 24 (1600727426517696516), 25 (1600727426517696517), 26 
(1600727426517696518), 27 (1600727426517696519), 28 (1600727426517696520), 29 
(1600727426517696521), ... (20 adds)]} 0 0
   [junit4]   2> 2455483 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=404
   [junit4]   2> 2455484 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 
(1600727426729508864), 41 (1600727426729508865), 42 (1600727426729508866), 43 
(1600727426729508867), 44 (1600727426729508868), 45 (1600727426729508869), 46 
(1600727426729508870), 47 (1600727426729508871), 48 (1600727426729508872), 49 
(1600727426729508873), ... (20 adds)]} 0 0
   [junit4]   2> 2455685 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=606
   [junit4]   2> 2455686 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 
(1600727426940272640), 61 (1600727426940272641), 62 (1600727426940272642), 63 
(1600727426940272643), 64 (1600727426940272644), 65 (1600727426940272645), 66 
(1600727426940272646), 67 (1600727426940272647), 68 (1600727426940272648), 69 
(1600727426940272649), ... (20 adds)]} 0 0
   [junit4]   2> 2455886 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=807
   [junit4]   2> 2455887 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 
(1600727427151036416), 81 (1600727427152084992), 82 (1600727427152084993), 83 
(1600727427152084994), 84 (1600727427152084995), 85 (1600727427152084996), 86 
(1600727427152084997), 87 (1600727427152084998), 88 (1600727427152084999), 89 
(1600727427152085000), ... (20 adds)]} 0 0
   [junit4]   2> 2456087 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1008
   [junit4]   2> 2456088 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 
(1600727427362848768), 101 (1600727427362848769), 102 (1600727427362848770), 
103 (1600727427362848771), 104 (1600727427362848772), 105 
(1600727427362848773), 106 (1600727427362848774), 107 (1600727427362848775), 
108 (1600727427362848776), 109 (1600727427362848777), ... (20 adds)]} 0 0
   [junit4]   2> 2456289 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1210
   [junit4]   2> 2456293 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 
(1600727427573612544), 121 (1600727427573612545), 122 (1600727427574661120), 
123 (1600727427574661121), 124 (1600727427574661122), 125 
(1600727427574661123), 126 (1600727427574661124), 127 (1600727427574661125), 
128 (1600727427574661126), 129 (1600727427574661127), ... (20 adds)]} 0 3
   [junit4]   2> 2456293 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2456293 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6570c848 commitCommandVersion:0
   [junit4]   2> 2456299 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@12f1930f[collection1] realtime]
   [junit4]   2> 2456299 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2456343 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1264
   [junit4]   2> 2456344 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 
(1600727427630235648), 141 (1600727427631284224), 142 (1600727427631284225), 
143 (1600727427631284226), 144 (1600727427631284227), 145 
(1600727427631284228), 146 (1600727427631284229), 147 (1600727427631284230), 
148 (1600727427631284231), 149 (1600727427631284232), ... (20 adds)]} 0 1
   [junit4]   2> 2456546 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1467
   [junit4]   2> 2456547 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160 
(1600727427843096576), 161 (1600727427843096577), 162 (1600727427843096578), 
163 (1600727427843096579), 164 (1600727427843096580), 165 
(1600727427843096581), 166 (1600727427843096582), 167 (1600727427843096583), 
168 (1600727427843096584), 169 (1600727427843096585), ... (20 adds)]} 0 0
   [junit4]   2> 2456747 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1668
   [junit4]   2> 2456748 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180 
(1600727428054908928), 181 (1600727428054908929), 182 (1600727428054908930), 
183 (1600727428054908931), 184 (1600727428054908932), 185 
(1600727428054908933), 186 (1600727428054908934), 187 (1600727428054908935), 
188 (1600727428054908936), 189 (1600727428054908937), ... (20 adds)]} 0 0
   [junit4]   2> 2456949 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=1870
   [junit4]   2> 2456950 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200 
(1600727428265672704), 201 (1600727428265672705), 202 (1600727428265672706), 
203 (1600727428265672707), 204 (1600727428265672708), 205 
(1600727428266721280), 206 (1600727428266721281), 207 (1600727428266721282), 
208 (1600727428266721283), 209 (1600727428266721284), ... (20 adds)]} 0 0
   [junit4]   2> 2457151 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2072
   [junit4]   2> 2457151 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220 
(1600727428477485056), 221 (1600727428477485057), 222 (1600727428477485058), 
223 (1600727428477485059), 224 (1600727428477485060), 225 
(1600727428477485061), 226 (1600727428477485062), 227 (1600727428477485063), 
228 (1600727428477485064), 229 (1600727428477485065), ... (20 adds)]} 0 0
   [junit4]   2> 2457352 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2273
   [junit4]   2> 2457353 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240 
(1600727428689297408), 241 (1600727428689297409), 242 (1600727428689297410), 
243 (1600727428689297411), 244 (1600727428689297412), 245 
(1600727428689297413), 246 (1600727428689297414), 247 (1600727428689297415), 
248 (1600727428689297416), 249 (1600727428689297417), ... (20 adds)]} 0 0
   [junit4]   2> 2457554 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2475
   [junit4]   2> 2457555 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260 
(1600727428900061184), 261 (1600727428900061185), 262 (1600727428900061186), 
263 (1600727428900061187), 264 (1600727428900061188), 265 
(1600727428900061189), 266 (1600727428900061190), 267 (1600727428900061191), 
268 (1600727428901109760), 269 (1600727428901109761), ... (20 adds)]} 0 0
   [junit4]   2> 2457556 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2457556 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6570c848 commitCommandVersion:0
   [junit4]   2> 2457559 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@a4922a5[collection1] realtime]
   [junit4]   2> 2457559 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2457605 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2526
   [junit4]   2> 2457607 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280 
(1600727428954587136), 281 (1600727428955635712), 282 (1600727428955635713), 
283 (1600727428955635714), 284 (1600727428955635715), 285 
(1600727428955635716), 286 (1600727428955635717), 287 (1600727428955635718), 
288 (1600727428955635719), 289 (1600727428955635720), ... (20 adds)]} 0 1
   [junit4]   2> 2457808 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=2729
   [junit4]   2> 2457809 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300 
(1600727429166399488), 301 (1600727429166399489), 302 (1600727429166399490), 
303 (1600727429166399491), 304 (1600727429166399492), 305 
(1600727429166399493), 306 (1600727429166399494), 307 (1600727429166399495), 
308 (1600727429166399496), 309 (1600727429166399497), ... (20 adds)]} 0 0
   [junit4]   2> 2458009 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2930
   [junit4]   2> 2458010 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320 
(1600727429378211840), 321 (1600727429378211841), 322 (1600727429378211842), 
323 (1600727429378211843), 324 (1600727429378211844), 325 
(1600727429378211845), 326 (1600727429378211846), 327 (1600727429378211847), 
328 (1600727429378211848), 329 (1600727429378211849), ... (20 adds)]} 0 0
   [junit4]   2> 2458211 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3132
   [junit4]   2> 2458212 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340 
(1600727429588975616), 341 (1600727429588975617), 342 (1600727429588975618), 
343 (1600727429588975619), 344 (1600727429590024192), 345 
(1600727429590024193), 346 (1600727429590024194), 347 (1600727429590024195), 
348 (1600727429590024196), 349 (1600727429590024197), ... (20 adds)]} 0 0
   [junit4]   2> 2458413 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3334
   [junit4]   2> 2458413 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360 
(1600727429800787968), 361 (1600727429800787969), 362 (1600727429800787970), 
363 (1600727429800787971), 364 (1600727429800787972), 365 
(1600727429800787973), 366 (1600727429800787974), 367 (1600727429800787975), 
368 (1600727429800787976), 369 (1600727429800787977), ... (20 adds)]} 0 0
   [junit4]   2> 2458614 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3535
   [junit4]   2> 2458615 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380 
(1600727430011551744), 381 (1600727430011551745), 382 (1600727430011551746), 
383 (1600727430011551747), 384 (1600727430011551748), 385 
(1600727430011551749), 386 (1600727430011551750), 387 (1600727430011551751), 
388 (1600727430011551752), 389 (1600727430011551753), ... (20 adds)]} 0 0
   [junit4]   2> 2458815 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3736
   [junit4]   2> 2458817 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400 
(1600727430223364096), 401 (1600727430223364097), 402 (1600727430223364098), 
403 (1600727430223364099), 404 (1600727430223364100), 405 
(1600727430223364101), 406 (1600727430223364102), 407 (1600727430223364103), 
408 (1600727430223364104), 409 (1600727430223364105), ... (20 adds)]} 0 1
   [junit4]   2> 2458818 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2458818 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6570c848 commitCommandVersion:0
   [junit4]   2> 2458825 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@67a2a3ff[collection1] realtime]
   [junit4]   2> 2458826 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2458867 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3788
   [junit4]   2> 2458869 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420 
(1600727430276841472), 421 (1600727430277890048), 422 (1600727430277890049), 
423 (1600727430277890050), 424 (1600727430277890051), 425 
(1600727430277890052), 426 (1600727430277890053), 427 (1600727430277890054), 
428 (1600727430277890055), 429 (1600727430277890056), ... (20 adds)]} 0 1
   [junit4]   2> 2459070 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=3991
   [junit4]   2> 2459071 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440 
(1600727430489702400), 441 (1600727430489702401), 442 (1600727430489702402), 
443 (1600727430489702403), 444 (1600727430489702404), 445 
(1600727430489702405), 446 (1600727430489702406), 447 (1600727430489702407), 
448 (1600727430489702408), 449 (1600727430490750976), ... (20 adds)]} 0 0
   [junit4]   2> 2459271 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=4192
   [junit4]   2> 2459272 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460 
(1600727430701514752), 461 (1600727430701514753), 462 (1600727430701514754), 
463 (1600727430701514755), 464 (1600727430701514756), 465 
(1600727430701514757), 466 (1600727430701514758), 467 (1600727430701514759), 
468 (1600727430701514760), 469 (1600727430701514761), ... (20 adds)]} 0 0
   [junit4]   2> 2459473 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=4394
   [junit4]   2> 2459473 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480 
(1600727430912278528), 481 (1600727430912278529), 482 (1600727430912278530), 
483 (1600727430912278531), 484 (1600727430912278532), 485 
(1600727430912278533), 486 (1600727430912278534), 487 (1600727430912278535), 
488 (1600727430912278536), 489 (1600727430912278537), ... (20 adds)]} 0 0
   [junit4]   2> 2459674 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=4595
   [junit4]   2> 2459675 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1600727431123042304), 501 (1600727431123042305), 502 (1600727431123042306), 
503 (1600727431123042307), 504 (1600727431123042308), 505 
(1600727431123042309), 506 (1600727431123042310), 507 (1600727431123042311), 
508 (1600727431123042312), 509 (1600727431123042313), ... (20 adds)]} 0 0
   [junit4]   2> 2459875 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4796
   [junit4]   2> 2459876 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520 
(1600727431334854656), 521 (1600727431334854657), 522 (1600727431334854658), 
523 (1600727431334854659), 524 (1600727431334854660), 525 
(1600727431334854661), 526 (1600727431334854662), 527 (1600727431334854663), 
528 (1600727431334854664), 529 (1600727431334854665), ... (20 adds)]} 0 0
   [junit4]   2> 2460077 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=4998
   [junit4]   2> 2460078 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540 
(1600727431545618432), 541 (1600727431545618433), 542 (1600727431545618434), 
543 (1600727431545618435), 544 (1600727431545618436), 545 
(1600727431545618437), 546 (1600727431545618438), 547 (1600727431545618439), 
548 (1600727431545618440), 549 (1600727431545618441), ... (20 adds)]} 0 0
   [junit4]   2> 2460079 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2460079 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6570c848 commitCommandVersion:0
   [junit4]   2> 2460081 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@35146823[collection1] realtime]
   [junit4]   2> 2460081 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2460128 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5049
   [junit4]   2> 2460129 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560 
(1600727431599095808), 561 (1600727431600144384), 562 (1600727431600144385), 
563 (1600727431600144386), 564 (1600727431600144387), 565 
(1600727431600144388), 566 (1600727431600144389), 567 (1600727431600144390), 
568 (1600727431600144391), 569 (1600727431600144392), ... (20 adds)]} 0 0
   [junit4]   2> 2460330 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5251
   [junit4]   2> 2460331 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580 
(1600727431810908160), 581 (1600727431810908161), 582 (1600727431810908162), 
583 (1600727431810908163), 584 (1600727431810908164), 585 
(1600727431810908165), 586 (1600727431810908166), 587 (1600727431810908167), 
588 (1600727431810908168), 589 (1600727431810908169), ... (20 adds)]} 0 0
   [junit4]   2> 2460533 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5454
   [junit4]   2> 2460534 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600 
(1600727432024817664), 601 (1600727432024817665), 602 (1600727432024817666), 
603 (1600727432024817667), 604 (1600727432024817668), 605 
(1600727432024817669), 606 (1600727432024817670), 607 (1600727432024817671), 
608 (1600727432024817672), 609 (1600727432024817673), ... (20 adds)]} 0 0
   [junit4]   2> 2460742 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5663
   [junit4]   2> 2460743 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620 
(1600727432242921472), 621 (1600727432242921473), 622 (1600727432242921474), 
623 (1600727432242921475), 624 (1600727432242921476), 625 
(1600727432242921477), 626 (1600727432242921478), 627 (1600727432242921479), 
628 (1600727432242921480), 629 (1600727432243970048), ... (20 adds)]} 0 0
   [junit4]   2> 2460951 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=5872
   [junit4]   2> 2460952 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640 
(1600727432462073856), 641 (1600727432463122432), 642 (1600727432463122433), 
643 (1600727432463122434), 644 (1600727432463122435), 645 
(1600727432463122436), 646 (1600727432463122437), 647 (1600727432463122438), 
648 (1600727432463122439), 649 (1600727432463122440), ... (20 adds)]} 0 0
   [junit4]   2> 2461155 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=6076
   [junit4]   2> 2461156 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660 
(1600727432675983360), 661 (1600727432677031936), 662 (1600727432677031937), 
663 (1600727432677031938), 664 (1600727432677031939), 665 
(1600727432677031940), 666 (1600727432677031941), 667 (1600727432677031942), 
668 (1600727432677031943), 669 (1600727432677031944), ... (20 adds)]} 0 0
   [junit4]   2> 2461362 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
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=6283
   [junit4]   2> 2461363 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A569C2CBB7547EDE]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680 
(1600727432893038592), 681 (1600727432894087168), 682 (1600727432894087169), 
683 (1600727432894087170), 684 (1600727432894087171), 685 
(1600727432894087172), 686 (1600727432894087173), 687 (1600727432894087174), 
688 (1600727432894087175), 689 (1600727432894087176), ... (20 adds)]} 0 0
   [junit4]   2> 2461364 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2461364 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6570c848 commitCommandVersion:0
   [junit4]   2> 2461368 INFO  (commitScheduler-4866-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searche

[...truncated too long message...]

te=[100 (-1600727476656406536)]} 0 5281
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1600727476656406537)]} 0 5281
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1600727476656406538)]} 0 5281
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1600727476656406539)]} 0 5281
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1600727476656406540)]} 0 5281
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1600727476656406541)]} 0 5281
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1600727476656406542)]} 0 5281
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testRedundantDeletes
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.c.CoreContainer Shutting down CoreContainer instance=744305351
   [junit4]   2> 2503098 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 2503099 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f88a7a4: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@56a8ee0b
   [junit4]   2> 2503099 INFO  (commitScheduler-4944-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2503099 INFO  (commitScheduler-4944-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@489fbf32 commitCommandVersion:0
   [junit4]   2> 2503099 INFO  (commitScheduler-4944-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@30767fda[collection1] realtime]
   [junit4]   2> 2503100 INFO  (commitScheduler-4944-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2503104 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 2503104 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6eb10d0d: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@77cce185
   [junit4]   2> 2503108 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 2503108 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A569C2CBB7547EDE]) [    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4431d8e5: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@4bff5841
   [junit4]   2> 2503109 INFO  (coreCloseExecutor-4946-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@44fa5c8a
   [junit4]   2> 2503109 INFO  (coreCloseExecutor-4946-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=44fa5c8a
   [junit4]   2> 2503109 INFO  (coreCloseExecutor-4946-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6d56e74f: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@53f62207
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.update.MaxSizeAutoCommitTest_A569C2CBB7547EDE-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{multiDefault=PostingsFormat(name=MockRandom), id=Lucene50(blocksize=128)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Memory), 
_version_=DocValuesFormat(name=Lucene70), 
range_facet_i_dv=DocValuesFormat(name=Lucene70), 
intDvoDefault=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=117, 
maxMBSortInHeap=7.1399248018109756, sim=RandomSimilarity(queryNorm=false): {}, 
locale=twq, timezone=Asia/Rangoon
   [junit4]   2> NOTE: Linux 4.13.0-39-generic amd64/Oracle Corporation 9.0.4 
(64-bit)/cpus=8,threads=1,free=155652584,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [SolrMetricsIntegrationTest, 
AnalysisErrorHandlingTest, TestClassicSimilarityFactory, TestReqParamsAPI, 
OutputWriterTest, ScheduledTriggerTest, CleanupOldIndexTest, 
TestHalfAndHalfDocValues, CdcrBootstrapTest, DistributedFacetExistsSmallTest, 
TestFileDictionaryLookup, TestCollationField, TestJsonRequest, 
HttpTriggerListenerTest, TestSolrQueryParser, TestMiniSolrCloudClusterSSL, 
TestConfigSets, HdfsDirectoryFactoryTest, HdfsThreadLeakTest, 
TestUseDocValuesAsStored2, AliasIntegrationTest, TestFieldCacheWithThreads, 
ShardRoutingTest, HdfsDirectoryTest, SuggestComponentTest, HdfsRecoveryZkTest, 
MetricsHandlerTest, TestInPlaceUpdatesDistrib, RequestHandlersTest, 
TestSerializedLuceneMatchVersion, DefaultValueUpdateProcessorTest, 
TestWordDelimiterFilterFactory, UtilsToolTest, FullSolrCloudDistribCmdsTest, 
TestManagedSchemaThreadSafety, BigEndianAscendingWordDeserializerTest, 
ManagedSchemaRoundRobinCloudTest, TestDocTermOrdsUninvertLimit, 
TestLMDirichletSimilarityFactory, MergeStrategyTest, TestStreamBody, 
DistributedQueryElevationComponentTest, SolrIndexSplitterTest, 
TestImpersonationWithHadoopAuth, TestReloadAndDeleteDocs, 
TestJsonFacetRefinement, TestMinMaxOnMultiValuedField, 
LeaderVoteWaitTimeoutTest, HdfsCollectionsAPIDistributedZkTest, TestJoin, 
DocExpirationUpdateProcessorFactoryTest, SuggesterWFSTTest, TestSort, 
TestCloudSearcherWarming, TestSolrDeletionPolicy1, ConfigSetsAPITest, 
CursorPagingTest, TestRandomFaceting, AutoAddReplicasIntegrationTest, 
NodeLostTriggerIntegrationTest, TestOmitPositions, RuleEngineTest, 
TestTriggerIntegration, SolrXmlInZkTest, SearchHandlerTest, 
HttpSolrCallGetCoreTest, TestGenericDistributedQueue, 
TestHttpShardHandlerFactory, BasicDistributedZkTest, TestDirectoryFactory, 
TestSubQueryTransformer, TestCollectionAPI, ZkCLITest, TokenizerChainTest, 
TestBulkSchemaAPI, ZkSolrClientTest, SolrCoreMetricManagerTest, 
TermVectorComponentDistributedTest, TestFastOutputStream, 
TestTolerantUpdateProcessorCloud, TestComputePlanAction, BJQParserTest, 
OverseerCollectionConfigSetProcessorTest, HighlighterConfigTest, 
DeleteNodeTest, TestCloudDeleteByQuery, BinaryUpdateRequestHandlerTest, 
TestHighlightDedupGrouping, TestMissingGroups, SpellingQueryConverterTest, 
SolrPluginUtilsTest, NodeMutatorTest, DirectUpdateHandlerTest, ZkFailoverTest, 
TemplateUpdateProcessorTest, StatsComponentTest, 
FieldAnalysisRequestHandlerTest, RestoreTriggerStateTest, TestFieldCacheSort, 
TestSolr4Spatial2, OpenCloseCoreStressTest, TestDistribIDF, 
TestSchemalessBufferedUpdates, TestSQLHandlerNonCloud, 
TestPerFieldSimilarityWithDefaultOverride, TestNumericRangeQuery32, 
TolerantUpdateProcessorTest, SolrCloudReportersTest, TestCloudManagedSchema, 
TestLocalFSCloudBackupRestore, TestDocBasedVersionConstraints, 
TestNestedDocsSort, JavabinLoaderTest, TestRetrieveFieldsOptimizer, 
SolrJmxReporterCloudTest, TestCSVResponseWriter, 
TestRuleBasedAuthorizationPlugin, TestExtendedDismaxParser, 
TestGeoJSONResponseWriter, MaxSizeAutoCommitTest]
   [junit4] Completed [721/805 (1!)] on J0 in 58.24s, 8 tests, 1 failure <<< 
FAILURES!

[...truncated 44041 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1920/consoleText

[repro] Revision: 922fd26859cd1e288c8e9ed0d1f22bf75306de90

[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC"
[repro] Repro line:  ant test  -Dtestcase=MaxSizeAutoCommitTest 
-Dtests.method=deleteTest -Dtests.seed=A569C2CBB7547EDE -Dtests.multiplier=3 
-Dtests.slow=true -Dtests.locale=twq -Dtests.timezone=Asia/Rangoon 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/core
[repro]       MaxSizeAutoCommitTest
[repro] ant compile-test

[...truncated 3321 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.MaxSizeAutoCommitTest" -Dtests.showOutput=onerror 
"-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC" -Dtests.seed=A569C2CBB7547EDE 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=twq 
-Dtests.timezone=Asia/Rangoon -Dtests.asserts=true -Dtests.file.encoding=UTF-8

[...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: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to