[JENKINS] Lucene-Solr-7.x-Linux (32bit/jdk1.8.0_172) - Build # 2052 - Unstable!

[Policeman Jenkins Server]

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2052/
Java: 32bit/jdk1.8.0_172 -client -XX:+UseConcMarkSweepGC

2 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/J2/temp/solr.update.MaxSizeAutoCommitTest_A970CFAFF1717FB9-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/J2/temp/solr.update.MaxSizeAutoCommitTest_A970CFAFF1717FB9-001/init-core-data-001/tlog/tlog.0000000000000000003,
 tlog size: 1302
        at 
__randomizedtesting.SeedInfo.seed([A970CFAFF1717FB9:B93E2A508ADF4648]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        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 
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.lang.Thread.run(Thread.java:748)


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/J2/temp/solr.update.MaxSizeAutoCommitTest_A970CFAFF1717FB9-001/init-core-data-001/tlog/tlog.0000000000000000003,
 tlog size: 1276

Stack Trace:
java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_A970CFAFF1717FB9-001/init-core-data-001/tlog/tlog.0000000000000000003,
 tlog size: 1276
        at 
__randomizedtesting.SeedInfo.seed([A970CFAFF1717FB9:B93E2A508ADF4648]: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 sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        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 
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.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 15334 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/J2/temp/solr.update.MaxSizeAutoCommitTest_A970CFAFF1717FB9-001/init-core-data-001
   [junit4]   2> 3204088 INFO  
(SUITE-MaxSizeAutoCommitTest-seed#[A970CFAFF1717FB9]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 3204090 INFO  
(SUITE-MaxSizeAutoCommitTest-seed#[A970CFAFF1717FB9]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 3204090 INFO  
(SUITE-MaxSizeAutoCommitTest-seed#[A970CFAFF1717FB9]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 3204093 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest 
{seed=[A970CFAFF1717FB9:B326A09911C358BB]}
   [junit4]   2> 3204093 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 3204094 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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> 3204132 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 3204172 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 3204302 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 3205455 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@197c92b
   [junit4]   2> 3205470 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@197c92b
   [junit4]   2> 3205470 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@197c92b
   [junit4]   2> 3205473 INFO  (coreLoadExecutor-12076-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 3205473 INFO  (coreLoadExecutor-12076-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> 3205503 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 3205519 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 3205654 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 3205669 INFO  (coreLoadExecutor-12076-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> 3205670 INFO  (coreLoadExecutor-12076-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@197c92b
   [junit4]   2> 3205670 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 3205670 INFO  (coreLoadExecutor-12076-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/J2/temp/solr.update.MaxSizeAutoCommitTest_A970CFAFF1717FB9-001/init-core-data-001/]
   [junit4]   2> 3205673 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 3205678 WARN  (coreLoadExecutor-12076-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> 3205730 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 3205730 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 3205736 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 3205736 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 3205739 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=32, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 3205740 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@83db8b[collection1] 
main]
   [junit4]   2> 3205740 WARN  (coreLoadExecutor-12076-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> 3205741 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 3205743 INFO  
(searcherExecutor-12077-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@83db8b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 3205743 INFO  (coreLoadExecutor-12076-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1602370489595985920
   [junit4]   2> 3205746 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 3205752 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1602370489600180224), 1 (1602370489603325952), 2 (1602370489603325953), 3 
(1602370489603325954), 4 (1602370489603325955), 5 (1602370489603325956), 6 
(1602370489603325957), 7 (1602370489604374528), 8 (1602370489604374529), 9 
(1602370489604374530), ... (20 adds)]} 0 5
   [junit4]   2> 3205954 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=206
   [junit4]   2> 3206008 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 
(1602370489870712832), 21 (1602370489870712833), 22 (1602370489871761408), 23 
(1602370489871761409), 24 (1602370489871761410), 25 (1602370489871761411), 26 
(1602370489871761412), 27 (1602370489871761413), 28 (1602370489872809984), 29 
(1602370489872809985), ... (20 adds)]} 0 3
   [junit4]   2> 3206209 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=462
   [junit4]   2> 3206213 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 
(1602370490085670912), 41 (1602370490085670913), 42 (1602370490085670914), 43 
(1602370490085670915), 44 (1602370490086719488), 45 (1602370490086719489), 46 
(1602370490086719490), 47 (1602370490086719491), 48 (1602370490086719492), 49 
(1602370490086719493), ... (20 adds)]} 0 4
   [junit4]   2> 3206414 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=667
   [junit4]   2> 3206418 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 
(1602370490300628992), 61 (1602370490300628993), 62 (1602370490300628994), 63 
(1602370490301677568), 64 (1602370490301677569), 65 (1602370490301677570), 66 
(1602370490301677571), 67 (1602370490301677572), 68 (1602370490301677573), 69 
(1602370490301677574), ... (20 adds)]} 0 3
   [junit4]   2> 3206619 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=871
   [junit4]   2> 3206622 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 
(1602370490514538496), 81 (1602370490515587072), 82 (1602370490515587073), 83 
(1602370490515587074), 84 (1602370490515587075), 85 (1602370490515587076), 86 
(1602370490515587077), 87 (1602370490515587078), 88 (1602370490515587079), 89 
(1602370490516635648), ... (20 adds)]} 0 2
   [junit4]   2> 3206823 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1075
   [junit4]   2> 3206826 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 
(1602370490728448000), 101 (1602370490728448001), 102 (1602370490728448002), 
103 (1602370490729496576), 104 (1602370490729496577), 105 
(1602370490729496578), 106 (1602370490729496579), 107 (1602370490729496580), 
108 (1602370490729496581), 109 (1602370490729496582), ... (20 adds)]} 0 2
   [junit4]   2> 3207027 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1280
   [junit4]   2> 3207032 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 
