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/06/05 10:44:41 UTC
[JENKINS] Lucene-Solr-7.x-Linux (64bit/jdk-10.0.1) - Build # 2057 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2057/
Java: 64bit/jdk-10.0.1 -XX:-UseCompressedOops -XX:+UseSerialGC
3 tests failed.
FAILED: org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest
Error Message:
Tlog size exceeds the max size bound. Tlog path: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_A21F6220B631ED93-001/init-core-data-001/tlog/tlog.0000000000000000003, tlog size: 1276
Stack Trace:
java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_A21F6220B631ED93-001/init-core-data-001/tlog/tlog.0000000000000000003, tlog size: 1276
at __randomizedtesting.SeedInfo.seed([A21F6220B631ED93:B25187DFCD9FD462]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.solr.update.MaxSizeAutoCommitTest.getTlogFileSizes(MaxSizeAutoCommitTest.java:379)
at org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest(MaxSizeAutoCommitTest.java:200)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
FAILED: org.apache.solr.update.TransactionLogTest.testBigLastAddSize
Error Message:
For input string: "000000000000000000014604988058574180280"
Stack Trace:
java.lang.NumberFormatException: For input string: "000000000000000000014604988058574180280"
at __randomizedtesting.SeedInfo.seed([A21F6220B631ED93:BAE5CC8B5F7F1192]:0)
at java.base/java.lang.NumberFormatException.forInputString(NumberFormatException.java:65)
at java.base/java.lang.Long.parseLong(Long.java:692)
at java.base/java.lang.Long.parseLong(Long.java:817)
at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:153)
at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:141)
at org.apache.solr.update.TransactionLogTest.testBigLastAddSize(TransactionLogTest.java:34)
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 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 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)
FAILED: org.apache.solr.update.TransactionLogTest.testBigLastAddSize
Error Message:
For input string: "000000000000000000017741293658854428970"
Stack Trace:
java.lang.NumberFormatException: For input string: "000000000000000000017741293658854428970"
at __randomizedtesting.SeedInfo.seed([A21F6220B631ED93:BAE5CC8B5F7F1192]:0)
at java.base/java.lang.NumberFormatException.forInputString(NumberFormatException.java:65)
at java.base/java.lang.Long.parseLong(Long.java:692)
at java.base/java.lang.Long.parseLong(Long.java:817)
at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:153)
at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:141)
at org.apache.solr.update.TransactionLogTest.testBigLastAddSize(TransactionLogTest.java:34)
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 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 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 12849 lines...]
[junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_A21F6220B631ED93-001/init-core-data-001
[junit4] 2> 140048 INFO (SUITE-MaxSizeAutoCommitTest-seed#[A21F6220B631ED93]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 140048 INFO (SUITE-MaxSizeAutoCommitTest-seed#[A21F6220B631ED93]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 140048 INFO (SUITE-MaxSizeAutoCommitTest-seed#[A21F6220B631ED93]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 140049 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ###Starting simpleTest
[junit4] 2> 140160 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 140161 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 140172 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 140179 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 140244 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 140375 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 140380 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 140380 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 140381 INFO (coreLoadExecutor-1238-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 140382 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 140392 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 140404 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 140452 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 140458 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 140458 INFO (coreLoadExecutor-1238-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@53fa6feb
[junit4] 2> 140458 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 140458 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_A21F6220B631ED93-001/init-core-data-001/]
[junit4] 2> 140459 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 140460 WARN (coreLoadExecutor-1238-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> 140485 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 140485 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 140486 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 140486 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 140487 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.17790926505534754]
[junit4] 2> 140487 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@176b6871[collection1] main]
[junit4] 2> 140487 WARN (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 140487 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 140488 INFO (searcherExecutor-1239-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@176b6871[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 140488 INFO (coreLoadExecutor-1238-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1602426439649460224
[junit4] 2> 140490 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 140492 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1602426439652605952), 1 (1602426439653654528), 2 (1602426439653654529)]} 0 1
[junit4] 2> 140693 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1602426439864418304), 4 (1602426439864418305), 5 (1602426439864418306)]} 0 0
[junit4] 2> 140894 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1602426440075182080), 7 (1602426440075182081), 8 (1602426440075182082)]} 0 0
[junit4] 2> 141095 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1602426440285945856), 10 (1602426440285945857), 11 (1602426440285945858)]} 0 0
[junit4] 2> 141296 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1602426440496709632), 13 (1602426440496709633), 14 (1602426440496709634)]} 0 0
[junit4] 2> 141497 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1602426440707473408), 16 (1602426440707473409), 17 (1602426440707473410)]} 0 0
[junit4] 2> 141698 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[18 (1602426440918237184), 19 (1602426440918237185), 20 (1602426440918237186)]} 0 0
[junit4] 2> 141899 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[21 (1602426441129000960), 22 (1602426441129000961), 23 (1602426441129000962)]} 0 0
[junit4] 2> 142100 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[24 (1602426441339764736), 25 (1602426441339764737), 26 (1602426441339764738)]} 0 0
[junit4] 2> 142102 INFO (commitScheduler-1242-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 142102 INFO (commitScheduler-1242-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@6f90e49f commitCommandVersion:0
[junit4] 2> 142106 INFO (commitScheduler-1242-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@270b5e44[collection1] realtime]
[junit4] 2> 142106 INFO (commitScheduler-1242-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 142152 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[27 (1602426441393242112), 28 (1602426441394290688), 29 (1602426441394290689)]} 0 1
[junit4] 2> 142353 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ###Ending simpleTest
[junit4] 2> 142353 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 142353 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=900921797
[junit4] 2> 142353 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 142353 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3d894421: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@172a6260
[junit4] 2> 142356 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 142356 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@77e035da: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@76e666df
[junit4] 2> 142359 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 142359 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5504a015: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@14f3429
[junit4] 2> 142359 INFO (coreCloseExecutor-1244-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3d6b12a0
[junit4] 2> 142360 INFO (coreCloseExecutor-1244-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=3d6b12a0
[junit4] 2> 142360 INFO (coreCloseExecutor-1244-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3e757c04: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@23c4a5df
[junit4] 2> 142369 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ###Starting endToEndTest {seed=[A21F6220B631ED93:B8490D165683CA91]}
[junit4] 2> 142369 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 142369 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 142381 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 142388 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 142465 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 142573 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 142581 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 142582 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 142587 INFO (coreLoadExecutor-1252-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 142588 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 142606 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 142617 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 142693 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 142701 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 142701 INFO (coreLoadExecutor-1252-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@53fa6feb
[junit4] 2> 142701 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 142701 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_A21F6220B631ED93-001/init-core-data-001/]
[junit4] 2> 142702 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 142704 WARN (coreLoadExecutor-1252-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> 142729 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 142729 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 142730 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 142730 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 142731 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.17790926505534754]
[junit4] 2> 142731 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@74addc44[collection1] main]
[junit4] 2> 142732 WARN (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 142732 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 142732 INFO (coreLoadExecutor-1252-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1602426442002464768
[junit4] 2> 142734 INFO (searcherExecutor-1253-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@74addc44[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 142734 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 142737 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1602426442005610496), 1 (1602426442006659072), 2 (1602426442007707648), 3 (1602426442007707649), 4 (1602426442007707650), 5 (1602426442007707651), 6 (1602426442007707652), 7 (1602426442007707653), 8 (1602426442007707654), 9 (1602426442007707655), ... (20 adds)]} 0 2
[junit4] 2> 142938 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=203
[junit4] 2> 142974 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 (1602426442255171584), 21 (1602426442255171585), 22 (1602426442255171586), 23 (1602426442255171587), 24 (1602426442255171588), 25 (1602426442255171589), 26 (1602426442255171590), 27 (1602426442255171591), 28 (1602426442255171592), 29 (1602426442255171593), ... (20 adds)]} 0 1
[junit4] 2> 143174 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=439
[junit4] 2> 143184 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 (1602426442466983936), 41 (1602426442466983937), 42 (1602426442466983938), 43 (1602426442466983939), 44 (1602426442466983940), 45 (1602426442466983941), 46 (1602426442466983942), 47 (1602426442474323968), 48 (1602426442476421120), 49 (1602426442476421121), ... (20 adds)]} 0 9
[junit4] 2> 143385 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=650
[junit4] 2> 143386 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 (1602426442688233472), 61 (1602426442688233473), 62 (1602426442688233474), 63 (1602426442688233475), 64 (1602426442688233476), 65 (1602426442688233477), 66 (1602426442688233478), 67 (1602426442688233479), 68 (1602426442688233480), 69 (1602426442688233481), ... (20 adds)]} 0 0
[junit4] 2> 143587 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=852
[junit4] 2> 143604 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 (1602426442900045824), 81 (1602426442900045825), 82 (1602426442900045826), 83 (1602426442900045827), 84 (1602426442900045828), 85 (1602426442900045829), 86 (1602426442900045830), 87 (1602426442900045831), 88 (1602426442900045832), 89 (1602426442900045833), ... (20 adds)]} 0 16
[junit4] 2> 143805 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1069
[junit4] 2> 143806 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 (1602426443127586816), 101 (1602426443127586817), 102 (1602426443127586818), 103 (1602426443127586819), 104 (1602426443127586820), 105 (1602426443127586821), 106 (1602426443127586822), 107 (1602426443127586823), 108 (1602426443127586824), 109 (1602426443128635392), ... (20 adds)]} 0 0
[junit4] 2> 144007 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1271
[junit4] 2> 144018 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 (1602426443339399168), 121 (1602426443339399169), 122 (1602426443339399170), 123 (1602426443339399171), 124 (1602426443339399172), 125 (1602426443339399173), 126 (1602426443339399174), 127 (1602426443339399175), 128 (1602426443339399176), 129 (1602426443339399177), ... (20 adds)]} 0 10
[junit4] 2> 144018 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 144018 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@727de4c0 commitCommandVersion:0
[junit4] 2> 144023 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@639c08a7[collection1] realtime]
[junit4] 2> 144023 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 144068 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1332
[junit4] 2> 144069 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 (1602426443403362304), 141 (1602426443404410880), 142 (1602426443404410881), 143 (1602426443404410882), 144 (1602426443404410883), 145 (1602426443404410884), 146 (1602426443404410885), 147 (1602426443404410886), 148 (1602426443404410887), 149 (1602426443404410888), ... (20 adds)]} 0 1
[junit4] 2> 144270 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1535
[junit4] 2> 144272 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160 (1602426443616223232), 161 (1602426443616223233), 162 (1602426443616223234), 163 (1602426443616223235), 164 (1602426443616223236), 165 (1602426443616223237), 166 (1602426443616223238), 167 (1602426443616223239), 168 (1602426443616223240), 169 (1602426443616223241), ... (20 adds)]} 0 0
[junit4] 2> 144472 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1737
[junit4] 2> 144476 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180 (1602426443828035584), 181 (1602426443828035585), 182 (1602426443828035586), 183 (1602426443828035587), 184 (1602426443828035588), 185 (1602426443828035589), 186 (1602426443828035590), 187 (1602426443830132736), 188 (1602426443831181312), 189 (1602426443831181313), ... (20 adds)]} 0 3
[junit4] 2> 144677 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1941
[junit4] 2> 144678 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200 (1602426444041945088), 201 (1602426444041945089), 202 (1602426444041945090), 203 (1602426444041945091), 204 (1602426444041945092), 205 (1602426444041945093), 206 (1602426444041945094), 207 (1602426444041945095), 208 (1602426444041945096), 209 (1602426444041945097), ... (20 adds)]} 0 0
[junit4] 2> 144878 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2143
[junit4] 2> 144883 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220 (1602426444253757440), 221 (1602426444253757441), 222 (1602426444253757442), 223 (1602426444253757443), 224 (1602426444253757444), 225 (1602426444253757445), 226 (1602426444253757446), 227 (1602426444253757447), 228 (1602426444253757448), 229 (1602426444253757449), ... (20 adds)]} 0 4
[junit4] 2> 145084 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2348
[junit4] 2> 145085 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240 (1602426444468715520), 241 (1602426444468715521), 242 (1602426444468715522), 243 (1602426444468715523), 244 (1602426444468715524), 245 (1602426444468715525), 246 (1602426444468715526), 247 (1602426444468715527), 248 (1602426444468715528), 249 (1602426444468715529), ... (20 adds)]} 0 0
[junit4] 2> 145285 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2550
[junit4] 2> 145286 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260 (1602426444680527872), 261 (1602426444680527873), 262 (1602426444680527874), 263 (1602426444680527875), 264 (1602426444680527876), 265 (1602426444680527877), 266 (1602426444680527878), 267 (1602426444680527879), 268 (1602426444680527880), 269 (1602426444680527881), ... (20 adds)]} 0 0
[junit4] 2> 145287 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 145287 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@727de4c0 commitCommandVersion:0
[junit4] 2> 145292 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@50da439d[collection1] realtime]
[junit4] 2> 145292 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 145337 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2601
[junit4] 2> 145338 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280 (1602426444734005248), 281 (1602426444734005249), 282 (1602426444734005250), 283 (1602426444734005251), 284 (1602426444734005252), 285 (1602426444734005253), 286 (1602426444734005254), 287 (1602426444735053824), 288 (1602426444735053825), 289 (1602426444735053826), ... (20 adds)]} 0 1
[junit4] 2> 145539 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2803
[junit4] 2> 145540 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300 (1602426444945817600), 301 (1602426444945817601), 302 (1602426444945817602), 303 (1602426444945817603), 304 (1602426444945817604), 305 (1602426444945817605), 306 (1602426444945817606), 307 (1602426444945817607), 308 (1602426444945817608), 309 (1602426444945817609), ... (20 adds)]} 0 0
[junit4] 2> 145740 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3005
[junit4] 2> 145745 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320 (1602426445157629952), 321 (1602426445157629953), 322 (1602426445157629954), 323 (1602426445157629955), 324 (1602426445157629956), 325 (1602426445157629957), 326 (1602426445157629958), 327 (1602426445160775680), 328 (1602426445160775681), 329 (1602426445160775682), ... (20 adds)]} 0 4
[junit4] 2> 145946 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3210
[junit4] 2> 145946 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340 (1602426445372588032), 341 (1602426445372588033), 342 (1602426445372588034), 343 (1602426445372588035), 344 (1602426445372588036), 345 (1602426445372588037), 346 (1602426445372588038), 347 (1602426445372588039), 348 (1602426445372588040), 349 (1602426445372588041), ... (20 adds)]} 0 0
[junit4] 2> 146147 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3412
[junit4] 2> 146152 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360 (1602426445584400384), 361 (1602426445584400385), 362 (1602426445584400386), 363 (1602426445584400387), 364 (1602426445584400388), 365 (1602426445584400389), 366 (1602426445584400390), 367 (1602426445584400391), 368 (1602426445584400392), 369 (1602426445584400393), ... (20 adds)]} 0 4
[junit4] 2> 146353 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3618
[junit4] 2> 146354 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380 (1602426445799358464), 381 (1602426445800407040), 382 (1602426445800407041), 383 (1602426445800407042), 384 (1602426445800407043), 385 (1602426445800407044), 386 (1602426445800407045), 387 (1602426445800407046), 388 (1602426445800407047), 389 (1602426445800407048), ... (20 adds)]} 0 0
[junit4] 2> 146555 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3819
[junit4] 2> 146556 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400 (1602426446011170816), 401 (1602426446011170817), 402 (1602426446011170818), 403 (1602426446011170819), 404 (1602426446011170820), 405 (1602426446011170821), 406 (1602426446011170822), 407 (1602426446011170823), 408 (1602426446011170824), 409 (1602426446011170825), ... (20 adds)]} 0 0
[junit4] 2> 146557 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 146557 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@727de4c0 commitCommandVersion:0
[junit4] 2> 146563 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@450a1fd6[collection1] realtime]
[junit4] 2> 146563 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 146606 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3871
[junit4] 2> 146607 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420 (1602426446064648192), 421 (1602426446065696768), 422 (1602426446065696769), 423 (1602426446065696770), 424 (1602426446065696771), 425 (1602426446065696772), 426 (1602426446065696773), 427 (1602426446065696774), 428 (1602426446065696775), 429 (1602426446065696776), ... (20 adds)]} 0 1
[junit4] 2> 146808 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4073
[junit4] 2> 146809 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440 (1602426446277509120), 441 (1602426446277509121), 442 (1602426446277509122), 443 (1602426446277509123), 444 (1602426446277509124), 445 (1602426446277509125), 446 (1602426446277509126), 447 (1602426446277509127), 448 (1602426446277509128), 449 (1602426446277509129), ... (20 adds)]} 0 0
[junit4] 2> 147010 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4274
[junit4] 2> 147013 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460 (1602426446488272896), 461 (1602426446488272897), 462 (1602426446489321472), 463 (1602426446489321473), 464 (1602426446489321474), 465 (1602426446489321475), 466 (1602426446489321476), 467 (1602426446491418624), 468 (1602426446491418625), 469 (1602426446491418626), ... (20 adds)]} 0 2
[junit4] 2> 147214 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4479
[junit4] 2> 147215 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480 (1602426446703230976), 481 (1602426446703230977), 482 (1602426446703230978), 483 (1602426446703230979), 484 (1602426446703230980), 485 (1602426446703230981), 486 (1602426446703230982), 487 (1602426446703230983), 488 (1602426446703230984), 489 (1602426446703230985), ... (20 adds)]} 0 0
[junit4] 2> 147416 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4680
[junit4] 2> 147420 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1602426446913994752), 501 (1602426446913994753), 502 (1602426446913994754), 503 (1602426446913994755), 504 (1602426446915043328), 505 (1602426446915043329), 506 (1602426446915043330), 507 (1602426446915043331), 508 (1602426446915043332), 509 (1602426446915043333), ... (20 adds)]} 0 4
[junit4] 2> 147621 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4886
[junit4] 2> 147622 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520 (1602426447128952832), 521 (1602426447130001408), 522 (1602426447130001409), 523 (1602426447130001410), 524 (1602426447130001411), 525 (1602426447130001412), 526 (1602426447130001413), 527 (1602426447130001414), 528 (1602426447130001415), 529 (1602426447130001416), ... (20 adds)]} 0 0
[junit4] 2> 147823 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5087
[junit4] 2> 147824 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540 (1602426447340765184), 541 (1602426447340765185), 542 (1602426447340765186), 543 (1602426447340765187), 544 (1602426447340765188), 545 (1602426447340765189), 546 (1602426447340765190), 547 (1602426447340765191), 548 (1602426447340765192), 549 (1602426447340765193), ... (20 adds)]} 0 0
[junit4] 2> 147825 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 147825 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@727de4c0 commitCommandVersion:0
[junit4] 2> 147831 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@23f1859d[collection1] realtime]
[junit4] 2> 147831 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 147874 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5139
[junit4] 2> 147876 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560 (1602426447395291136), 561 (1602426447395291137), 562 (1602426447395291138), 563 (1602426447395291139), 564 (1602426447395291140), 565 (1602426447395291141), 566 (1602426447396339712), 567 (1602426447396339713), 568 (1602426447396339714), 569 (1602426447396339715), ... (20 adds)]} 0 1
[junit4] 2> 148077 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5341
[junit4] 2> 148077 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580 (1602426447607103488), 581 (1602426447607103489), 582 (1602426447607103490), 583 (1602426447607103491), 584 (1602426447607103492), 585 (1602426447607103493), 586 (1602426447607103494), 587 (1602426447607103495), 588 (1602426447607103496), 589 (1602426447607103497), ... (20 adds)]} 0 0
[junit4] 2> 148278 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5542
[junit4] 2> 148281 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600 (1602426447817867264), 601 (1602426447817867265), 602 (1602426447817867266), 603 (1602426447817867267), 604 (1602426447817867268), 605 (1602426447817867269), 606 (1602426447817867270), 607 (1602426447821012992), 608 (1602426447821012993), 609 (1602426447821012994), ... (20 adds)]} 0 2
[junit4] 2> 148482 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5746
[junit4] 2> 148482 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620 (1602426448031776768), 621 (1602426448031776769), 622 (1602426448031776770), 623 (1602426448031776771), 624 (1602426448031776772), 625 (1602426448031776773), 626 (1602426448031776774), 627 (1602426448031776775), 628 (1602426448031776776), 629 (1602426448031776777), ... (20 adds)]} 0 0
[junit4] 2> 148683 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5948
[junit4] 2> 148688 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640 (1602426448243589120), 641 (1602426448243589121), 642 (1602426448243589122), 643 (1602426448243589123), 644 (1602426448243589124), 645 (1602426448243589125), 646 (1602426448243589126), 647 (1602426448243589127), 648 (1602426448243589128), 649 (1602426448243589129), ... (20 adds)]} 0 4
[junit4] 2> 148889 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6153
[junit4] 2> 148889 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660 (1602426448458547200), 661 (1602426448458547201), 662 (1602426448458547202), 663 (1602426448458547203), 664 (1602426448458547204), 665 (1602426448458547205), 666 (1602426448458547206), 667 (1602426448458547207), 668 (1602426448458547208), 669 (1602426448458547209), ... (20 adds)]} 0 0
[junit4] 2> 149090 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6355
[junit4] 2> 149091 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680 (1602426448670359552), 681 (1602426448670359553), 682 (1602426448670359554), 683 (1602426448670359555), 684 (1602426448670359556), 685 (1602426448670359557), 686 (1602426448670359558), 687 (1602426448670359559), 688 (1602426448670359560), 689 (1602426448670359561), ... (20 adds)]} 0 0
[junit4] 2> 149092 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 149092 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@727de4c0 commitCommandVersion:0
[junit4] 2> 149101 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@48820b77[collection1] realtime]
[junit4] 2> 149101 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 149142 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6406
[junit4] 2> 149143 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[700 (1602426448723836928), 701 (1602426448724885504), 702 (1602426448724885505), 703 (1602426448724885506), 704 (1602426448724885507), 705 (1602426448724885508), 706 (1602426448724885509), 707 (1602426448724885510), 708 (1602426448724885511), 709 (1602426448724885512), ... (20 adds)]} 0 0
[junit4] 2> 149344 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6608
[junit4] 2> 149345 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[720 (1602426448935649280), 721 (1602426448935649281), 722 (1602426448935649282), 723 (1602426448935649283), 724 (1602426448935649284), 725 (1602426448935649285), 726 (1602426448935649286), 727 (1602426448935649287), 728 (1602426448935649288), 729 (1602426448935649289), ... (20 adds)]} 0 0
[junit4] 2> 149545 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6810
[junit4] 2> 149561 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[740 (1602426449147461632), 741 (1602426449147461633), 742 (1602426449147461634), 743 (1602426449147461635), 744 (1602426449147461636), 745 (1602426449147461637), 746 (1602426449147461638), 747 (1602426449163190272), 748 (1602426449163190273), 749 (1602426449163190274), ... (20 adds)]} 0 15
[junit4] 2> 149762 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7027
[junit4] 2> 149763 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[760 (1602426449375002624), 761 (1602426449375002625), 762 (1602426449375002626), 763 (1602426449375002627), 764 (1602426449375002628), 765 (1602426449375002629), 766 (1602426449375002630), 767 (1602426449375002631), 768 (1602426449375002632), 769 (1602426449375002633), ... (20 adds)]} 0 0
[junit4] 2> 149964 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7228
[junit4] 2> 149969 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[780 (1602426449585766400), 781 (1602426449585766401), 782 (1602426449585766402), 783 (1602426449585766403), 784 (1602426449585766404), 785 (1602426449585766405), 786 (1602426449585766406), 787 (1602426449585766407), 788 (1602426449586814976), 789 (1602426449586814977), ... (20 adds)]} 0 4
[junit4] 2> 150170 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7434
[junit4] 2> 150171 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[800 (1602426449801773056), 801 (1602426449801773057), 802 (1602426449801773058), 803 (1602426449801773059), 804 (1602426449801773060), 805 (1602426449801773061), 806 (1602426449801773062), 807 (1602426449801773063), 808 (1602426449801773064), 809 (1602426449801773065), ... (20 adds)]} 0 0
[junit4] 2> 150371 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7636
[junit4] 2> 150372 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[820 (1602426450013585408), 821 (1602426450013585409), 822 (1602426450013585410), 823 (1602426450013585411), 824 (1602426450013585412), 825 (1602426450013585413), 826 (1602426450013585414), 827 (1602426450013585415), 828 (1602426450013585416), 829 (1602426450013585417), ... (20 adds)]} 0 0
[junit4] 2> 150373 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 150373 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@727de4c0 commitCommandVersion:0
[junit4] 2> 150378 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@319069ae[collection1] realtime]
[junit4] 2> 150378 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 150423 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7687
[junit4] 2> 150424 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[840 (1602426450067062784), 841 (1602426450068111360), 842 (1602426450068111361), 843 (1602426450068111362), 844 (1602426450068111363), 845 (1602426450068111364), 846 (1602426450068111365), 847 (1602426450068111366), 848 (1602426450068111367), 849 (1602426450068111368), ... (20 adds)]} 0 1
[junit4] 2> 150625 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7889
[junit4] 2> 150626 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[860 (1602426450278875136), 861 (1602426450278875137), 862 (1602426450278875138), 863 (1602426450278875139), 864 (1602426450278875140), 865 (1602426450279923712), 866 (1602426450279923713), 867 (1602426450279923714), 868 (1602426450279923715), 869 (1602426450279923716), ... (20 adds)]} 0 0
[junit4] 2> 150827 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8091
[junit4] 2> 150831 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[880 (1602426450490687488), 881 (1602426450490687489), 882 (1602426450490687490), 883 (1602426450490687491), 884 (1602426450490687492), 885 (1602426450490687493), 886 (1602426450490687494), 887 (1602426450493833216), 888 (1602426450494881792), 889 (1602426450494881793), ... (20 adds)]} 0 4
[junit4] 2> 151032 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8296
[junit4] 2> 151033 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[900 (1602426450705645568), 901 (1602426450705645569), 902 (1602426450705645570), 903 (1602426450705645571), 904 (1602426450705645572), 905 (1602426450705645573), 906 (1602426450705645574), 907 (1602426450705645575), 908 (1602426450705645576), 909 (1602426450705645577), ... (20 adds)]} 0 0
[junit4] 2> 151233 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8498
[junit4] 2> 151240 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[920 (1602426450917457920), 921 (1602426450917457921), 922 (1602426450917457922), 923 (1602426450917457923), 924 (1602426450917457924), 925 (1602426450917457925), 926 (1602426450917457926), 927 (1602426450917457927), 928 (1602426450917457928), 929 (1602426450917457929), ... (20 adds)]} 0 6
[junit4] 2> 151441 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8705
[junit4] 2> 151441 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[940 (1602426451134513152), 941 (1602426451134513153), 942 (1602426451134513154), 943 (1602426451134513155), 944 (1602426451134513156), 945 (1602426451134513157), 946 (1602426451134513158), 947 (1602426451134513159), 948 (1602426451134513160), 949 (1602426451134513161), ... (20 adds)]} 0 0
[junit4] 2> 151642 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8906
[junit4] 2> 151643 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[960 (1602426451345276928), 961 (1602426451345276929), 962 (1602426451345276930), 963 (1602426451345276931), 964 (1602426451345276932), 965 (1602426451345276933), 966 (1602426451345276934), 967 (1602426451346325504), 968 (1602426451346325505), 969 (1602426451346325506), ... (20 adds)]} 0 0
[junit4] 2> 151644 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 151644 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@727de4c0 commitCommandVersion:0
[junit4] 2> 151649 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@32aea619[collection1] realtime]
[junit4] 2> 151649 INFO (commitScheduler-1256-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 151693 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8958
[junit4] 2> 151695 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[980 (1602426451399802880), 981 (1602426451399802881), 982 (1602426451400851456), 983 (1602426451400851457), 984 (1602426451400851458), 985 (1602426451400851459), 986 (1602426451400851460), 987 (1602426451400851461), 988 (1602426451400851462), 989 (1602426451400851463), ... (20 adds)]} 0 1
[junit4] 2> 151896 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=9160
[junit4] 2> 151896 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 151896 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@727de4c0 commitCommandVersion:0
[junit4] 2> 151901 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1b06316c[collection1] main]
[junit4] 2> 151902 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 151903 INFO (searcherExecutor-1253-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1b06316c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.4.0):C47) Uninverting(_1(7.4.0):C47) Uninverting(_2(7.4.0):C46) Uninverting(_3(7.4.0):C47) Uninverting(_4(7.4.0):C47) Uninverting(_5(7.4.0):C46) Uninverting(_6(7.4.0):C47) Uninverting(_7(7.4.0):C47) Uninverting(_8(7.4.0):C46) Uninverting(_9(7.4.0):C47) Uninverting(_a(7.4.0):C47) Uninverting(_b(7.4.0):C46) Uninverting(_c(7.4.0):C47) Uninverting(_d(7.4.0):C47) Uninverting(_e(7.4.0):C46) Uninverting(_f(7.4.0):C47) Uninverting(_g(7.4.0):C47) Uninverting(_h(7.4.0):C46) Uninverting(_i(7.4.0):C47) Uninverting(_j(7.4.0):C47) Uninverting(_k(7.4.0):C46) Uninverting(_l(7.4.0):C20)))}
[junit4] 2> 151953 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] 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=9218
[junit4] 2> 151956 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ###Ending endToEndTest {seed=[A21F6220B631ED93:B8490D165683CA91]}
[junit4] 2> 151956 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 151956 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1955259009
[junit4] 2> 151957 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 151957 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5eb07892: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@5432a64c
[junit4] 2> 151961 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 151961 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5012c09c: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@76e666df
[junit4] 2> 151964 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 151964 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2590b34a: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@14f3429
[junit4] 2> 151965 INFO (coreCloseExecutor-1258-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5f64ab60
[junit4] 2> 151965 INFO (coreCloseExecutor-1258-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=5f64ab60
[junit4] 2> 151965 INFO (coreCloseExecutor-1258-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3d1075f2: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4d05d7fb
[junit4] 2> 151986 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ###Starting endToEndTest {seed=[A21F6220B631ED93:C1FB1EA624101BD]}
[junit4] 2> 151986 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 151986 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 151998 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 152007 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 152070 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 152198 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 152203 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 152203 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53fa6feb
[junit4] 2> 152204 INFO (coreLoadExecutor-1266-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 152204 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 152220 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 152227 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 152283 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 152288 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 152289 INFO (coreLoadExecutor-1266-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@53fa6feb
[junit4] 2> 152289 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 152289 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_A21F6220B631ED93-001/init-core-data-001/]
[junit4] 2> 152290 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 152291 WARN (coreLoadExecutor-1266-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> 152311 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 152311 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 152312 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 152312 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 152312 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.17790926505534754]
[junit4] 2> 152313 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6aec3625[collection1] main]
[junit4] 2> 152313 WARN (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 152313 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 152314 INFO (searcherExecutor-1267-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6aec3625[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 152314 INFO (coreLoadExecutor-1266-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1602426452049920000
[junit4] 2> 152316 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 152318 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1602426452053065728), 1 (1602426452054114304), 2 (1602426452054114305), 3 (1602426452054114306), 4 (1602426452054114307), 5 (1602426452054114308), 6 (1602426452054114309), 7 (1602426452054114310), 8 (1602426452054114311), 9 (1602426452054114312), ... (20 adds)]} 0 1
[junit4] 2> 152519 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=202
[junit4] 2> 152521 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 (1602426452265926656), 21 (1602426452265926657), 22 (1602426452265926658), 23 (1602426452265926659), 24 (1602426452265926660), 25 (1602426452265926661), 26 (1602426452265926662), 27 (1602426452265926663), 28 (1602426452265926664), 29 (1602426452265926665), ... (20 adds)]} 0 0
[junit4] 2> 152721 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=404
[junit4] 2> 152724 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 (1602426452476690432), 41 (1602426452476690433), 42 (1602426452477739008), 43 (1602426452477739009), 44 (1602426452477739010), 45 (1602426452477739011), 46 (1602426452477739012), 47 (1602426452478787584), 48 (1602426452478787585), 49 (1602426452478787586), ... (20 adds)]} 0 2
[junit4] 2> 152924 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=607
[junit4] 2> 152925 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 (1602426452690599936), 61 (1602426452690599937), 62 (1602426452690599938), 63 (1602426452690599939), 64 (1602426452690599940), 65 (1602426452690599941), 66 (1602426452690599942), 67 (1602426452690599943), 68 (1602426452690599944), 69 (1602426452690599945), ... (20 adds)]} 0 0
[junit4] 2> 153126 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=809
[junit4] 2> 153130 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 (1602426452901363712), 81 (1602426452901363713), 82 (1602426452901363714), 83 (1602426452901363715), 84 (1602426452901363716), 85 (1602426452901363717), 86 (1602426452901363718), 87 (1602426452901363719), 88 (1602426452901363720), 89 (1602426452901363721), ... (20 adds)]} 0 3
[junit4] 2> 153330 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1013
[junit4] 2> 153331 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 (1602426453115273216), 101 (1602426453116321792), 102 (1602426453116321793), 103 (1602426453116321794), 104 (1602426453116321795), 105 (1602426453116321796), 106 (1602426453116321797), 107 (1602426453116321798), 108 (1602426453116321799), 109 (1602426453116321800), ... (20 adds)]} 0 0
[junit4] 2> 153531 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1214
[junit4] 2> 153532 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 (1602426453327085568), 121 (1602426453327085569), 122 (1602426453327085570), 123 (1602426453327085571), 124 (1602426453327085572), 125 (1602426453327085573), 126 (1602426453327085574), 127 (1602426453327085575), 128 (1602426453327085576), 129 (1602426453327085577), ... (20 adds)]} 0 0
[junit4] 2> 153533 INFO (commitScheduler-1270-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 153533 INFO (commitScheduler-1270-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5401da02 commitCommandVersion:0
[junit4] 2> 153537 INFO (commitScheduler-1270-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5da16ff8[collection1] realtime]
[junit4] 2> 153537 INFO (commitScheduler-1270-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 153583 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1265
[junit4] 2> 153584 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[A21F6220B631ED93]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 (1602426453380562944), 141 (1602426453381611520), 142 (1602426453381611521), 143 (1602426453381611522), 144 (1602426453381611523), 145 (1602426453381611524), 146 (1602426453381611525), 147 (1602426453381611526), 148 (1602426453381611527), 149 (1602426453381611528), ... (20
[...truncated too long message...]
[junit4] Completed [102/811 (1!)] on J2 in 57.59s, 8 tests, 1 failure <<< FAILURES!
[...truncated 288 lines...]
[junit4] Suite: org.apache.solr.update.TransactionLogTest
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TransactionLogTest -Dtests.method=testBigLastAddSize -Dtests.seed=A21F6220B631ED93 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sq-XK -Dtests.timezone=America/Montserrat -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J1 | TransactionLogTest.testBigLastAddSize <<<
[junit4] > Throwable #1: java.lang.NumberFormatException: For input string: "000000000000000000017741293658854428970"
[junit4] > at __randomizedtesting.SeedInfo.seed([A21F6220B631ED93:BAE5CC8B5F7F1192]:0)
[junit4] > at java.base/java.lang.NumberFormatException.forInputString(NumberFormatException.java:65)
[junit4] > at java.base/java.lang.Long.parseLong(Long.java:692)
[junit4] > at java.base/java.lang.Long.parseLong(Long.java:817)
[junit4] > at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:153)
[junit4] > at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:141)
[junit4] > at org.apache.solr.update.TransactionLogTest.testBigLastAddSize(TransactionLogTest.java:34)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1859, maxMBSortInHeap=5.912483190163807, sim=RandomSimilarity(queryNorm=true): {}, locale=sq-XK, timezone=America/Montserrat
[junit4] 2> NOTE: Linux 4.13.0-41-generic amd64/Oracle Corporation 10.0.1 (64-bit)/cpus=8,threads=1,free=289786184,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [QueryElevationComponentTest, TestJsonFacetsWithNestedObjects, TestCustomDocTransformer, TestQueryUtils, TestOnReconnectListenerSupport, TestPKIAuthenticationPlugin, SimpleMLTQParserTest, ScheduledMaintenanceTriggerTest, TestScoreJoinQPScore, TestPointFields, TestBM25SimilarityFactory, TestExpandComponent, SecurityConfHandlerTest, TestZkAclsWithHadoopAuth, DirectSolrConnectionTest, BasicFunctionalityTest, ZkShardTermsTest, DistributedSuggestComponentTest, CoreAdminRequestStatusTest, OverseerRolesTest, TestLegacyNumericRangeQueryBuilder, JSONWriterTest, DistributedFacetPivotLongTailTest, TestSubQueryTransformerCrossCore, SignatureUpdateProcessorFactoryTest, TestElisionMultitermQuery, CSVRequestHandlerTest, TestZkChroot, TestStressLiveNodes, TestDistributedGrouping, TestDocTermOrds, SchemaVersionSpecificBehaviorTest, DirectoryFactoryTest, TestPerFieldSimilarity, TestFunctionQuery, ConfigSetsAPITest, TestNonDefinedSimilarityFactory, SolrInfoBeanTest, TestSurroundQueryParser, TestFoldingMultitermQuery, RequiredFieldsTest, CdcrReplicationDistributedZkTest, TestUniqueKeyFieldResource, TokenizerChainTest, DistributedIntervalFacetingTest, SOLR749Test, ResourceLoaderTest, HdfsRestartWhileUpdatingTest, LoggingHandlerTest, StressHdfsTest, TestTrie, TestReqParamsAPI, TriLevelCompositeIdRoutingTest, TestDefaultStatsCache, TestLRUCache, CreateRoutedAliasTest, SuggesterTest, QueryParsingTest, SampleTest, TestTolerantUpdateProcessorRandomCloud, AliasIntegrationTest, TestPartialUpdateDeduplication, BigEndianAscendingWordSerializerTest, BasicAuthStandaloneTest, SaslZkACLProviderTest, TimeRoutedAliasUpdateProcessorTest, SolrSlf4jReporterTest, DocValuesMissingTest, ChaosMonkeySafeLeaderTest, TestSimpleTrackingShardHandler, MetricsConfigTest, TestDynamicLoading, AutoAddReplicasPlanActionTest, TestFieldTypeResource, AlternateDirectoryTest, TestReloadAndDeleteDocs, TestCorePropertiesReload, NodeAddedTriggerIntegrationTest, TestRawResponseWriter, SortByFunctionTest, TransactionLogTest]
[junit4] Completed [186/811 (2!)] on J1 in 0.01s, 1 test, 1 error <<< FAILURES!
[...truncated 45979 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2057/consoleText
[repro] Revision: 9b61121ffb65d59f49429aba99b1c1b641ddb3c6
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line: ant test -Dtestcase=MaxSizeAutoCommitTest -Dtests.method=deleteTest -Dtests.seed=A21F6220B631ED93 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=te -Dtests.timezone=America/Argentina/Tucuman -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[repro] Repro line: ant test -Dtestcase=TransactionLogTest -Dtests.method=testBigLastAddSize -Dtests.seed=A21F6220B631ED93 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sq-XK -Dtests.timezone=America/Montserrat -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] MaxSizeAutoCommitTest
[repro] TransactionLogTest
[repro] ant compile-test
[...truncated 3322 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 -Dtests.class="*.MaxSizeAutoCommitTest|*.TransactionLogTest" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=A21F6220B631ED93 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=te -Dtests.timezone=America/Argentina/Tucuman -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[...truncated 36 lines...]
[junit4] Suite: org.apache.solr.update.TransactionLogTest
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TransactionLogTest -Dtests.method=testBigLastAddSize -Dtests.seed=A21F6220B631ED93 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=te -Dtests.timezone=America/Argentina/Tucuman -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.01s J2 | TransactionLogTest.testBigLastAddSize <<<
[junit4] > Throwable #1: java.lang.NumberFormatException: For input string: "000000000000000000014604988058574180280"
[junit4] > at __randomizedtesting.SeedInfo.seed([A21F6220B631ED93:BAE5CC8B5F7F1192]:0)
[junit4] > at java.base/java.lang.NumberFormatException.forInputString(NumberFormatException.java:65)
[junit4] > at java.base/java.lang.Long.parseLong(Long.java:692)
[junit4] > at java.base/java.lang.Long.parseLong(Long.java:817)
[junit4] > at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:153)
[junit4] > at org.apache.solr.update.TransactionLog.<init>(TransactionLog.java:141)
[junit4] > at org.apache.solr.update.TransactionLogTest.testBigLastAddSize(TransactionLogTest.java:34)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1859, maxMBSortInHeap=5.912483190163807, sim=RandomSimilarity(queryNorm=true): {}, locale=te, timezone=America/Argentina/Tucuman
[junit4] 2> NOTE: Linux 4.13.0-41-generic amd64/Oracle Corporation 10.0.1 (64-bit)/cpus=8,threads=1,free=477415584,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TransactionLogTest, TransactionLogTest]
[junit4] Completed [2/10 (1!)] on J2 in 0.05s, 1 test, 1 error <<< FAILURES!
[...truncated 80 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1568: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092: There were test failures: 10 suites, 45 tests, 1 error [seed: A21F6220B631ED93]
Total time: 2 minutes 6 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.update.MaxSizeAutoCommitTest
[repro] 1/5 failed: org.apache.solr.update.TransactionLogTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=9b61121ffb65d59f49429aba99b1c1b641ddb3c6, workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #2056
Recording test results
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2