You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/08/12 21:35:04 UTC
[JENKINS] Lucene-Solr-master-Linux (64bit/jdk-9.0.4) - Build #
22657 - Failure!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/22657/
Java: 64bit/jdk-9.0.4 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest
Error Message:
Tlog size exceeds the max size bound. Tlog path: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3C66F996AC542D1-001/init-core-data-001/tlog/tlog.0000000000000000002, tlog size: 1265
Stack Trace:
java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3C66F996AC542D1-001/init-core-data-001/tlog/tlog.0000000000000000002, tlog size: 1265
at __randomizedtesting.SeedInfo.seed([3C66F996AC542D1:13888A66116B7B20]: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:382)
at org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest(MaxSizeAutoCommitTest.java:202)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 15198 lines...]
[junit4] JVM J0: stdout was not empty, see: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/temp/junit4-J0-20180812_205800_92311964180906072912054.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] #
[junit4] # A fatal error has been detected by the Java Runtime Environment:
[junit4] #
[junit4] # SIGSEGV (0xb) at pc=0x00007fbf60da4dc9, pid=6925, tid=7034
[junit4] #
[junit4] # JRE version: Java(TM) SE Runtime Environment (9.0+11) (build 9.0.4+11)
[junit4] # Java VM: Java HotSpot(TM) 64-Bit Server VM (9.0.4+11, mixed mode, tiered, g1 gc, linux-amd64)
[junit4] # Problematic frame:
[junit4] # V [libjvm.so+0xc5adc9] PhaseIdealLoop::split_up(Node*, Node*, Node*) [clone .part.40]+0x619
[junit4] #
[junit4] # No core dump will be written. Core dumps have been disabled. To enable core dumping, try "ulimit -c unlimited" before starting Java again
[junit4] #
[junit4] # An error report file with more information is saved as:
[junit4] # /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/hs_err_pid6925.log
[junit4] [thread 25922 also had an error]
[junit4] # [ timer expired, abort... ]
[junit4] <<< JVM J0: EOF ----
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3C66F996AC542D1-001/init-core-data-001
[junit4] 2> 2143746 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2143763 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2143774 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 2143864 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2143992 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2143992 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2144002 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@757db4c4
[junit4] 2> 2144007 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@757db4c4
[junit4] 2> 2144007 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@757db4c4
[junit4] 2> 2144009 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2144025 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2144035 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2144121 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2144125 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2144125 INFO (coreLoadExecutor-10292-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@757db4c4
[junit4] 2> 2144126 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2144126 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3C66F996AC542D1-001/init-core-data-001/]
[junit4] 2> 2144126 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 2144127 WARN (coreLoadExecutor-10292-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> 2144148 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2144148 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2144177 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2144177 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2144178 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=73.3173828125, floorSegmentMB=1.6064453125, forceMergeDeletesPctAllowed=5.340000614952993, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6969336812489716, deletesPctAllowed=32.50513481288843
[junit4] 2> 2144178 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@675f8e09[collection1] main]
[junit4] 2> 2144179 WARN (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 2144179 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2144179 INFO (coreLoadExecutor-10292-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1608630534317015040
[junit4] 2> 2144180 INFO (searcherExecutor-10293-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@675f8e09[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2144186 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1608630534321209344), 1 (1608630534322257920), 2 (1608630534322257921), 3 (1608630534322257922), 4 (1608630534322257923), 5 (1608630534322257924), 6 (1608630534323306496), 7 (1608630534323306497), 8 (1608630534323306498), 9 (1608630534323306499), ... (20 adds)]} 0 3
[junit4] 2> 2144408 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=225
[junit4] 2> 2144434 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 (1608630534583353344), 21 (1608630534583353345), 22 (1608630534583353346), 23 (1608630534583353347), 24 (1608630534583353348), 25 (1608630534583353349), 26 (1608630534583353350), 27 (1608630534583353351), 28 (1608630534583353352), 29 (1608630534583353353), ... (20 adds)]} 0 1
[junit4] 2> 2144634 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=452
[junit4] 2> 2144637 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 (1608630534795165696), 41 (1608630534795165697), 42 (1608630534795165698), 43 (1608630534795165699), 44 (1608630534795165700), 45 (1608630534795165701), 46 (1608630534795165702), 47 (1608630534796214272), 48 (1608630534796214273), 49 (1608630534796214274), ... (20 adds)]} 0 2
[junit4] 2> 2144838 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=655
[junit4] 2> 2144839 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 (1608630535008026624), 61 (1608630535009075200), 62 (1608630535009075201), 63 (1608630535009075202), 64 (1608630535009075203), 65 (1608630535009075204), 66 (1608630535009075205), 67 (1608630535009075206), 68 (1608630535009075207), 69 (1608630535009075208), ... (20 adds)]} 0 1
[junit4] 2> 2145040 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=857
[junit4] 2> 2145041 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 (1608630535219838976), 81 (1608630535220887552), 82 (1608630535220887553), 83 (1608630535220887554), 84 (1608630535220887555), 85 (1608630535220887556), 86 (1608630535220887557), 87 (1608630535220887558), 88 (1608630535220887559), 89 (1608630535220887560), ... (20 adds)]} 0 1
[junit4] 2> 2145242 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1059
[junit4] 2> 2145243 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 (1608630535431651328), 101 (1608630535432699904), 102 (1608630535432699905), 103 (1608630535432699906), 104 (1608630535432699907), 105 (1608630535432699908), 106 (1608630535432699909), 107 (1608630535432699910), 108 (1608630535432699911), 109 (1608630535432699912), ... (20 adds)]} 0 1
[junit4] 2> 2145444 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1261
[junit4] 2> 2145446 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2145446 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 (1608630535643463680), 121 (1608630535643463681), 122 (1608630535643463682), 123 (1608630535643463683), 124 (1608630535643463684), 125 (1608630535643463685), 126 (1608630535643463686), 127 (1608630535644512256), 128 (1608630535644512257), 129 (1608630535644512258), ... (20 adds)]} 0 2
[junit4] 2> 2145446 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c4f168e commitCommandVersion:0
[junit4] 2> 2145455 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3fefe207[collection1] realtime]
[junit4] 2> 2145455 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2145496 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1314
[junit4] 2> 2145498 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 (1608630535699038208), 141 (1608630535699038209), 142 (1608630535700086784), 143 (1608630535700086785), 144 (1608630535700086786), 145 (1608630535700086787), 146 (1608630535700086788), 147 (1608630535700086789), 148 (1608630535700086790), 149 (1608630535700086791), ... (20 adds)]} 0 1
[junit4] 2> 2145699 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1516
[junit4] 2> 2145700 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160 (1608630535910850560), 161 (1608630535910850561), 162 (1608630535910850562), 163 (1608630535910850563), 164 (1608630535910850564), 165 (1608630535910850565), 166 (1608630535910850566), 167 (1608630535910850567), 168 (1608630535910850568), 169 (1608630535910850569), ... (20 adds)]} 0 0
[junit4] 2> 2145900 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1717
[junit4] 2> 2145901 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180 (1608630536122662912), 181 (1608630536122662913), 182 (1608630536122662914), 183 (1608630536122662915), 184 (1608630536122662916), 185 (1608630536122662917), 186 (1608630536122662918), 187 (1608630536122662919), 188 (1608630536122662920), 189 (1608630536122662921), ... (20 adds)]} 0 0
[junit4] 2> 2146102 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1919
[junit4] 2> 2146103 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200 (1608630536333426688), 201 (1608630536333426689), 202 (1608630536333426690), 203 (1608630536333426691), 204 (1608630536333426692), 205 (1608630536333426693), 206 (1608630536333426694), 207 (1608630536333426695), 208 (1608630536333426696), 209 (1608630536333426697), ... (20 adds)]} 0 0
[junit4] 2> 2146303 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2121
[junit4] 2> 2146304 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220 (1608630536545239040), 221 (1608630536545239041), 222 (1608630536545239042), 223 (1608630536545239043), 224 (1608630536545239044), 225 (1608630536545239045), 226 (1608630536545239046), 227 (1608630536545239047), 228 (1608630536545239048), 229 (1608630536545239049), ... (20 adds)]} 0 0
[junit4] 2> 2146505 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2322
[junit4] 2> 2146506 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240 (1608630536756002816), 241 (1608630536756002817), 242 (1608630536756002818), 243 (1608630536756002819), 244 (1608630536756002820), 245 (1608630536756002821), 246 (1608630536756002822), 247 (1608630536756002823), 248 (1608630536757051392), 249 (1608630536757051393), ... (20 adds)]} 0 0
[junit4] 2> 2146707 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2524
[junit4] 2> 2146708 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260 (1608630536967815168), 261 (1608630536967815169), 262 (1608630536967815170), 263 (1608630536967815171), 264 (1608630536967815172), 265 (1608630536967815173), 266 (1608630536967815174), 267 (1608630536967815175), 268 (1608630536967815176), 269 (1608630536967815177), ... (20 adds)]} 0 0
[junit4] 2> 2146709 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2146709 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c4f168e commitCommandVersion:0
[junit4] 2> 2146711 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@663c42c[collection1] realtime]
[junit4] 2> 2146711 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2146758 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2575
[junit4] 2> 2146760 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280 (1608630537021292544), 281 (1608630537022341120), 282 (1608630537022341121), 283 (1608630537022341122), 284 (1608630537022341123), 285 (1608630537022341124), 286 (1608630537022341125), 287 (1608630537022341126), 288 (1608630537022341127), 289 (1608630537022341128), ... (20 adds)]} 0 1
[junit4] 2> 2146960 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2778
[junit4] 2> 2146961 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300 (1608630537234153472), 301 (1608630537234153473), 302 (1608630537234153474), 303 (1608630537234153475), 304 (1608630537234153476), 305 (1608630537234153477), 306 (1608630537234153478), 307 (1608630537234153479), 308 (1608630537234153480), 309 (1608630537234153481), ... (20 adds)]} 0 0
[junit4] 2> 2147162 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2979
[junit4] 2> 2147163 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320 (1608630537444917248), 321 (1608630537444917249), 322 (1608630537444917250), 323 (1608630537444917251), 324 (1608630537444917252), 325 (1608630537444917253), 326 (1608630537444917254), 327 (1608630537444917255), 328 (1608630537444917256), 329 (1608630537444917257), ... (20 adds)]} 0 0
[junit4] 2> 2147363 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3180
[junit4] 2> 2147364 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340 (1608630537656729600), 341 (1608630537656729601), 342 (1608630537656729602), 343 (1608630537656729603), 344 (1608630537656729604), 345 (1608630537656729605), 346 (1608630537656729606), 347 (1608630537656729607), 348 (1608630537656729608), 349 (1608630537656729609), ... (20 adds)]} 0 0
[junit4] 2> 2147565 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3382
[junit4] 2> 2147566 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360 (1608630537867493376), 361 (1608630537867493377), 362 (1608630537867493378), 363 (1608630537867493379), 364 (1608630537867493380), 365 (1608630537867493381), 366 (1608630537867493382), 367 (1608630537867493383), 368 (1608630537867493384), 369 (1608630537867493385), ... (20 adds)]} 0 0
[junit4] 2> 2147766 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3584
[junit4] 2> 2147767 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380 (1608630538079305728), 381 (1608630538079305729), 382 (1608630538079305730), 383 (1608630538079305731), 384 (1608630538079305732), 385 (1608630538079305733), 386 (1608630538079305734), 387 (1608630538079305735), 388 (1608630538079305736), 389 (1608630538079305737), ... (20 adds)]} 0 0
[junit4] 2> 2147968 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3785
[junit4] 2> 2147969 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400 (1608630538290069504), 401 (1608630538291118080), 402 (1608630538291118081), 403 (1608630538291118082), 404 (1608630538291118083), 405 (1608630538291118084), 406 (1608630538291118085), 407 (1608630538291118086), 408 (1608630538291118087), 409 (1608630538291118088), ... (20 adds)]} 0 1
[junit4] 2> 2147970 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2147970 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c4f168e commitCommandVersion:0
[junit4] 2> 2147973 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7f95e19e[collection1] realtime]
[junit4] 2> 2147973 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2148020 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3837
[junit4] 2> 2148021 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420 (1608630538344595456), 421 (1608630538345644032), 422 (1608630538345644033), 423 (1608630538345644034), 424 (1608630538345644035), 425 (1608630538345644036), 426 (1608630538345644037), 427 (1608630538345644038), 428 (1608630538345644039), 429 (1608630538345644040), ... (20 adds)]} 0 1
[junit4] 2> 2148222 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4039
[junit4] 2> 2148223 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440 (1608630538556407808), 441 (1608630538556407809), 442 (1608630538556407810), 443 (1608630538556407811), 444 (1608630538557456384), 445 (1608630538557456385), 446 (1608630538557456386), 447 (1608630538557456387), 448 (1608630538557456388), 449 (1608630538557456389), ... (20 adds)]} 0 0
[junit4] 2> 2148424 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4241
[junit4] 2> 2148424 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460 (1608630538768220160), 461 (1608630538768220161), 462 (1608630538768220162), 463 (1608630538768220163), 464 (1608630538768220164), 465 (1608630538768220165), 466 (1608630538768220166), 467 (1608630538768220167), 468 (1608630538768220168), 469 (1608630538768220169), ... (20 adds)]} 0 0
[junit4] 2> 2148625 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4442
[junit4] 2> 2148626 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480 (1608630538978983936), 481 (1608630538978983937), 482 (1608630538978983938), 483 (1608630538978983939), 484 (1608630538980032512), 485 (1608630538980032513), 486 (1608630538980032514), 487 (1608630538980032515), 488 (1608630538980032516), 489 (1608630538980032517), ... (20 adds)]} 0 0
[junit4] 2> 2148827 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4644
[junit4] 2> 2148828 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1608630539190796288), 501 (1608630539190796289), 502 (1608630539190796290), 503 (1608630539190796291), 504 (1608630539190796292), 505 (1608630539190796293), 506 (1608630539190796294), 507 (1608630539190796295), 508 (1608630539190796296), 509 (1608630539190796297), ... (20 adds)]} 0 0
[junit4] 2> 2149028 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4845
[junit4] 2> 2149029 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520 (1608630539401560064), 521 (1608630539401560065), 522 (1608630539402608640), 523 (1608630539402608641), 524 (1608630539402608642), 525 (1608630539402608643), 526 (1608630539402608644), 527 (1608630539402608645), 528 (1608630539402608646), 529 (1608630539402608647), ... (20 adds)]} 0 0
[junit4] 2> 2149229 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5047
[junit4] 2> 2149230 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540 (1608630539613372416), 541 (1608630539613372417), 542 (1608630539613372418), 543 (1608630539613372419), 544 (1608630539613372420), 545 (1608630539613372421), 546 (1608630539613372422), 547 (1608630539613372423), 548 (1608630539613372424), 549 (1608630539613372425), ... (20 adds)]} 0 0
[junit4] 2> 2149231 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2149231 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c4f168e commitCommandVersion:0
[junit4] 2> 2149234 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1986c79f[collection1] realtime]
[junit4] 2> 2149234 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2149281 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5098
[junit4] 2> 2149282 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560 (1608630539666849792), 561 (1608630539666849793), 562 (1608630539666849794), 563 (1608630539666849795), 564 (1608630539666849796), 565 (1608630539666849797), 566 (1608630539666849798), 567 (1608630539666849799), 568 (1608630539666849800), 569 (1608630539666849801), ... (20 adds)]} 0 0
[junit4] 2> 2149482 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5300
[junit4] 2> 2149483 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580 (1608630539878662144), 581 (1608630539878662145), 582 (1608630539878662146), 583 (1608630539878662147), 584 (1608630539878662148), 585 (1608630539878662149), 586 (1608630539878662150), 587 (1608630539878662151), 588 (1608630539878662152), 589 (1608630539878662153), ... (20 adds)]} 0 0
[junit4] 2> 2149684 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5501
[junit4] 2> 2149685 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600 (1608630540089425920), 601 (1608630540089425921), 602 (1608630540089425922), 603 (1608630540089425923), 604 (1608630540089425924), 605 (1608630540089425925), 606 (1608630540089425926), 607 (1608630540089425927), 608 (1608630540089425928), 609 (1608630540089425929), ... (20 adds)]} 0 0
[junit4] 2> 2149885 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5703
[junit4] 2> 2149886 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620 (1608630540301238272), 621 (1608630540301238273), 622 (1608630540301238274), 623 (1608630540301238275), 624 (1608630540301238276), 625 (1608630540301238277), 626 (1608630540301238278), 627 (1608630540301238279), 628 (1608630540301238280), 629 (1608630540301238281), ... (20 adds)]} 0 0
[junit4] 2> 2150087 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5904
[junit4] 2> 2150088 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640 (1608630540512002048), 641 (1608630540512002049), 642 (1608630540512002050), 643 (1608630540512002051), 644 (1608630540512002052), 645 (1608630540512002053), 646 (1608630540512002054), 647 (1608630540512002055), 648 (1608630540512002056), 649 (1608630540512002057), ... (20 adds)]} 0 0
[junit4] 2> 2150288 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6106
[junit4] 2> 2150289 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660 (1608630540723814400), 661 (1608630540723814401), 662 (1608630540723814402), 663 (1608630540723814403), 664 (1608630540723814404), 665 (1608630540723814405), 666 (1608630540723814406), 667 (1608630540723814407), 668 (1608630540723814408), 669 (1608630540723814409), ... (20 adds)]} 0 0
[junit4] 2> 2150490 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6307
[junit4] 2> 2150491 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680 (1608630540934578176), 681 (1608630540934578177), 682 (1608630540934578178), 683 (1608630540934578179), 684 (1608630540934578180), 685 (1608630540934578181), 686 (1608630540935626752), 687 (1608630540935626753), 688 (1608630540935626754), 689 (1608630540935626755), ... (20 adds)]} 0 0
[junit4] 2> 2150492 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2150492 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c4f168e commitCommandVersion:0
[junit4] 2> 2150494 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3d79899b[collection1] realtime]
[junit4] 2> 2150494 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2150541 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6359
[junit4] 2> 2150543 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[700 (1608630540989104128), 701 (1608630540990152704), 702 (1608630540990152705), 703 (1608630540990152706), 704 (1608630540990152707), 705 (1608630540990152708), 706 (1608630540990152709), 707 (1608630540990152710), 708 (1608630540990152711), 709 (1608630540990152712), ... (20 adds)]} 0 1
[junit4] 2> 2150744 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6561
[junit4] 2> 2150745 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[720 (1608630541200916480), 721 (1608630541200916481), 722 (1608630541200916482), 723 (1608630541200916483), 724 (1608630541200916484), 725 (1608630541200916485), 726 (1608630541200916486), 727 (1608630541200916487), 728 (1608630541200916488), 729 (1608630541200916489), ... (20 adds)]} 0 0
[junit4] 2> 2150945 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6763
[junit4] 2> 2150946 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[740 (1608630541412728832), 741 (1608630541412728833), 742 (1608630541412728834), 743 (1608630541412728835), 744 (1608630541412728836), 745 (1608630541412728837), 746 (1608630541412728838), 747 (1608630541412728839), 748 (1608630541412728840), 749 (1608630541412728841), ... (20 adds)]} 0 0
[junit4] 2> 2151147 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6964
[junit4] 2> 2151148 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[760 (1608630541623492608), 761 (1608630541623492609), 762 (1608630541623492610), 763 (1608630541623492611), 764 (1608630541623492612), 765 (1608630541623492613), 766 (1608630541624541184), 767 (1608630541624541185), 768 (1608630541624541186), 769 (1608630541624541187), ... (20 adds)]} 0 0
[junit4] 2> 2151349 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7166
[junit4] 2> 2151349 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[780 (1608630541835304960), 781 (1608630541835304961), 782 (1608630541835304962), 783 (1608630541835304963), 784 (1608630541835304964), 785 (1608630541835304965), 786 (1608630541835304966), 787 (1608630541835304967), 788 (1608630541835304968), 789 (1608630541835304969), ... (20 adds)]} 0 0
[junit4] 2> 2151550 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7367
[junit4] 2> 2151551 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[800 (1608630542046068736), 801 (1608630542046068737), 802 (1608630542046068738), 803 (1608630542046068739), 804 (1608630542046068740), 805 (1608630542046068741), 806 (1608630542047117312), 807 (1608630542047117313), 808 (1608630542047117314), 809 (1608630542047117315), ... (20 adds)]} 0 0
[junit4] 2> 2151752 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7569
[junit4] 2> 2151752 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[820 (1608630542257881088), 821 (1608630542257881089), 822 (1608630542257881090), 823 (1608630542257881091), 824 (1608630542257881092), 825 (1608630542257881093), 826 (1608630542257881094), 827 (1608630542257881095), 828 (1608630542257881096), 829 (1608630542257881097), ... (20 adds)]} 0 0
[junit4] 2> 2151753 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2151753 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c4f168e commitCommandVersion:0
[junit4] 2> 2151755 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@56be9ef3[collection1] realtime]
[junit4] 2> 2151755 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2151803 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7620
[junit4] 2> 2151804 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[840 (1608630542311358464), 841 (1608630542312407040), 842 (1608630542312407041), 843 (1608630542312407042), 844 (1608630542312407043), 845 (1608630542312407044), 846 (1608630542312407045), 847 (1608630542312407046), 848 (1608630542312407047), 849 (1608630542312407048), ... (20 adds)]} 0 1
[junit4] 2> 2152005 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7822
[junit4] 2> 2152006 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[860 (1608630542524219392), 861 (1608630542524219393), 862 (1608630542524219394), 863 (1608630542524219395), 864 (1608630542524219396), 865 (1608630542524219397), 866 (1608630542524219398), 867 (1608630542524219399), 868 (1608630542524219400), 869 (1608630542524219401), ... (20 adds)]} 0 0
[junit4] 2> 2152207 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8024
[junit4] 2> 2152208 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[880 (1608630542734983168), 881 (1608630542734983169), 882 (1608630542734983170), 883 (1608630542736031744), 884 (1608630542736031745), 885 (1608630542736031746), 886 (1608630542736031747), 887 (1608630542736031748), 888 (1608630542736031749), 889 (1608630542736031750), ... (20 adds)]} 0 0
[junit4] 2> 2152409 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8226
[junit4] 2> 2152409 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[900 (1608630542946795520), 901 (1608630542946795521), 902 (1608630542946795522), 903 (1608630542946795523), 904 (1608630542946795524), 905 (1608630542946795525), 906 (1608630542946795526), 907 (1608630542946795527), 908 (1608630542946795528), 909 (1608630542946795529), ... (20 adds)]} 0 0
[junit4] 2> 2152610 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8427
[junit4] 2> 2152611 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[920 (1608630543157559296), 921 (1608630543157559297), 922 (1608630543157559298), 923 (1608630543157559299), 924 (1608630543157559300), 925 (1608630543158607872), 926 (1608630543158607873), 927 (1608630543158607874), 928 (1608630543158607875), 929 (1608630543158607876), ... (20 adds)]} 0 0
[junit4] 2> 2152811 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8629
[junit4] 2> 2152812 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[940 (1608630543369371648), 941 (1608630543369371649), 942 (1608630543369371650), 943 (1608630543369371651), 944 (1608630543369371652), 945 (1608630543369371653), 946 (1608630543369371654), 947 (1608630543369371655), 948 (1608630543369371656), 949 (1608630543369371657), ... (20 adds)]} 0 0
[junit4] 2> 2153013 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8830
[junit4] 2> 2153014 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[960 (1608630543580135424), 961 (1608630543580135425), 962 (1608630543580135426), 963 (1608630543580135427), 964 (1608630543580135428), 965 (1608630543580135429), 966 (1608630543580135430), 967 (1608630543580135431), 968 (1608630543580135432), 969 (1608630543580135433), ... (20 adds)]} 0 0
[junit4] 2> 2153015 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2153015 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c4f168e commitCommandVersion:0
[junit4] 2> 2153016 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@28b34554[collection1] realtime]
[junit4] 2> 2153017 INFO (commitScheduler-10296-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2153064 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8881
[junit4] 2> 2153065 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[980 (1608630543633612800), 981 (1608630543634661376), 982 (1608630543634661377), 983 (1608630543634661378), 984 (1608630543634661379), 985 (1608630543634661380), 986 (1608630543634661381), 987 (1608630543634661382), 988 (1608630543634661383), 989 (1608630543634661384), ... (20 adds)]} 0 1
[junit4] 2> 2153266 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=9083
[junit4] 2> 2153266 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2153266 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5c4f168e commitCommandVersion:0
[junit4] 2> 2153268 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5f81ae62[collection1] main]
[junit4] 2> 2153268 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2153269 INFO (searcherExecutor-10293-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5f81ae62[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C140) Uninverting(_1(8.0.0):C140) Uninverting(_2(8.0.0):C140) Uninverting(_3(8.0.0):C140) Uninverting(_4(8.0.0):C140) Uninverting(_5(8.0.0):C140) Uninverting(_6(8.0.0):C140) Uninverting(_7(8.0.0):C20)))}
[junit4] 2> 2153319 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] 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=9137
[junit4] 2> 2153322 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1496305822
[junit4] 2> 2153322 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 2153322 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@c0f2a7b: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@61415d90
[junit4] 2> 2153326 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 2153326 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@13977cd2: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@3a26a826
[junit4] 2> 2153328 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 2153328 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2c2869aa: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@66f49570
[junit4] 2> 2153329 INFO (coreCloseExecutor-10298-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4482a292
[junit4] 2> 2153329 INFO (coreCloseExecutor-10298-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=4482a292
[junit4] 2> 2153329 INFO (coreCloseExecutor-10298-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4c9f209d: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@f340888
[junit4] 2> 2153337 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2153348 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2153355 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 2153410 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2153575 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2153575 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2153585 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@757db4c4
[junit4] 2> 2153592 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@757db4c4
[junit4] 2> 2153592 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@757db4c4
[junit4] 2> 2153593 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2153606 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2153613 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2153668 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2153673 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2153673 INFO (coreLoadExecutor-10308-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@757db4c4
[junit4] 2> 2153673 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2153673 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3C66F996AC542D1-001/init-core-data-001/]
[junit4] 2> 2153674 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 2153675 WARN (coreLoadExecutor-10308-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> 2153696 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2153696 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2153704 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2153704 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2153704 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=43, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=73.3173828125, floorSegmentMB=1.6064453125, forceMergeDeletesPctAllowed=5.340000614952993, segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6969336812489716, deletesPctAllowed=32.50513481288843
[junit4] 2> 2153704 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@42377fcb[collection1] main]
[junit4] 2> 2153705 WARN (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 2153705 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2153705 INFO (coreLoadExecutor-10308-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1608630544305750016
[junit4] 2> 2153706 INFO (searcherExecutor-10309-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@42377fcb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2153708 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1608630544307847168), 1 (1608630544308895744), 2 (1608630544308895745), 3 (1608630544308895746), 4 (1608630544308895747), 5 (1608630544308895748), 6 (1608630544308895749), 7 (1608630544308895750), 8 (1608630544308895751), 9 (1608630544308895752), ... (20 adds)]} 0 1
[junit4] 2> 2153928 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=221
[junit4] 2> 2153930 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 (1608630544541679616), 21 (1608630544541679617), 22 (1608630544541679618), 23 (1608630544541679619), 24 (1608630544541679620), 25 (1608630544541679621), 26 (1608630544541679622), 27 (1608630544541679623), 28 (1608630544541679624), 29 (1608630544541679625), ... (20 adds)]} 0 0
[junit4] 2> 2154131 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=423
[junit4] 2> 2154131 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 (1608630544752443392), 41 (1608630544752443393), 42 (1608630544752443394), 43 (1608630544752443395), 44 (1608630544752443396), 45 (1608630544752443397), 46 (1608630544752443398), 47 (1608630544752443399), 48 (1608630544752443400), 49 (1608630544752443401), ... (20 adds)]} 0 0
[junit4] 2> 2154332 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=625
[junit4] 2> 2154333 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 (1608630544963207168), 61 (1608630544963207169), 62 (1608630544963207170), 63 (1608630544963207171), 64 (1608630544963207172), 65 (1608630544963207173), 66 (1608630544963207174), 67 (1608630544963207175), 68 (1608630544963207176), 69 (1608630544963207177), ... (20 adds)]} 0 0
[junit4] 2> 2154533 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=826
[junit4] 2> 2154534 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 (1608630545175019520), 81 (1608630545175019521), 82 (1608630545175019522), 83 (1608630545175019523), 84 (1608630545175019524), 85 (1608630545175019525), 86 (1608630545175019526), 87 (1608630545175019527), 88 (1608630545175019528), 89 (1608630545175019529), ... (20 adds)]} 0 0
[junit4] 2> 2154735 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1027
[junit4] 2> 2154735 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 (1608630545385783296), 101 (1608630545385783297), 102 (1608630545385783298), 103 (1608630545385783299), 104 (1608630545385783300), 105 (1608630545385783301), 106 (1608630545385783302), 107 (1608630545385783303), 108 (1608630545385783304), 109 (1608630545385783305), ... (20 adds)]} 0 0
[junit4] 2> 2154936 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1228
[junit4] 2> 2154937 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 (1608630545596547072), 121 (1608630545596547073), 122 (1608630545596547074), 123 (1608630545596547075), 124 (1608630545596547076), 125 (1608630545596547077), 126 (1608630545596547078), 127 (1608630545596547079), 128 (1608630545597595648), 129 (1608630545597595649), ... (20 adds)]} 0 1
[junit4] 2> 2154938 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2154938 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@560c2b31 commitCommandVersion:0
[junit4] 2> 2154941 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@42845437[collection1] realtime]
[junit4] 2> 2154941 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2154988 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.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> 2154989 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 (1608630545651073024), 141 (1608630545652121600), 142 (1608630545652121601), 143 (1608630545652121602), 144 (1608630545652121603), 145 (1608630545652121604), 146 (1608630545652121605), 147 (1608630545652121606), 148 (1608630545652121607), 149 (1608630545652121608), ... (20 adds)]} 0 1
[junit4] 2> 2155190 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1482
[junit4] 2> 2155191 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160 (1608630545862885376), 161 (1608630545862885377), 162 (1608630545862885378), 163 (1608630545862885379), 164 (1608630545862885380), 165 (1608630545862885381), 166 (1608630545862885382), 167 (1608630545862885383), 168 (1608630545862885384), 169 (1608630545862885385), ... (20 adds)]} 0 0
[junit4] 2> 2155391 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1684
[junit4] 2> 2155392 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180 (1608630546073649152), 181 (1608630546074697728), 182 (1608630546074697729), 183 (1608630546074697730), 184 (1608630546074697731), 185 (1608630546074697732), 186 (1608630546074697733), 187 (1608630546074697734), 188 (1608630546074697735), 189 (1608630546074697736), ... (20 adds)]} 0 0
[junit4] 2> 2155592 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1885
[junit4] 2> 2155593 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200 (1608630546285461504), 201 (1608630546285461505), 202 (1608630546285461506), 203 (1608630546285461507), 204 (1608630546285461508), 205 (1608630546285461509), 206 (1608630546285461510), 207 (1608630546285461511), 208 (1608630546285461512), 209 (1608630546285461513), ... (20 adds)]} 0 0
[junit4] 2> 2155794 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2086
[junit4] 2> 2155795 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220 (1608630546496225280), 221 (1608630546496225281), 222 (1608630546497273856), 223 (1608630546497273857), 224 (1608630546497273858), 225 (1608630546497273859), 226 (1608630546497273860), 227 (1608630546497273861), 228 (1608630546497273862), 229 (1608630546497273863), ... (20 adds)]} 0 0
[junit4] 2> 2155996 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2288
[junit4] 2> 2155996 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240 (1608630546708037632), 241 (1608630546708037633), 242 (1608630546708037634), 243 (1608630546708037635), 244 (1608630546708037636), 245 (1608630546708037637), 246 (1608630546708037638), 247 (1608630546708037639), 248 (1608630546708037640), 249 (1608630546708037641), ... (20 adds)]} 0 0
[junit4] 2> 2156197 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2490
[junit4] 2> 2156198 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260 (1608630546918801408), 261 (1608630546918801409), 262 (1608630546918801410), 263 (1608630546918801411), 264 (1608630546918801412), 265 (1608630546918801413), 266 (1608630546918801414), 267 (1608630546918801415), 268 (1608630546919849984), 269 (1608630546919849985), ... (20 adds)]} 0 0
[junit4] 2> 2156199 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2156199 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@560c2b31 commitCommandVersion:0
[junit4] 2> 2156200 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2fa5625d[collection1] realtime]
[junit4] 2> 2156201 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2156248 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2541
[junit4] 2> 2156249 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280 (1608630546972278784), 281 (1608630546973327360), 282 (1608630546973327361), 283 (1608630546973327362), 284 (1608630546973327363), 285 (1608630546973327364), 286 (1608630546973327365), 287 (1608630546973327366), 288 (1608630546973327367), 289 (1608630546973327368), ... (20 adds)]} 0 0
[junit4] 2> 2156450 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2742
[junit4] 2> 2156451 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300 (1608630547184091136), 301 (1608630547184091137), 302 (1608630547184091138), 303 (1608630547184091139), 304 (1608630547184091140), 305 (1608630547184091141), 306 (1608630547184091142), 307 (1608630547184091143), 308 (1608630547184091144), 309 (1608630547184091145), ... (20 adds)]} 0 0
[junit4] 2> 2156651 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2944
[junit4] 2> 2156652 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320 (1608630547395903488), 321 (1608630547395903489), 322 (1608630547395903490), 323 (1608630547395903491), 324 (1608630547395903492), 325 (1608630547395903493), 326 (1608630547395903494), 327 (1608630547395903495), 328 (1608630547395903496), 329 (1608630547395903497), ... (20 adds)]} 0 0
[junit4] 2> 2156853 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3145
[junit4] 2> 2156853 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340 (1608630547606667264), 341 (1608630547606667265), 342 (1608630547606667266), 343 (1608630547606667267), 344 (1608630547606667268), 345 (1608630547606667269), 346 (1608630547606667270), 347 (1608630547606667271), 348 (1608630547606667272), 349 (1608630547606667273), ... (20 adds)]} 0 0
[junit4] 2> 2157054 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3346
[junit4] 2> 2157054 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360 (1608630547817431040), 361 (1608630547817431041), 362 (1608630547817431042), 363 (1608630547817431043), 364 (1608630547817431044), 365 (1608630547817431045), 366 (1608630547817431046), 367 (1608630547817431047), 368 (1608630547817431048), 369 (1608630547817431049), ... (20 adds)]} 0 0
[junit4] 2> 2157255 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3547
[junit4] 2> 2157256 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380 (1608630548028194816), 381 (1608630548028194817), 382 (1608630548028194818), 383 (1608630548028194819), 384 (1608630548028194820), 385 (1608630548028194821), 386 (1608630548028194822), 387 (1608630548028194823), 388 (1608630548028194824), 389 (1608630548028194825), ... (20 adds)]} 0 0
[junit4] 2> 2157456 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3749
[junit4] 2> 2157457 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400 (1608630548240007168), 401 (1608630548240007169), 402 (1608630548240007170), 403 (1608630548240007171), 404 (1608630548240007172), 405 (1608630548240007173), 406 (1608630548240007174), 407 (1608630548240007175), 408 (1608630548240007176), 409 (1608630548240007177), ... (20 adds)]} 0 0
[junit4] 2> 2157458 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2157458 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@560c2b31 commitCommandVersion:0
[junit4] 2> 2157460 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3f48f94f[collection1] realtime]
[junit4] 2> 2157460 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2157508 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3800
[junit4] 2> 2157509 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420 (1608630548293484544), 421 (1608630548293484545), 422 (1608630548293484546), 423 (1608630548293484547), 424 (1608630548293484548), 425 (1608630548293484549), 426 (1608630548293484550), 427 (1608630548293484551), 428 (1608630548293484552), 429 (1608630548293484553), ... (20 adds)]} 0 0
[junit4] 2> 2157709 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4002
[junit4] 2> 2157710 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440 (1608630548505296896), 441 (1608630548505296897), 442 (1608630548505296898), 443 (1608630548505296899), 444 (1608630548505296900), 445 (1608630548505296901), 446 (1608630548505296902), 447 (1608630548505296903), 448 (1608630548505296904), 449 (1608630548505296905), ... (20 adds)]} 0 0
[junit4] 2> 2157911 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4204
[junit4] 2> 2157912 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460 (1608630548716060672), 461 (1608630548716060673), 462 (1608630548717109248), 463 (1608630548717109249), 464 (1608630548717109250), 465 (1608630548717109251), 466 (1608630548717109252), 467 (1608630548717109253), 468 (1608630548717109254), 469 (1608630548717109255), ... (20 adds)]} 0 0
[junit4] 2> 2158112 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4405
[junit4] 2> 2158113 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480 (1608630548927873024), 481 (1608630548927873025), 482 (1608630548927873026), 483 (1608630548927873027), 484 (1608630548927873028), 485 (1608630548927873029), 486 (1608630548927873030), 487 (1608630548927873031), 488 (1608630548927873032), 489 (1608630548927873033), ... (20 adds)]} 0 0
[junit4] 2> 2158314 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4606
[junit4] 2> 2158314 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1608630549138636800), 501 (1608630549138636801), 502 (1608630549138636802), 503 (1608630549138636803), 504 (1608630549138636804), 505 (1608630549138636805), 506 (1608630549138636806), 507 (1608630549138636807), 508 (1608630549138636808), 509 (1608630549138636809), ... (20 adds)]} 0 0
[junit4] 2> 2158515 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4807
[junit4] 2> 2158516 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520 (1608630549349400576), 521 (1608630549349400577), 522 (1608630549349400578), 523 (1608630549349400579), 524 (1608630549349400580), 525 (1608630549349400581), 526 (1608630549349400582), 527 (1608630549349400583), 528 (1608630549349400584), 529 (1608630549349400585), ... (20 adds)]} 0 0
[junit4] 2> 2158716 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5009
[junit4] 2> 2158717 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540 (1608630549561212928), 541 (1608630549561212929), 542 (1608630549561212930), 543 (1608630549561212931), 544 (1608630549561212932), 545 (1608630549561212933), 546 (1608630549561212934), 547 (1608630549561212935), 548 (1608630549561212936), 549 (1608630549561212937), ... (20 adds)]} 0 0
[junit4] 2> 2158718 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2158718 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@560c2b31 commitCommandVersion:0
[junit4] 2> 2158720 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3a17ce97[collection1] realtime]
[junit4] 2> 2158767 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5060
[junit4] 2> 2158856 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2158857 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560 (1608630549614690304), 561 (1608630549708013568), 562 (1608630549708013569), 563 (1608630549708013570), 564 (1608630549708013571), 565 (1608630549708013572), 566 (1608630549708013573), 567 (1608630549708013574), 568 (1608630549708013575), 569 (1608630549708013576), ... (20 adds)]} 0 89
[junit4] 2> 2159058 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5350
[junit4] 2> 2159059 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580 (1608630549918777344), 581 (1608630549918777345), 582 (1608630549918777346), 583 (1608630549918777347), 584 (1608630549918777348), 585 (1608630549918777349), 586 (1608630549918777350), 587 (1608630549918777351), 588 (1608630549918777352), 589 (1608630549918777353), ... (20 adds)]} 0 0
[junit4] 2> 2159259 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5552
[junit4] 2> 2159260 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600 (1608630550130589696), 601 (1608630550130589697), 602 (1608630550130589698), 603 (1608630550130589699), 604 (1608630550130589700), 605 (1608630550130589701), 606 (1608630550130589702), 607 (1608630550130589703), 608 (1608630550130589704), 609 (1608630550130589705), ... (20 adds)]} 0 0
[junit4] 2> 2159461 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5753
[junit4] 2> 2159461 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620 (1608630550341353472), 621 (1608630550341353473), 622 (1608630550341353474), 623 (1608630550341353475), 624 (1608630550341353476), 625 (1608630550341353477), 626 (1608630550341353478), 627 (1608630550341353479), 628 (1608630550341353480), 629 (1608630550341353481), ... (20 adds)]} 0 0
[junit4] 2> 2159662 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5954
[junit4] 2> 2159663 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640 (1608630550552117248), 641 (1608630550552117249), 642 (1608630550552117250), 643 (1608630550552117251), 644 (1608630550552117252), 645 (1608630550552117253), 646 (1608630550552117254), 647 (1608630550552117255), 648 (1608630550552117256), 649 (1608630550552117257), ... (20 adds)]} 0 0
[junit4] 2> 2159863 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6156
[junit4] 2> 2159864 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660 (1608630550762881024), 661 (1608630550763929600), 662 (1608630550763929601), 663 (1608630550763929602), 664 (1608630550763929603), 665 (1608630550763929604), 666 (1608630550763929605), 667 (1608630550763929606), 668 (1608630550763929607), 669 (1608630550763929608), ... (20 adds)]} 0 0
[junit4] 2> 2160064 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6357
[junit4] 2> 2160065 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680 (1608630550974693376), 681 (1608630550974693377), 682 (1608630550974693378), 683 (1608630550974693379), 684 (1608630550974693380), 685 (1608630550974693381), 686 (1608630550974693382), 687 (1608630550974693383), 688 (1608630550974693384), 689 (1608630550974693385), ... (20 adds)]} 0 0
[junit4] 2> 2160066 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2160066 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@560c2b31 commitCommandVersion:0
[junit4] 2> 2160068 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@733a81[collection1] realtime]
[junit4] 2> 2160068 INFO (commitScheduler-10312-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2160116 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3C66F996AC542D1]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6408
[ju
[...truncated too long message...]
ds-interceptors-admin-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-authn-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-authz-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-changelog-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/api-all-1.0.0-M20.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/bcprov-jdk15on-1.54.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/byte-buddy-1.6.2.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/commons-collections-3.2.2.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/commons-math3-3.6.1.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/ehcache-core-2.4.4.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/hadoop-common-2.7.4-tests.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/hadoop-hdfs-2.7.4-tests.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/hadoop-minikdc-2.7.4.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/htrace-core-3.2.0-incubating.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/jersey-core-1.9.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/jersey-server-1.9.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/jetty-6.1.26.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/jetty-sslengine-6.1.26.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/jetty-util-6.1.26.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/mina-core-2.0.0-M5.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/mockito-core-2.6.2.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/netty-all-4.0.36.Final.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/test-lib/objenesis-2.5.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/build/analysis/icu/lucene-analyzers-icu-8.0.0-SNAPSHOT.jar:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/contrib/solr-analysis-extras/classes/java:/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/build/queryparser/classes/test:/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/build/backward-codecs/classes/test:/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/contrib/analysis-extras/lib/icu4j-62.1.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-launcher.jar:/home/jenkins/.ant/lib/ivy-2.4.0.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-netrexx.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-xalan2.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-javamail.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-net.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-regexp.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-oro.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jmf.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-log4j.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jsch.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jai.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bsf.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit4.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-resolver.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bcel.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jdepend.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-testutil.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-antlr.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-swing.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-logging.jar:/home/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.6.0.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/temp/junit4-J0-20180812_205800_92317914706415026122960.events @/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/temp/junit4-J0-20180812_205800_9236140317244312025666.suites -stdin
[junit4] ERROR: JVM J0 ended with an exception: Forked process returned with error code: 134. Very likely a JVM crash. See process stdout at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/temp/junit4-J0-20180812_205800_92311964180906072912054.sysout
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1519)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:126)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:982)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:979)
[junit4] at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
[junit4] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
[junit4] at java.base/java.lang.Thread.run(Thread.java:844)
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:633: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:577: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:267: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/common-build.xml:558: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1568: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1092: At least one slave process threw an exception, first: Forked process returned with error code: 134. Very likely a JVM crash. See process stdout at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/temp/junit4-J0-20180812_205800_92311964180906072912054.sysout
Total time: 63 minutes 58 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
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