(1602370490942357504), 121 (1602370490943406080), 122 (1602370490943406081), 
123 (1602370490943406082), 124 (1602370490944454656), 125 
(1602370490944454657), 126 (1602370490944454658), 127 (1602370490944454659), 
128 (1602370490945503232), 129 (1602370490945503233), ... (20 adds)]} 0 5
   [junit4]   2> 3207033 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3207033 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1759a1e commitCommandVersion:0
   [junit4]   2> 3207042 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@326aed[collection1] realtime]
   [junit4]   2> 3207043 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3207083 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1336
   [junit4]   2> 3207088 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 
(1602370491001077760), 141 (1602370491003174912), 142 (1602370491003174913), 
143 (1602370491003174914), 144 (1602370491003174915), 145 
(1602370491003174916), 146 (1602370491004223488), 147 (1602370491004223489), 
148 (1602370491004223490), 149 (1602370491004223491), ... (20 adds)]} 0 5
   [junit4]   2> 3207289 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1542
   [junit4]   2> 3207293 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160 
(1602370491218132992), 161 (1602370491218132993), 162 (1602370491218132994), 
163 (1602370491218132995), 164 (1602370491218132996), 165 
(1602370491219181568), 166 (1602370491219181569), 167 (1602370491219181570), 
168 (1602370491219181571), 169 (1602370491219181572), ... (20 adds)]} 0 3
   [junit4]   2> 3207494 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1747
   [junit4]   2> 3207498 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180 
(1602370491432042496), 181 (1602370491433091072), 182 (1602370491433091073), 
183 (1602370491433091074), 184 (1602370491433091075), 185 
(1602370491433091076), 186 (1602370491434139648), 187 (1602370491434139649), 
188 (1602370491434139650), 189 (1602370491434139651), ... (20 adds)]} 0 3
   [junit4]   2> 3207699 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1952
   [junit4]   2> 3207703 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200 
(1602370491647000576), 201 (1602370491648049152), 202 (1602370491648049153), 
203 (1602370491648049154), 204 (1602370491648049155), 205 
(1602370491648049156), 206 (1602370491648049157), 207 (1602370491649097728), 
208 (1602370491649097729), 209 (1602370491649097730), ... (20 adds)]} 0 3
   [junit4]   2> 3207904 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2156
   [junit4]   2> 3207907 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220 
(1602370491861958656), 221 (1602370491861958657), 222 (1602370491863007232), 
223 (1602370491863007233), 224 (1602370491863007234), 225 
(1602370491863007235), 226 (1602370491863007236), 227 (1602370491863007237), 
228 (1602370491863007238), 229 (1602370491864055808), ... (20 adds)]} 0 3
   [junit4]   2> 3208108 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2361
   [junit4]   2> 3208112 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240 
(1602370492075868160), 241 (1602370492076916736), 242 (1602370492076916737), 
243 (1602370492076916738), 244 (1602370492076916739), 245 
(1602370492076916740), 246 (1602370492077965312), 247 (1602370492077965313), 
248 (1602370492077965314), 249 (1602370492077965315), ... (20 adds)]} 0 3
   [junit4]   2> 3208312 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2565
   [junit4]   2> 3208317 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260 
(1602370492290826240), 261 (1602370492291874816), 262 (1602370492291874817), 
263 (1602370492291874818), 264 (1602370492291874819), 265 
(1602370492291874820), 266 (1602370492291874821), 267 (1602370492292923392), 
268 (1602370492292923393), 269 (1602370492292923394), ... (20 adds)]} 0 4
   [junit4]   2> 3208317 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3208317 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1759a1e commitCommandVersion:0
   [junit4]   2> 3208323 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1bb5a4a[collection1] realtime]
   [junit4]   2> 3208324 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3208368 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2621
   [junit4]   2> 3208373 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280 
(1602370492349546496), 281 (1602370492350595072), 282 (1602370492350595073), 
283 (1602370492351643648), 284 (1602370492351643649), 285 
(1602370492351643650), 286 (1602370492351643651), 287 (1602370492351643652), 
288 (1602370492351643653), 289 (1602370492352692224), ... (20 adds)]} 0 5
   [junit4]   2> 3208574 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2827
   [junit4]   2> 3208578 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300 
(1602370492565553152), 301 (1602370492565553153), 302 (1602370492565553154), 
303 (1602370492565553155), 304 (1602370492565553156), 305 
(1602370492566601728), 306 (1602370492566601729), 307 (1602370492566601730), 
308 (1602370492566601731), 309 (1602370492566601732), ... (20 adds)]} 0 3
   [junit4]   2> 3208779 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3032
   [junit4]   2> 3208782 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320 
(1602370492779462656), 321 (1602370492780511232), 322 (1602370492780511233), 
323 (1602370492780511234), 324 (1602370492780511235), 325 
(1602370492780511236), 326 (1602370492780511237), 327 (1602370492780511238), 
328 (1602370492780511239), 329 (1602370492781559808), ... (20 adds)]} 0 2
   [junit4]   2> 3208984 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3237
   [junit4]   2> 3208988 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340 
(1602370492995469312), 341 (1602370492995469313), 342 (1602370492995469314), 
343 (1602370492996517888), 344 (1602370492996517889), 345 
(1602370492996517890), 346 (1602370492996517891), 347 (1602370492996517892), 
348 (1602370492996517893), 349 (1602370492996517894), ... (20 adds)]} 0 2
   [junit4]   2> 3209188 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3441
   [junit4]   2> 3209192 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360 
(1602370493209378816), 361 (1602370493209378817), 362 (1602370493209378818), 
363 (1602370493210427392), 364 (1602370493210427393), 365 
(1602370493210427394), 366 (1602370493210427395), 367 (1602370493210427396), 
368 (1602370493210427397), 369 (1602370493210427398), ... (20 adds)]} 0 2
   [junit4]   2> 3209392 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3645
   [junit4]   2> 3209396 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380 
(1602370493423288320), 381 (1602370493423288321), 382 (1602370493424336896), 
383 (1602370493424336897), 384 (1602370493424336898), 385 
(1602370493424336899), 386 (1602370493424336900), 387 (1602370493424336901), 
388 (1602370493424336902), 389 (1602370493424336903), ... (20 adds)]} 0 3
   [junit4]   2> 3209597 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3850
   [junit4]   2> 3209601 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400 
(1602370493638246400), 401 (1602370493638246401), 402 (1602370493638246402), 
403 (1602370493638246403), 404 (1602370493638246404), 405 
(1602370493639294976), 406 (1602370493639294977), 407 (1602370493639294978), 
408 (1602370493639294979), 409 (1602370493639294980), ... (20 adds)]} 0 3
   [junit4]   2> 3209601 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3209601 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1759a1e commitCommandVersion:0
   [junit4]   2> 3209607 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7fbbe5[collection1] realtime]
   [junit4]   2> 3209608 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3209651 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3904
   [junit4]   2> 3209656 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420 
(1602370493694869504), 421 (1602370493695918080), 422 (1602370493696966656), 
423 (1602370493696966657), 424 (1602370493696966658), 425 
(1602370493696966659), 426 (1602370493696966660), 427 (1602370493696966661), 
428 (1602370493698015232), 429 (1602370493698015233), ... (20 adds)]} 0 4
   [junit4]   2> 3209857 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4110
   [junit4]   2> 3209860 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440 
(1602370493910876160), 441 (1602370493910876161), 442 (1602370493910876162), 
443 (1602370493910876163), 444 (1602370493910876164), 445 
(1602370493911924736), 446 (1602370493911924737), 447 (1602370493911924738), 
448 (1602370493911924739), 449 (1602370493911924740), ... (20 adds)]} 0 2
   [junit4]   2> 3210061 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4314
   [junit4]   2> 3210064 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460 
(1602370494124785664), 461 (1602370494124785665), 462 (1602370494124785666), 
463 (1602370494124785667), 464 (1602370494124785668), 465 
(1602370494124785669), 466 (1602370494125834240), 467 (1602370494125834241), 
468 (1602370494125834242), 469 (1602370494125834243), ... (20 adds)]} 0 2
   [junit4]   2> 3210265 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4518
   [junit4]   2> 3210269 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480 
(1602370494338695168), 481 (1602370494338695169), 482 (1602370494338695170), 
483 (1602370494338695171), 484 (1602370494338695172), 485 
(1602370494338695173), 486 (1602370494339743744), 487 (1602370494339743745), 
488 (1602370494339743746), 489 (1602370494339743747), ... (20 adds)]} 0 3
   [junit4]   2> 3210470 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4722
   [junit4]   2> 3210472 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1602370494552604672), 501 (1602370494552604673), 502 (1602370494552604674), 
503 (1602370494553653248), 504 (1602370494553653249), 505 
(1602370494553653250), 506 (1602370494553653251), 507 (1602370494553653252), 
508 (1602370494553653253), 509 (1602370494553653254), ... (20 adds)]} 0 2
   [junit4]   2> 3210673 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4926
   [junit4]   2> 3210677 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520 
(1602370494766514176), 521 (1602370494766514177), 522 (1602370494766514178), 
523 (1602370494766514179), 524 (1602370494767562752), 525 
(1602370494767562753), 526 (1602370494767562754), 527 (1602370494767562755), 
528 (1602370494767562756), 529 (1602370494767562757), ... (20 adds)]} 0 2
   [junit4]   2> 3210878 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=5130
   [junit4]   2> 3210880 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540 
(1602370494980423680), 541 (1602370494980423681), 542 (1602370494980423682), 
543 (1602370494981472256), 544 (1602370494981472257), 545 
(1602370494981472258), 546 (1602370494981472259), 547 (1602370494981472260), 
548 (1602370494981472261), 549 (1602370494981472262), ... (20 adds)]} 0 2
   [junit4]   2> 3210881 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3210881 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1759a1e commitCommandVersion:0
   [junit4]   2> 3210885 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@d52ca8[collection1] realtime]
   [junit4]   2> 3210886 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3210931 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=5184
   [junit4]   2> 3210935 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560 
(1602370495035998208), 561 (1602370495038095360), 562 (1602370495038095361), 
563 (1602370495038095362), 564 (1602370495038095363), 565 
(1602370495038095364), 566 (1602370495038095365), 567 (1602370495038095366), 
568 (1602370495039143936), 569 (1602370495039143937), ... (20 adds)]} 0 3
   [junit4]   2> 3211136 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=5389
   [junit4]   2> 3211139 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580 
(1602370495250956288), 581 (1602370495252004864), 582 (1602370495252004865), 
583 (1602370495252004866), 584 (1602370495252004867), 585 
(1602370495252004868), 586 (1602370495252004869), 587 (1602370495252004870), 
588 (1602370495252004871), 589 (1602370495252004872), ... (20 adds)]} 0 2
   [junit4]   2> 3211340 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=5592
   [junit4]   2> 3211342 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600 
(1602370495464865792), 601 (1602370495464865793), 602 (1602370495464865794), 
603 (1602370495464865795), 604 (1602370495465914368), 605 
(1602370495465914369), 606 (1602370495465914370), 607 (1602370495465914371), 
608 (1602370495465914372), 609 (1602370495465914373), ... (20 adds)]} 0 2
   [junit4]   2> 3211543 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=5796
   [junit4]   2> 3211545 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620 
(1602370495677726720), 621 (1602370495678775296), 622 (1602370495678775297), 
623 (1602370495678775298), 624 (1602370495678775299), 625 
(1602370495678775300), 626 (1602370495678775301), 627 (1602370495678775302), 
628 (1602370495678775303), 629 (1602370495678775304), ... (20 adds)]} 0 1
   [junit4]   2> 3211746 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=5999
   [junit4]   2> 3211748 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640 
(1602370495890587648), 641 (1602370495891636224), 642 (1602370495891636225), 
643 (1602370495891636226), 644 (1602370495891636227), 645 
(1602370495891636228), 646 (1602370495891636229), 647 (1602370495891636230), 
648 (1602370495891636231), 649 (1602370495891636232), ... (20 adds)]} 0 2
   [junit4]   2> 3211949 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=6202
   [junit4]   2> 3211952 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660 
(1602370496104497152), 661 (1602370496104497153), 662 (1602370496104497154), 
663 (1602370496104497155), 664 (1602370496104497156), 665 
(1602370496104497157), 666 (1602370496104497158), 667 (1602370496105545728), 
668 (1602370496105545729), 669 (1602370496105545730), ... (20 adds)]} 0 2
   [junit4]   2> 3212153 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=6405
   [junit4]   2> 3212155 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680 
(1602370496317358080), 681 (1602370496317358081), 682 (1602370496317358082), 
683 (1602370496318406656), 684 (1602370496318406657), 685 
(1602370496318406658), 686 (1602370496318406659), 687 (1602370496318406660), 
688 (1602370496318406661), 689 (1602370496318406662), ... (20 adds)]} 0 2
   [junit4]   2> 3212156 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3212156 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1759a1e commitCommandVersion:0
   [junit4]   2> 3212161 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@119c7a4[collection1] realtime]
   [junit4]   2> 3212161 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3212206 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=6459
   [junit4]   2> 3212209 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[700 
(1602370496372932608), 701 (1602370496373981184), 702 (1602370496373981185), 
703 (1602370496375029760), 704 (1602370496375029761), 705 
(1602370496375029762), 706 (1602370496375029763), 707 (1602370496375029764), 
708 (1602370496375029765), 709 (1602370496375029766), ... (20 adds)]} 0 2
   [junit4]   2> 3212410 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=6663
   [junit4]   2> 3212412 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[720 
(1602370496586842112), 721 (1602370496586842113), 722 (1602370496586842114), 
723 (1602370496586842115), 724 (1602370496587890688), 725 
(1602370496587890689), 726 (1602370496587890690), 727 (1602370496587890691), 
728 (1602370496587890692), 729 (1602370496587890693), ... (20 adds)]} 0 1
   [junit4]   2> 3212613 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=6865
   [junit4]   2> 3212615 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[740 
(1602370496799703040), 741 (1602370496799703041), 742 (1602370496799703042), 
743 (1602370496799703043), 744 (1602370496799703044), 745 
(1602370496800751616), 746 (1602370496800751617), 747 (1602370496800751618), 
748 (1602370496800751619), 749 (1602370496800751620), ... (20 adds)]} 0 1
   [junit4]   2> 3212816 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=7068
   [junit4]   2> 3212818 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[760 
(1602370497012563968), 761 (1602370497012563969), 762 (1602370497012563970), 
763 (1602370497012563971), 764 (1602370497012563972), 765 
(1602370497012563973), 766 (1602370497013612544), 767 (1602370497013612545), 
768 (1602370497013612546), 769 (1602370497013612547), ... (20 adds)]} 0 2
   [junit4]   2> 3213019 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=7271
   [junit4]   2> 3213021 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[780 
(1602370497225424896), 781 (1602370497225424897), 782 (1602370497225424898), 
783 (1602370497225424899), 784 (1602370497225424900), 785 
(1602370497226473472), 786 (1602370497226473473), 787 (1602370497226473474), 
788 (1602370497226473475), 789 (1602370497226473476), ... (20 adds)]} 0 1
   [junit4]   2> 3213222 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=7474
   [junit4]   2> 3213224 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[800 
(1602370497438285824), 801 (1602370497438285825), 802 (1602370497438285826), 
803 (1602370497438285827), 804 (1602370497438285828), 805 
(1602370497438285829), 806 (1602370497439334400), 807 (1602370497439334401), 
808 (1602370497439334402), 809 (1602370497439334403), ... (20 adds)]} 0 1
   [junit4]   2> 3213424 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=7677
   [junit4]   2> 3213427 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[820 
(1602370497651146752), 821 (1602370497651146753), 822 (1602370497651146754), 
823 (1602370497651146755), 824 (1602370497651146756), 825 
(1602370497651146757), 826 (1602370497651146758), 827 (1602370497651146759), 
828 (1602370497652195328), 829 (1602370497652195329), ... (20 adds)]} 0 1
   [junit4]   2> 3213427 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3213427 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1759a1e commitCommandVersion:0
   [junit4]   2> 3213432 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d12bd3[collection1] realtime]
   [junit4]   2> 3213432 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3213477 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=7730
   [junit4]   2> 3213480 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[840 
(1602370497706721280), 841 (1602370497707769856), 842 (1602370497707769857), 
843 (1602370497707769858), 844 (1602370497707769859), 845 
(1602370497707769860), 846 (1602370497707769861), 847 (1602370497707769862), 
848 (1602370497707769863), 849 (1602370497707769864), ... (20 adds)]} 0 2
   [junit4]   2> 3213681 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=7934
   [junit4]   2> 3213683 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[860 
(1602370497919582208), 861 (1602370497920630784), 862 (1602370497920630785), 
863 (1602370497920630786), 864 (1602370497920630787), 865 
(1602370497920630788), 866 (1602370497920630789), 867 (1602370497920630790), 
868 (1602370497920630791), 869 (1602370497920630792), ... (20 adds)]} 0 1
   [junit4]   2> 3213884 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=8137
   [junit4]   2> 3213886 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[880 
(1602370498132443136), 881 (1602370498132443137), 882 (1602370498133491712), 
883 (1602370498133491713), 884 (1602370498133491714), 885 
(1602370498133491715), 886 (1602370498133491716), 887 (1602370498133491717), 
888 (1602370498133491718), 889 (1602370498133491719), ... (20 adds)]} 0 1
   [junit4]   2> 3214087 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=8340
   [junit4]   2> 3214089 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[900 
(1602370498345304064), 901 (1602370498346352640), 902 (1602370498346352641), 
903 (1602370498346352642), 904 (1602370498346352643), 905 
(1602370498346352644), 906 (1602370498346352645), 907 (1602370498346352646), 
908 (1602370498346352647), 909 (1602370498346352648), ... (20 adds)]} 0 2
   [junit4]   2> 3214290 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=8543
   [junit4]   2> 3214293 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[920 
(1602370498559213568), 921 (1602370498559213569), 922 (1602370498559213570), 
923 (1602370498559213571), 924 (1602370498559213572), 925 
(1602370498560262144), 926 (1602370498560262145), 927 (1602370498560262146), 
928 (1602370498560262147), 929 (1602370498560262148), ... (20 adds)]} 0 2
   [junit4]   2> 3214494 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=8747
   [junit4]   2> 3214496 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[940 
(1602370498773123072), 941 (1602370498773123073), 942 (1602370498773123074), 
943 (1602370498773123075), 944 (1602370498773123076), 945 
(1602370498773123077), 946 (1602370498773123078), 947 (1602370498773123079), 
948 (1602370498773123080), 949 (1602370498773123081), ... (20 adds)]} 0 2
   [junit4]   2> 3214697 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=8950
   [junit4]   2> 3214700 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[960 
(1602370498985984000), 961 (1602370498985984001), 962 (1602370498985984002), 
963 (1602370498985984003), 964 (1602370498985984004), 965 
(1602370498985984005), 966 (1602370498985984006), 967 (1602370498985984007), 
968 (1602370498987032576), 969 (1602370498987032577), ... (20 adds)]} 0 2
   [junit4]   2> 3214700 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3214700 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1759a1e commitCommandVersion:0
   [junit4]   2> 3214706 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b97333[collection1] realtime]
   [junit4]   2> 3214707 INFO  (commitScheduler-12080-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3214750 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=9003
   [junit4]   2> 3214754 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[980 
(1602370499041558528), 981 (1602370499042607104), 982 (1602370499042607105), 
983 (1602370499042607106), 984 (1602370499042607107), 985 
(1602370499042607108), 986 (1602370499042607109), 987 (1602370499043655680), 
988 (1602370499043655681), 989 (1602370499043655682), ... (20 adds)]} 0 3
   [junit4]   2> 3214955 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=9207
   [junit4]   2> 3214955 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3214955 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1759a1e commitCommandVersion:0
   [junit4]   2> 3214959 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@14ddaa5[collection1] main]
   [junit4]   2> 3214960 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3214963 INFO  (searcherExecutor-12077-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@14ddaa5[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> 3215014 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=9266
   [junit4]   2> 3215018 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending endToEndTest 
{seed=[A970CFAFF1717FB9:B326A09911C358BB]}
   [junit4]   2> 3215018 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 3215018 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=10281855
   [junit4]   2> 3215019 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 3215019 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f89e3d: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@aba577
   [junit4]   2> 3215026 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 3215026 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@175e3da: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@18bc837
   [junit4]   2> 3215030 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 3215030 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@40be89: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@d7cd58
   [junit4]   2> 3215031 INFO  (coreCloseExecutor-12082-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@efd443
   [junit4]   2> 3215031 INFO  (coreCloseExecutor-12082-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=efd443
   [junit4]   2> 3215032 INFO  (coreCloseExecutor-12082-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@17eb60e: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@250024
   [junit4]   2> 3215058 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting endToEndTest 
{seed=[A970CFAFF1717FB9:7701C6525019397]}
   [junit4]   2> 3215059 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 3215059 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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> 3215089 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 3215103 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 3215213 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 3215719 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@197c92b
   [junit4]   2> 3215730 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@197c92b
   [junit4]   2> 3215730 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@197c92b
   [junit4]   2> 3215742 INFO  (coreLoadExecutor-12090-thread-1) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 3215742 INFO  (coreLoadExecutor-12090-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> 3215778 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
   [junit4]   2> 3215795 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 3215911 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 3215922 INFO  (coreLoadExecutor-12090-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> 3215922 INFO  (coreLoadExecutor-12090-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@197c92b
   [junit4]   2> 3215922 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 3215922 INFO  (coreLoadExecutor-12090-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/J2/temp/solr.update.MaxSizeAutoCommitTest_A970CFAFF1717FB9-001/init-core-data-001/]
   [junit4]   2> 3215924 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 3215928 WARN  (coreLoadExecutor-12090-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> 3215971 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 3215971 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 3215972 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 3215972 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 3215973 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=32, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 3215974 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@db41ef[collection1] 
main]
   [junit4]   2> 3215974 WARN  (coreLoadExecutor-12090-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> 3215975 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 3215976 INFO  
(searcherExecutor-12091-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@db41ef[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 3215976 INFO  (coreLoadExecutor-12090-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1602370500326064128
   [junit4]   2> 3215979 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 3215985 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1602370500330258432), 1 (1602370500333404160), 2 (1602370500334452736), 3 
(1602370500334452737), 4 (1602370500334452738), 5 (1602370500334452739), 6 
(1602370500334452740), 7 (1602370500334452741), 8 (1602370500334452742), 9 
(1602370500334452743), ... (20 adds)]} 0 5
   [junit4]   2> 3216186 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=206
   [junit4]   2> 3216189 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 
(1602370500547313664), 21 (1602370500547313665), 22 (1602370500548362240), 23 
(1602370500548362241), 24 (1602370500548362242), 25 (1602370500548362243), 26 
(1602370500548362244), 27 (1602370500548362245), 28 (1602370500548362246), 29 
(1602370500548362247), ... (20 adds)]} 0 2
   [junit4]   2> 3216390 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=410
   [junit4]   2> 3216393 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 
(1602370500761223168), 41 (1602370500761223169), 42 (1602370500761223170), 43 
(1602370500761223171), 44 (1602370500761223172), 45 (1602370500761223173), 46 
(1602370500761223174), 47 (1602370500761223175), 48 (1602370500761223176), 49 
(1602370500762271744), ... (20 adds)]} 0 2
   [junit4]   2> 3216594 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=613
   [junit4]   2> 3216596 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 
(1602370500974084096), 61 (1602370500974084097), 62 (1602370500974084098), 63 
(1602370500974084099), 64 (1602370500974084100), 65 (1602370500974084101), 66 
(1602370500975132672), 67 (1602370500975132673), 68 (1602370500975132674), 69 
(1602370500975132675), ... (20 adds)]} 0 1
   [junit4]   2> 3216797 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=816
   [junit4]   2> 3216799 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 
(1602370501186945024), 81 (1602370501186945025), 82 (1602370501186945026), 83 
(1602370501186945027), 84 (1602370501186945028), 85 (1602370501186945029), 86 
(1602370501186945030), 87 (1602370501187993600), 88 (1602370501187993601), 89 
(1602370501187993602), ... (20 adds)]} 0 1
   [junit4]   2> 3217000 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1019
   [junit4]   2> 3217001 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 
(1602370501399805952), 101 (1602370501399805953), 102 (1602370501399805954), 
103 (1602370501399805955), 104 (1602370501399805956), 105 
(1602370501399805957), 106 (1602370501399805958), 107 (1602370501399805959), 
108 (1602370501400854528), 109 (1602370501400854529), ... (20 adds)]} 0 1
   [junit4]   2> 3217202 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1222
   [junit4]   2> 3217204 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 
(1602370501612666880), 121 (1602370501612666881), 122 (1602370501612666882), 
123 (1602370501612666883), 124 (1602370501612666884), 125 
(1602370501612666885), 126 (1602370501612666886), 127 (1602370501612666887), 
128 (1602370501612666888), 129 (1602370501612666889), ... (20 adds)]} 0 1
   [junit4]   2> 3217205 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3217205 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3946d0 commitCommandVersion:0
   [junit4]   2> 3217210 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1601d07[collection1] realtime]
   [junit4]   2> 3217210 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3217255 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1275
   [junit4]   2> 3217258 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 
(1602370501667192832), 141 (1602370501668241408), 142 (1602370501668241409), 
143 (1602370501668241410), 144 (1602370501668241411), 145 
(1602370501669289984), 146 (1602370501669289985), 147 (1602370501669289986), 
148 (1602370501669289987), 149 (1602370501669289988), ... (20 adds)]} 0 2
   [junit4]   2> 3217459 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1479
   [junit4]   2> 3217461 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160 
(1602370501881102336), 161 (1602370501881102337), 162 (1602370501881102338), 
163 (1602370501881102339), 164 (1602370501882150912), 165 
(1602370501882150913), 166 (1602370501882150914), 167 (1602370501882150915), 
168 (1602370501882150916), 169 (1602370501882150917), ... (20 adds)]} 0 1
   [junit4]   2> 3217662 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1681
   [junit4]   2> 3217664 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180 
(1602370502093963264), 181 (1602370502093963265), 182 (1602370502093963266), 
183 (1602370502095011840), 184 (1602370502095011841), 185 
(1602370502095011842), 186 (1602370502095011843), 187 (1602370502095011844), 
188 (1602370502095011845), 189 (1602370502095011846), ... (20 adds)]} 0 1
   [junit4]   2> 3217865 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=1884
   [junit4]   2> 3217866 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200 
(1602370502306824192), 201 (1602370502306824193), 202 (1602370502306824194), 
203 (1602370502306824195), 204 (1602370502306824196), 205 
(1602370502306824197), 206 (1602370502306824198), 207 (1602370502306824199), 
208 (1602370502306824200), 209 (1602370502306824201), ... (20 adds)]} 0 1
   [junit4]   2> 3218067 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2087
   [junit4]   2> 3218068 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220 
(1602370502518636544), 221 (1602370502519685120), 222 (1602370502519685121), 
223 (1602370502519685122), 224 (1602370502519685123), 225 
(1602370502519685124), 226 (1602370502519685125), 227 (1602370502519685126), 
228 (1602370502519685127), 229 (1602370502519685128), ... (20 adds)]} 0 1
   [junit4]   2> 3218271 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2290
   [junit4]   2> 3218272 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240 
(1602370502732546048), 241 (1602370502732546049), 242 (1602370502732546050), 
243 (1602370502732546051), 244 (1602370502732546052), 245 
(1602370502732546053), 246 (1602370502732546054), 247 (1602370502732546055), 
248 (1602370502732546056), 249 (1602370502732546057), ... (20 adds)]} 0 1
   [junit4]   2> 3218473 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2493
   [junit4]   2> 3218475 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260 
(1602370502944358400), 261 (1602370502945406976), 262 (1602370502945406977), 
263 (1602370502945406978), 264 (1602370502945406979), 265 
(1602370502945406980), 266 (1602370502945406981), 267 (1602370502945406982), 
268 (1602370502945406983), 269 (1602370502945406984), ... (20 adds)]} 0 1
   [junit4]   2> 3218476 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3218476 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3946d0 commitCommandVersion:0
   [junit4]   2> 3218481 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3b5161[collection1] realtime]
   [junit4]   2> 3218481 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3218526 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2545
   [junit4]   2> 3218529 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280 
(1602370502999932928), 281 (1602370503002030080), 282 (1602370503002030081), 
283 (1602370503002030082), 284 (1602370503002030083), 285 
(1602370503002030084), 286 (1602370503002030085), 287 (1602370503002030086), 
288 (1602370503002030087), 289 (1602370503003078656), ... (20 adds)]} 0 3
   [junit4]   2> 3218730 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2750
   [junit4]   2> 3218731 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300 
(1602370503213842432), 301 (1602370503214891008), 302 (1602370503214891009), 
303 (1602370503214891010), 304 (1602370503214891011), 305 
(1602370503214891012), 306 (1602370503214891013), 307 (1602370503214891014), 
308 (1602370503214891015), 309 (1602370503214891016), ... (20 adds)]} 0 1
   [junit4]   2> 3218933 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=2953
   [junit4]   2> 3218935 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320 
(1602370503426703360), 321 (1602370503427751936), 322 (1602370503427751937), 
323 (1602370503427751938), 324 (1602370503427751939), 325 
(1602370503427751940), 326 (1602370503427751941), 327 (1602370503427751942), 
328 (1602370503427751943), 329 (1602370503427751944), ... (20 adds)]} 0 1
   [junit4]   2> 3219136 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3155
   [junit4]   2> 3219137 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340 
(1602370503639564288), 341 (1602370503639564289), 342 (1602370503639564290), 
343 (1602370503639564291), 344 (1602370503639564292), 345 
(1602370503639564293), 346 (1602370503639564294), 347 (1602370503639564295), 
348 (1602370503639564296), 349 (1602370503639564297), ... (20 adds)]} 0 1
   [junit4]   2> 3219338 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3358
   [junit4]   2> 3219339 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360 
(1602370503851376640), 361 (1602370503851376641), 362 (1602370503851376642), 
363 (1602370503851376643), 364 (1602370503851376644), 365 
(1602370503852425216), 366 (1602370503852425217), 367 (1602370503852425218), 
368 (1602370503852425219), 369 (1602370503852425220), ... (20 adds)]} 0 1
   [junit4]   2> 3219540 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3560
   [junit4]   2> 3219542 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380 
(1602370504064237568), 381 (1602370504064237569), 382 (1602370504064237570), 
383 (1602370504064237571), 384 (1602370504064237572), 385 
(1602370504064237573), 386 (1602370504064237574), 387 (1602370504064237575), 
388 (1602370504064237576), 389 (1602370504064237577), ... (20 adds)]} 0 1
   [junit4]   2> 3219743 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3763
   [junit4]   2> 3219744 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400 
(1602370504276049920), 401 (1602370504276049921), 402 (1602370504276049922), 
403 (1602370504276049923), 404 (1602370504276049924), 405 
(1602370504277098496), 406 (1602370504277098497), 407 (1602370504277098498), 
408 (1602370504277098499), 409 (1602370504277098500), ... (20 adds)]} 0 1
   [junit4]   2> 3219745 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3219745 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3946d0 commitCommandVersion:0
   [junit4]   2> 3219749 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1fdf475[collection1] realtime]
   [junit4]   2> 3219749 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3219795 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=3815
   [junit4]   2> 3219798 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420 
(1602370504330575872), 421 (1602370504332673024), 422 (1602370504332673025), 
423 (1602370504332673026), 424 (1602370504332673027), 425 
(1602370504332673028), 426 (1602370504332673029), 427 (1602370504332673030), 
428 (1602370504332673031), 429 (1602370504332673032), ... (20 adds)]} 0 2
   [junit4]   2> 3219999 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4018
   [junit4]   2> 3220000 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440 
(1602370504544485376), 441 (1602370504544485377), 442 (1602370504544485378), 
443 (1602370504544485379), 444 (1602370504544485380), 445 
(1602370504544485381), 446 (1602370504544485382), 447 (1602370504544485383), 
448 (1602370504545533952), 449 (1602370504545533953), ... (20 adds)]} 0 1
   [junit4]   2> 3220201 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4221
   [junit4]   2> 3220202 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460 
(1602370504756297728), 461 (1602370504757346304), 462 (1602370504757346305), 
463 (1602370504757346306), 464 (1602370504757346307), 465 
(1602370504757346308), 466 (1602370504757346309), 467 (1602370504757346310), 
468 (1602370504757346311), 469 (1602370504757346312), ... (20 adds)]} 0 1
   [junit4]   2> 3220403 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4423
   [junit4]   2> 3220404 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480 
(1602370504969158656), 481 (1602370504969158657), 482 (1602370504969158658), 
483 (1602370504969158659), 484 (1602370504969158660), 485 
(1602370504969158661), 486 (1602370504969158662), 487 (1602370504969158663), 
488 (1602370504969158664), 489 (1602370504969158665), ... (20 adds)]} 0 0
   [junit4]   2> 3220605 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4625
   [junit4]   2> 3220606 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1602370505179922432), 501 (1602370505180971008), 502 (1602370505180971009), 
503 (1602370505180971010), 504 (1602370505180971011), 505 
(1602370505180971012), 506 (1602370505180971013), 507 (1602370505180971014), 
508 (1602370505180971015), 509 (1602370505180971016), ... (20 adds)]} 0 0
   [junit4]   2> 3220807 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=4827
   [junit4]   2> 3220808 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520 
(1602370505391734784), 521 (1602370505391734785), 522 (1602370505392783360), 
523 (1602370505392783361), 524 (1602370505392783362), 525 
(1602370505392783363), 526 (1602370505392783364), 527 (1602370505392783365), 
528 (1602370505392783366), 529 (1602370505392783367), ... (20 adds)]} 0 0
   [junit4]   2> 3221009 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=5029
   [junit4]   2> 3221011 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540 
(1602370505603547136), 541 (1602370505604595712), 542 (1602370505604595713), 
543 (1602370505604595714), 544 (1602370505604595715), 545 
(1602370505604595716), 546 (1602370505604595717), 547 (1602370505604595718), 
548 (1602370505604595719), 549 (1602370505604595720), ... (20 adds)]} 0 1
   [junit4]   2> 3221011 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 3221011 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3946d0 commitCommandVersion:0
   [junit4]   2> 3221015 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@18629b8[collection1] realtime]
   [junit4]   2> 3221015 INFO  (commitScheduler-12094-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 3221061 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
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=5081
   [junit4]   2> 3221064 INFO  
(TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A970CFAFF1717FB9]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560 
(1602370505659121664), 561 (1602370505660170240), 562 (1602370505660170241), 
563 (1602370505660170242), 564 (1602370505660170243), 565 
(1602370505660170244), 566 (1602370505660170245), 567 (1602370505661218816), 
568 (1602370505661218817), 569 (1602370505661218818), ... (20 adds)]} 0 2
   [junit4]   2> 3221265 INFO  (TEST-MaxSizeAutoCom

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

    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496699756574)]} 0 6080
   [junit4]   2> 149156 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496699756575)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805120)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805121)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805122)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805123)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805124)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805125)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805126)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805127)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805128)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805129)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805130)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805131)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805132)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805133)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805134)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805135)]} 0 6081
   [junit4]   2> 149157 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[100 
(-1602371496700805136)]} 0 6081
   [junit4]   2> 149158 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testRedundantDeletes
   [junit4]   2> 149158 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 149158 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.c.CoreContainer Shutting down CoreContainer instance=29120949
   [junit4]   2> 149158 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 149158 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f3bf33: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ com.codahale.metrics.MetricRegistry@7c72af
   [junit4]   2> 149158 INFO  (commitScheduler-221-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 149158 INFO  (commitScheduler-221-thread-1) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@a8a781 commitCommandVersion:0
   [junit4]   2> 149159 INFO  (commitScheduler-221-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1103f2[collection1] realtime]
   [junit4]   2> 149159 INFO  (commitScheduler-221-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 149165 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 149165 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1ddf54f: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
com.codahale.metrics.MetricRegistry@63d4e1
   [junit4]   2> 149165 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 149165 INFO  
(TEST-MaxSizeAutoCommitTest.testRedundantDeletes-seed#[A970CFAFF1717FB9]) [    
] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1995272: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / com.codahale.metrics.MetricRegistry@18c4f5d
   [junit4]   2> 149166 INFO  (coreCloseExecutor-223-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@11e734
   [junit4]   2> 149166 INFO  (coreCloseExecutor-223-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=11e734
   [junit4]   2> 149166 INFO  (coreCloseExecutor-223-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1ae62d3: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4fed4f
   [junit4] OK      7.24s J2 | MaxSizeAutoCommitTest.testRedundantDeletes
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_A970CFAFF1717FB9-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=RandomSimilarity(queryNorm=false): {}, locale=es-VE, 
timezone=Antarctica/Casey
   [junit4]   2> NOTE: Linux 4.13.0-41-generic i386/Oracle Corporation 
1.8.0_172 (32-bit)/cpus=8,threads=1,free=10510664,total=39710720
   [junit4]   2> NOTE: All tests run in this JVM: [MaxSizeAutoCommitTest, 
MaxSizeAutoCommitTest]
   [junit4] Completed [5/5 (1!)] on J2 in 71.80s, 8 tests, 1 failure <<< 
FAILURES!

[...truncated 11 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1568: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092: 
There were test failures: 5 suites, 40 tests, 1 failure [seed: A970CFAFF1717FB9]

Total time: 2 minutes 31 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   1/5 failed: org.apache.solr.update.MaxSizeAutoCommitTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all 
warnings.
<Git Blamer> GIT_COMMIT=05cde8de3cf9f5e4162d1f2c031274ebe99daf51, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #2051
Recording test results
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org