Build: https://builds.apache.org/job/Lucene-Solr-BadApples-Tests-master/87/
3 tests failed. FAILED: org.apache.solr.cloud.TestAuthenticationFramework.testBasics Error Message: Error from server at https://127.0.0.1:37768/solr/testcollection_shard1_replica_n3: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 404 Can not find: /solr/testcollection_shard1_replica_n3/update</title> </head> <body><h2>HTTP ERROR 404</h2> <p>Problem accessing /solr/testcollection_shard1_replica_n3/update. Reason: <pre> Can not find: /solr/testcollection_shard1_replica_n3/update</pre></p><hr><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.4.11.v20180605</a><hr/> </body> </html> Stack Trace: org.apache.solr.client.solrj.impl.CloudSolrClient$RouteException: Error from server at https://127.0.0.1:37768/solr/testcollection_shard1_replica_n3: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 404 Can not find: /solr/testcollection_shard1_replica_n3/update</title> </head> <body><h2>HTTP ERROR 404</h2> <p>Problem accessing /solr/testcollection_shard1_replica_n3/update. Reason: <pre> Can not find: /solr/testcollection_shard1_replica_n3/update</pre></p><hr><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.4.11.v20180605</a><hr/> </body> </html> at __randomizedtesting.SeedInfo.seed([3D1B3B37BA65E6C9:C3951B828BB8B9]:0) at org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:551) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1015) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:886) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:948) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:948) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:948) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:948) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:948) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:233) at org.apache.solr.cloud.TestAuthenticationFramework.collectionCreateSearchDeleteTwice(TestAuthenticationFramework.java:127) at org.apache.solr.cloud.TestAuthenticationFramework.testBasics(TestAuthenticationFramework.java:75) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:37768/solr/testcollection_shard1_replica_n3: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=utf-8"/> <title>Error 404 Can not find: /solr/testcollection_shard1_replica_n3/update</title> </head> <body><h2>HTTP ERROR 404</h2> <p>Problem accessing /solr/testcollection_shard1_replica_n3/update. Reason: <pre> Can not find: /solr/testcollection_shard1_replica_n3/update</pre></p><hr><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.4.11.v20180605</a><hr/> </body> </html> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.CloudSolrClient.lambda$directUpdate$0(CloudSolrClient.java:528) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ... 1 more FAILED: org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest Error Message: Tlog size exceeds the max size bound. Tlog path: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3D1B3B37BA65E6C9-001/init-core-data-001/tlog/tlog.0000000000000000002, tlog size: 1265 Stack Trace: java.lang.AssertionError: Tlog size exceeds the max size bound. Tlog path: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3D1B3B37BA65E6C9-001/init-core-data-001/tlog/tlog.0000000000000000002, tlog size: 1265 at __randomizedtesting.SeedInfo.seed([3D1B3B37BA65E6C9:2D55DEC8C1CBDF38]: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:383) at org.apache.solr.update.MaxSizeAutoCommitTest.deleteTest(MaxSizeAutoCommitTest.java:203) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.cloud.api.collections.ShardSplitTest.testSplitWithChaosMonkey Error Message: We think that split was successful but sub-shard states were not updated even after 2 minutes. Stack Trace: java.lang.AssertionError: We think that split was successful but sub-shard states were not updated even after 2 minutes. at __randomizedtesting.SeedInfo.seed([3D1B3B37BA65E6C9:B63CE8E6FB634D4D]:0) at org.junit.Assert.fail(Assert.java:93) at org.apache.solr.cloud.api.collections.ShardSplitTest.testSplitWithChaosMonkey(ShardSplitTest.java:555) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1008) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:983) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) Build Log: [...truncated 13746 lines...] [junit4] Suite: org.apache.solr.update.MaxSizeAutoCommitTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3D1B3B37BA65E6C9-001/init-core-data-001 [junit4] 2> 2095375 WARN (SUITE-MaxSizeAutoCommitTest-seed#[3D1B3B37BA65E6C9]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=17 numCloses=17 [junit4] 2> 2095375 INFO (SUITE-MaxSizeAutoCommitTest-seed#[3D1B3B37BA65E6C9]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 2095377 INFO (SUITE-MaxSizeAutoCommitTest-seed#[3D1B3B37BA65E6C9]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 2095377 INFO (SUITE-MaxSizeAutoCommitTest-seed#[3D1B3B37BA65E6C9]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 2095382 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ###Starting simpleTest [junit4] 2> 2095383 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2095384 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2095973 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2096008 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 2096261 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2096930 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2096931 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2096990 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2097008 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2097008 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2097011 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2097081 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2097095 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2097214 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2097223 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2097223 INFO (coreLoadExecutor-5653-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@53c55c5 [junit4] 2> 2097223 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2097223 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3D1B3B37BA65E6C9-001/init-core-data-001/] [junit4] 2> 2097225 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2097227 WARN (coreLoadExecutor-5653-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> 2097282 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2097282 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2097283 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2097283 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2097285 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=66.5576171875, floorSegmentMB=1.8759765625, forceMergeDeletesPctAllowed=8.949208482230127, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8701368330596397, reclaimDeletesWeight=3.661011280764526 [junit4] 2> 2097285 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7a9fc2b8[collection1] main] [junit4] 2> 2097286 WARN (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead. [junit4] 2> 2097286 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2097288 INFO (searcherExecutor-5654-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7a9fc2b8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2097288 INFO (coreLoadExecutor-5653-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1604632524770770944 [junit4] 2> 2097291 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 2097300 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1604632524776013824), 1 (1604632524782305280), 2 (1604632524783353856)]} 0 8 [junit4] 2> 2097606 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1604632525103169536), 4 (1604632525104218112), 5 (1604632525104218113)]} 0 1 [junit4] 2> 2097809 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1604632525317079040), 7 (1604632525317079041), 8 (1604632525317079042)]} 0 0 [junit4] 2> 2098011 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1604632525528891392), 10 (1604632525528891393), 11 (1604632525528891394)]} 0 0 [junit4] 2> 2098213 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1604632525739655168), 13 (1604632525739655169), 14 (1604632525739655170)]} 0 0 [junit4] 2> 2098418 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1604632525954613248), 16 (1604632525954613249), 17 (1604632525954613250)]} 0 0 [junit4] 2> 2098619 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[18 (1604632526166425600), 19 (1604632526166425601), 20 (1604632526166425602)]} 0 0 [junit4] 2> 2098820 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[21 (1604632526377189376), 22 (1604632526377189377), 23 (1604632526377189378)]} 0 0 [junit4] 2> 2099029 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[24 (1604632526594244608), 25 (1604632526594244609), 26 (1604632526595293184)]} 0 1 [junit4] 2> 2099029 INFO (commitScheduler-5657-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2099029 INFO (commitScheduler-5657-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@51590f1f commitCommandVersion:0 [junit4] 2> 2099046 INFO (commitScheduler-5657-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ef3fccb[collection1] realtime] [junit4] 2> 2099047 INFO (commitScheduler-5657-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2099081 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[27 (1604632526648770560), 28 (1604632526649819136), 29 (1604632526650867712)]} 0 1 [junit4] 2> 2099282 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ###Ending simpleTest [junit4] 2> 2099282 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 2099282 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1849179677 [junit4] 2> 2099282 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2099282 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@20f3ede1: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@47913eae [junit4] 2> 2099289 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2099289 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@10cc8bac: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4fe896bb [junit4] 2> 2099293 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2099293 INFO (TEST-MaxSizeAutoCommitTest.simpleTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7084190b: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@369031fa [junit4] 2> 2099300 INFO (coreCloseExecutor-5659-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4fe36aa8 [junit4] 2> 2099300 INFO (coreCloseExecutor-5659-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=4fe36aa8 [junit4] 2> 2099300 INFO (coreCloseExecutor-5659-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@314bea91: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@70a9894f [junit4] 2> 2099310 INFO (coreCloseExecutor-5659-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 2099310 INFO (coreCloseExecutor-5659-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@51590f1f commitCommandVersion:0 [junit4] 2> 2099323 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ###Starting endToEndTest {seed=[3D1B3B37BA65E6C9:274D54015AD7C1CB]} [junit4] 2> 2099323 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2099324 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2099351 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2099366 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 2099498 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2099747 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2099747 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2099770 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2099797 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2099797 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2099800 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2099833 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2099847 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2100044 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2100052 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2100053 INFO (coreLoadExecutor-5669-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@53c55c5 [junit4] 2> 2100053 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2100053 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3D1B3B37BA65E6C9-001/init-core-data-001/] [junit4] 2> 2100064 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2100105 WARN (coreLoadExecutor-5669-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> 2100163 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2100164 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2100165 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2100165 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2100166 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=66.5576171875, floorSegmentMB=1.8759765625, forceMergeDeletesPctAllowed=8.949208482230127, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8701368330596397, reclaimDeletesWeight=3.661011280764526 [junit4] 2> 2100167 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@61c36845[collection1] main] [junit4] 2> 2100167 WARN (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead. [junit4] 2> 2100168 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2100168 INFO (coreLoadExecutor-5669-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1604632527790669824 [junit4] 2> 2100171 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 2100175 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1604632527794864128), 1 (1604632527795912704), 2 (1604632527795912705), 3 (1604632527795912706), 4 (1604632527795912707), 5 (1604632527795912708), 6 (1604632527796961280), 7 (1604632527796961281), 8 (1604632527796961282), 9 (1604632527796961283), ... (20 adds)]} 0 3 [junit4] 2> 2100176 INFO (searcherExecutor-5670-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@61c36845[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2100376 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=204 [junit4] 2> 2100381 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[20 (1604632528011919360), 21 (1604632528011919361), 22 (1604632528011919362), 23 (1604632528011919363), 24 (1604632528011919364), 25 (1604632528011919365), 26 (1604632528011919366), 27 (1604632528012967936), 28 (1604632528012967937), 29 (1604632528012967938), ... (20 adds)]} 0 1 [junit4] 2> 2100584 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=412 [junit4] 2> 2100586 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[40 (1604632528226877440), 41 (1604632528226877441), 42 (1604632528226877442), 43 (1604632528226877443), 44 (1604632528227926016), 45 (1604632528227926017), 46 (1604632528227926018), 47 (1604632528227926019), 48 (1604632528227926020), 49 (1604632528227926021), ... (20 adds)]} 0 2 [junit4] 2> 2100787 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=615 [junit4] 2> 2100790 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[60 (1604632528440786944), 61 (1604632528440786945), 62 (1604632528440786946), 63 (1604632528440786947), 64 (1604632528440786948), 65 (1604632528440786949), 66 (1604632528441835520), 67 (1604632528441835521), 68 (1604632528441835522), 69 (1604632528441835523), ... (20 adds)]} 0 1 [junit4] 2> 2100995 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=823 [junit4] 2> 2100998 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[80 (1604632528658890752), 81 (1604632528658890753), 82 (1604632528658890754), 83 (1604632528658890755), 84 (1604632528658890756), 85 (1604632528658890757), 86 (1604632528658890758), 87 (1604632528658890759), 88 (1604632528658890760), 89 (1604632528659939328), ... (20 adds)]} 0 2 [junit4] 2> 2101198 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1027 [junit4] 2> 2101207 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[100 (1604632528878043136), 101 (1604632528878043137), 102 (1604632528878043138), 103 (1604632528879091712), 104 (1604632528879091713), 105 (1604632528879091714), 106 (1604632528879091715), 107 (1604632528879091716), 108 (1604632528879091717), 109 (1604632528879091718), ... (20 adds)]} 0 8 [junit4] 2> 2101408 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1236 [junit4] 2> 2101410 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[120 (1604632529090904064), 121 (1604632529090904065), 122 (1604632529091952640), 123 (1604632529091952641), 124 (1604632529091952642), 125 (1604632529091952643), 126 (1604632529091952644), 127 (1604632529091952645), 128 (1604632529091952646), 129 (1604632529091952647), ... (20 adds)]} 0 2 [junit4] 2> 2101411 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2101411 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c871d8 commitCommandVersion:0 [junit4] 2> 2101422 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@524fa77a[collection1] realtime] [junit4] 2> 2101422 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2101461 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1289 [junit4] 2> 2101463 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[140 (1604632529146478592), 141 (1604632529147527168), 142 (1604632529147527169), 143 (1604632529147527170), 144 (1604632529147527171), 145 (1604632529147527172), 146 (1604632529147527173), 147 (1604632529147527174), 148 (1604632529147527175), 149 (1604632529147527176), ... (20 adds)]} 0 2 [junit4] 2> 2101664 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1492 [junit4] 2> 2101666 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[160 (1604632529359339520), 161 (1604632529360388096), 162 (1604632529360388097), 163 (1604632529360388098), 164 (1604632529360388099), 165 (1604632529360388100), 166 (1604632529360388101), 167 (1604632529360388102), 168 (1604632529360388103), 169 (1604632529360388104), ... (20 adds)]} 0 1 [junit4] 2> 2101867 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1695 [junit4] 2> 2101869 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[180 (1604632529573249024), 181 (1604632529573249025), 182 (1604632529573249026), 183 (1604632529573249027), 184 (1604632529573249028), 185 (1604632529573249029), 186 (1604632529573249030), 187 (1604632529573249031), 188 (1604632529573249032), 189 (1604632529573249033), ... (20 adds)]} 0 1 [junit4] 2> 2102070 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1898 [junit4] 2> 2102072 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[200 (1604632529786109952), 201 (1604632529786109953), 202 (1604632529786109954), 203 (1604632529786109955), 204 (1604632529786109956), 205 (1604632529786109957), 206 (1604632529786109958), 207 (1604632529786109959), 208 (1604632529786109960), 209 (1604632529786109961), ... (20 adds)]} 0 1 [junit4] 2> 2102274 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2102 [junit4] 2> 2102276 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[220 (1604632529998970880), 221 (1604632529998970881), 222 (1604632529998970882), 223 (1604632530000019456), 224 (1604632530000019457), 225 (1604632530000019458), 226 (1604632530000019459), 227 (1604632530000019460), 228 (1604632530000019461), 229 (1604632530000019462), ... (20 adds)]} 0 1 [junit4] 2> 2102477 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2305 [junit4] 2> 2102479 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[240 (1604632530211831808), 241 (1604632530212880384), 242 (1604632530212880385), 243 (1604632530212880386), 244 (1604632530212880387), 245 (1604632530212880388), 246 (1604632530212880389), 247 (1604632530212880390), 248 (1604632530212880391), 249 (1604632530212880392), ... (20 adds)]} 0 1 [junit4] 2> 2102680 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2508 [junit4] 2> 2102685 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2102685 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c871d8 commitCommandVersion:0 [junit4] 2> 2102690 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[260 (1604632530424692736), 261 (1604632530425741312), 262 (1604632530425741313), 263 (1604632530425741314), 264 (1604632530425741315), 265 (1604632530427838464), 266 (1604632530427838465), 267 (1604632530427838466), 268 (1604632530427838467), 269 (1604632530427838468), ... (20 adds)]} 0 10 [junit4] 2> 2102693 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@d869778[collection1] realtime] [junit4] 2> 2102693 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2102891 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2720 [junit4] 2> 2102894 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[280 (1604632530646990848), 281 (1604632530646990849), 282 (1604632530648039424), 283 (1604632530648039425), 284 (1604632530648039426), 285 (1604632530648039427), 286 (1604632530648039428), 287 (1604632530648039429), 288 (1604632530648039430), 289 (1604632530648039431), ... (20 adds)]} 0 2 [junit4] 2> 2103095 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=2923 [junit4] 2> 2103097 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[300 (1604632530859851776), 301 (1604632530860900352), 302 (1604632530860900353), 303 (1604632530860900354), 304 (1604632530860900355), 305 (1604632530860900356), 306 (1604632530860900357), 307 (1604632530860900358), 308 (1604632530860900359), 309 (1604632530860900360), ... (20 adds)]} 0 1 [junit4] 2> 2103298 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3126 [junit4] 2> 2103300 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[320 (1604632531072712704), 321 (1604632531073761280), 322 (1604632531073761281), 323 (1604632531073761282), 324 (1604632531073761283), 325 (1604632531073761284), 326 (1604632531073761285), 327 (1604632531073761286), 328 (1604632531073761287), 329 (1604632531073761288), ... (20 adds)]} 0 1 [junit4] 2> 2103501 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3329 [junit4] 2> 2103505 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[340 (1604632531288719360), 341 (1604632531288719361), 342 (1604632531288719362), 343 (1604632531288719363), 344 (1604632531288719364), 345 (1604632531288719365), 346 (1604632531288719366), 347 (1604632531288719367), 348 (1604632531288719368), 349 (1604632531288719369), ... (20 adds)]} 0 2 [junit4] 2> 2103711 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3539 [junit4] 2> 2103713 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[360 (1604632531505774592), 361 (1604632531505774593), 362 (1604632531505774594), 363 (1604632531506823168), 364 (1604632531506823169), 365 (1604632531506823170), 366 (1604632531506823171), 367 (1604632531506823172), 368 (1604632531506823173), 369 (1604632531506823174), ... (20 adds)]} 0 1 [junit4] 2> 2103914 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3742 [junit4] 2> 2103916 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[380 (1604632531718635520), 381 (1604632531719684096), 382 (1604632531719684097), 383 (1604632531719684098), 384 (1604632531719684099), 385 (1604632531719684100), 386 (1604632531719684101), 387 (1604632531719684102), 388 (1604632531719684103), 389 (1604632531719684104), ... (20 adds)]} 0 2 [junit4] 2> 2104117 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=3945 [junit4] 2> 2104128 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[400 (1604632531931496448), 401 (1604632531932545024), 402 (1604632531932545025), 403 (1604632531932545026), 404 (1604632531932545027), 405 (1604632531932545028), 406 (1604632531932545029), 407 (1604632531932545030), 408 (1604632531941982208), 409 (1604632531941982209), ... (20 adds)]} 0 10 [junit4] 2> 2104128 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2104128 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c871d8 commitCommandVersion:0 [junit4] 2> 2104132 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1beb239c[collection1] realtime] [junit4] 2> 2104132 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2104178 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4006 [junit4] 2> 2104182 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[420 (1604632531996508160), 421 (1604632531997556736), 422 (1604632531997556737), 423 (1604632531997556738), 424 (1604632531998605312), 425 (1604632531998605313), 426 (1604632531998605314), 427 (1604632531998605315), 428 (1604632531998605316), 429 (1604632531998605317), ... (20 adds)]} 0 3 [junit4] 2> 2104383 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4211 [junit4] 2> 2104385 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[440 (1604632532210417664), 441 (1604632532210417665), 442 (1604632532210417666), 443 (1604632532210417667), 444 (1604632532211466240), 445 (1604632532211466241), 446 (1604632532211466242), 447 (1604632532211466243), 448 (1604632532211466244), 449 (1604632532211466245), ... (20 adds)]} 0 1 [junit4] 2> 2104586 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4414 [junit4] 2> 2104587 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[460 (1604632532423278592), 461 (1604632532423278593), 462 (1604632532423278594), 463 (1604632532423278595), 464 (1604632532423278596), 465 (1604632532423278597), 466 (1604632532423278598), 467 (1604632532424327168), 468 (1604632532424327169), 469 (1604632532424327170), ... (20 adds)]} 0 1 [junit4] 2> 2104788 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4616 [junit4] 2> 2104792 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[480 (1604632532638236672), 481 (1604632532638236673), 482 (1604632532638236674), 483 (1604632532638236675), 484 (1604632532638236676), 485 (1604632532638236677), 486 (1604632532638236678), 487 (1604632532638236679), 488 (1604632532638236680), 489 (1604632532639285248), ... (20 adds)]} 0 1 [junit4] 2> 2104993 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=4821 [junit4] 2> 2104995 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1604632532851097600), 501 (1604632532851097601), 502 (1604632532851097602), 503 (1604632532851097603), 504 (1604632532851097604), 505 (1604632532851097605), 506 (1604632532851097606), 507 (1604632532851097607), 508 (1604632532851097608), 509 (1604632532851097609), ... (20 adds)]} 0 1 [junit4] 2> 2105196 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5024 [junit4] 2> 2105198 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[520 (1604632533062909952), 521 (1604632533063958528), 522 (1604632533063958529), 523 (1604632533063958530), 524 (1604632533063958531), 525 (1604632533063958532), 526 (1604632533063958533), 527 (1604632533063958534), 528 (1604632533063958535), 529 (1604632533063958536), ... (20 adds)]} 0 1 [junit4] 2> 2105399 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5227 [junit4] 2> 2105401 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[540 (1604632533275770880), 541 (1604632533276819456), 542 (1604632533276819457), 543 (1604632533276819458), 544 (1604632533276819459), 545 (1604632533276819460), 546 (1604632533276819461), 547 (1604632533276819462), 548 (1604632533276819463), 549 (1604632533276819464), ... (20 adds)]} 0 1 [junit4] 2> 2105402 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2105402 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c871d8 commitCommandVersion:0 [junit4] 2> 2105416 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@37868ccb[collection1] realtime] [junit4] 2> 2105416 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2105452 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5280 [junit4] 2> 2105467 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[560 (1604632533331345408), 561 (1604632533346025472), 562 (1604632533346025473), 563 (1604632533346025474), 564 (1604632533346025475), 565 (1604632533346025476), 566 (1604632533346025477), 567 (1604632533346025478), 568 (1604632533346025479), 569 (1604632533346025480), ... (20 adds)]} 0 14 [junit4] 2> 2105668 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5496 [junit4] 2> 2105670 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[580 (1604632533558886400), 581 (1604632533558886401), 582 (1604632533558886402), 583 (1604632533558886403), 584 (1604632533558886404), 585 (1604632533558886405), 586 (1604632533558886406), 587 (1604632533558886407), 588 (1604632533558886408), 589 (1604632533558886409), ... (20 adds)]} 0 1 [junit4] 2> 2105873 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5701 [junit4] 2> 2105875 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[600 (1604632533773844480), 601 (1604632533773844481), 602 (1604632533773844482), 603 (1604632533773844483), 604 (1604632533773844484), 605 (1604632533773844485), 606 (1604632533773844486), 607 (1604632533773844487), 608 (1604632533773844488), 609 (1604632533773844489), ... (20 adds)]} 0 1 [junit4] 2> 2106078 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=5906 [junit4] 2> 2106080 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[620 (1604632533988802560), 621 (1604632533988802561), 622 (1604632533988802562), 623 (1604632533988802563), 624 (1604632533988802564), 625 (1604632533988802565), 626 (1604632533988802566), 627 (1604632533988802567), 628 (1604632533988802568), 629 (1604632533989851136), ... (20 adds)]} 0 1 [junit4] 2> 2106281 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6109 [junit4] 2> 2106283 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[640 (1604632534201663488), 641 (1604632534201663489), 642 (1604632534201663490), 643 (1604632534201663491), 644 (1604632534201663492), 645 (1604632534201663493), 646 (1604632534201663494), 647 (1604632534201663495), 648 (1604632534201663496), 649 (1604632534201663497), ... (20 adds)]} 0 1 [junit4] 2> 2106484 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6313 [junit4] 2> 2106486 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[660 (1604632534414524416), 661 (1604632534414524417), 662 (1604632534414524418), 663 (1604632534414524419), 664 (1604632534414524420), 665 (1604632534414524421), 666 (1604632534414524422), 667 (1604632534414524423), 668 (1604632534415572992), 669 (1604632534415572993), ... (20 adds)]} 0 1 [junit4] 2> 2106687 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6516 [junit4] 2> 2106690 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[680 (1604632534627385344), 681 (1604632534627385345), 682 (1604632534627385346), 683 (1604632534627385347), 684 (1604632534627385348), 685 (1604632534627385349), 686 (1604632534628433920), 687 (1604632534628433921), 688 (1604632534628433922), 689 (1604632534628433923), ... (20 adds)]} 0 2 [junit4] 2> 2106691 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2106691 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c871d8 commitCommandVersion:0 [junit4] 2> 2106694 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f9d158[collection1] realtime] [junit4] 2> 2106695 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2106741 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6569 [junit4] 2> 2106744 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[700 (1604632534682959872), 701 (1604632534684008448), 702 (1604632534685057024), 703 (1604632534685057025), 704 (1604632534685057026), 705 (1604632534685057027), 706 (1604632534685057028), 707 (1604632534685057029), 708 (1604632534685057030), 709 (1604632534685057031), ... (20 adds)]} 0 2 [junit4] 2> 2106945 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6773 [junit4] 2> 2106947 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[720 (1604632534896869376), 721 (1604632534896869377), 722 (1604632534897917952), 723 (1604632534897917953), 724 (1604632534897917954), 725 (1604632534897917955), 726 (1604632534897917956), 727 (1604632534897917957), 728 (1604632534897917958), 729 (1604632534897917959), ... (20 adds)]} 0 1 [junit4] 2> 2107148 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=6976 [junit4] 2> 2107150 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[740 (1604632535109730304), 741 (1604632535109730305), 742 (1604632535109730306), 743 (1604632535110778880), 744 (1604632535110778881), 745 (1604632535110778882), 746 (1604632535110778883), 747 (1604632535110778884), 748 (1604632535110778885), 749 (1604632535110778886), ... (20 adds)]} 0 1 [junit4] 2> 2107351 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7179 [junit4] 2> 2107352 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[760 (1604632535322591232), 761 (1604632535322591233), 762 (1604632535322591234), 763 (1604632535322591235), 764 (1604632535322591236), 765 (1604632535322591237), 766 (1604632535323639808), 767 (1604632535323639809), 768 (1604632535323639810), 769 (1604632535323639811), ... (20 adds)]} 0 1 [junit4] 2> 2107553 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7382 [junit4] 2> 2107555 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[780 (1604632535535452160), 781 (1604632535535452161), 782 (1604632535535452162), 783 (1604632535535452163), 784 (1604632535535452164), 785 (1604632535535452165), 786 (1604632535535452166), 787 (1604632535535452167), 788 (1604632535535452168), 789 (1604632535536500736), ... (20 adds)]} 0 1 [junit4] 2> 2107756 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7584 [junit4] 2> 2107758 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[800 (1604632535748313088), 801 (1604632535748313089), 802 (1604632535748313090), 803 (1604632535748313091), 804 (1604632535748313092), 805 (1604632535748313093), 806 (1604632535748313094), 807 (1604632535748313095), 808 (1604632535748313096), 809 (1604632535748313097), ... (20 adds)]} 0 1 [junit4] 2> 2107959 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7787 [junit4] 2> 2107961 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[820 (1604632535961174016), 821 (1604632535961174017), 822 (1604632535961174018), 823 (1604632535961174019), 824 (1604632535961174020), 825 (1604632535961174021), 826 (1604632535961174022), 827 (1604632535961174023), 828 (1604632535961174024), 829 (1604632535961174025), ... (20 adds)]} 0 1 [junit4] 2> 2107962 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2107962 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c871d8 commitCommandVersion:0 [junit4] 2> 2107966 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@108c952f[collection1] realtime] [junit4] 2> 2107966 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2108012 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=7840 [junit4] 2> 2108014 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[840 (1604632536015699968), 841 (1604632536016748544), 842 (1604632536016748545), 843 (1604632536016748546), 844 (1604632536016748547), 845 (1604632536016748548), 846 (1604632536017797120), 847 (1604632536017797121), 848 (1604632536017797122), 849 (1604632536017797123), ... (20 adds)]} 0 2 [junit4] 2> 2108216 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8044 [junit4] 2> 2108217 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[860 (1604632536229609472), 861 (1604632536229609473), 862 (1604632536229609474), 863 (1604632536229609475), 864 (1604632536229609476), 865 (1604632536229609477), 866 (1604632536230658048), 867 (1604632536230658049), 868 (1604632536230658050), 869 (1604632536230658051), ... (20 adds)]} 0 1 [junit4] 2> 2108418 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8247 [junit4] 2> 2108420 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[880 (1604632536442470400), 881 (1604632536442470401), 882 (1604632536442470402), 883 (1604632536442470403), 884 (1604632536442470404), 885 (1604632536442470405), 886 (1604632536442470406), 887 (1604632536442470407), 888 (1604632536443518976), 889 (1604632536443518977), ... (20 adds)]} 0 1 [junit4] 2> 2108621 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8449 [junit4] 2> 2108623 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[900 (1604632536655331328), 901 (1604632536655331329), 902 (1604632536655331330), 903 (1604632536655331331), 904 (1604632536655331332), 905 (1604632536655331333), 906 (1604632536655331334), 907 (1604632536655331335), 908 (1604632536655331336), 909 (1604632536655331337), ... (20 adds)]} 0 1 [junit4] 2> 2108826 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8654 [junit4] 2> 2108828 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[920 (1604632536869240832), 921 (1604632536869240833), 922 (1604632536869240834), 923 (1604632536869240835), 924 (1604632536869240836), 925 (1604632536869240837), 926 (1604632536870289408), 927 (1604632536870289409), 928 (1604632536870289410), 929 (1604632536870289411), ... (20 adds)]} 0 1 [junit4] 2> 2109028 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=8857 [junit4] 2> 2109030 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[940 (1604632537082101760), 941 (1604632537082101761), 942 (1604632537082101762), 943 (1604632537082101763), 944 (1604632537082101764), 945 (1604632537082101765), 946 (1604632537082101766), 947 (1604632537082101767), 948 (1604632537082101768), 949 (1604632537082101769), ... (20 adds)]} 0 1 [junit4] 2> 2109231 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=9059 [junit4] 2> 2109235 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2109235 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c871d8 commitCommandVersion:0 [junit4] 2> 2109238 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5424c066[collection1] realtime] [junit4] 2> 2109239 INFO (commitScheduler-5673-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2109240 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[960 (1604632537293914112), 961 (1604632537294962688), 962 (1604632537294962689), 963 (1604632537294962690), 964 (1604632537294962691), 965 (1604632537294962692), 966 (1604632537294962693), 967 (1604632537294962694), 968 (1604632537294962695), 969 (1604632537294962696), ... (20 adds)]} 0 8 [junit4] 2> 2109441 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=9269 [junit4] 2> 2109443 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[980 (1604632537514115072), 981 (1604632537514115073), 982 (1604632537515163648), 983 (1604632537515163649), 984 (1604632537515163650), 985 (1604632537515163651), 986 (1604632537515163652), 987 (1604632537515163653), 988 (1604632537515163654), 989 (1604632537515163655), ... (20 adds)]} 0 1 [junit4] 2> 2109644 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=9472 [junit4] 2> 2109644 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 2109644 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2c871d8 commitCommandVersion:0 [junit4] 2> 2109648 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@69a3d656[collection1] main] [junit4] 2> 2109650 INFO (searcherExecutor-5670-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@69a3d656[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c140) Uninverting(_1(8.0.0):c138) Uninverting(_2(8.0.0):c2) Uninverting(_3(8.0.0):c140) Uninverting(_4(8.0.0):c140) Uninverting(_5(8.0.0):c140) Uninverting(_6(8.0.0):c140) Uninverting(_7(8.0.0):c136) Uninverting(_8(8.0.0):c24)))} [junit4] 2> 2109650 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2109701 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] 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=9529 [junit4] 2> 2109703 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ###Ending endToEndTest {seed=[3D1B3B37BA65E6C9:274D54015AD7C1CB]} [junit4] 2> 2109703 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 2109703 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2050438469 [junit4] 2> 2109703 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 2109703 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@51bcc7c3: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@7c42a52d [junit4] 2> 2109710 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 2109710 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@61d1c900: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@4fe896bb [junit4] 2> 2109714 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 2109714 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6cfd51a5: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@369031fa [junit4] 2> 2109755 INFO (coreCloseExecutor-5675-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@161e4a3a [junit4] 2> 2109755 INFO (coreCloseExecutor-5675-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=161e4a3a [junit4] 2> 2109755 INFO (coreCloseExecutor-5675-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4cef1b67: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7686046 [junit4] 2> 2109770 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ###Starting endToEndTest {seed=[3D1B3B37BA65E6C9:931BE8FD6E150AE7]} [junit4] 2> 2109770 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2109771 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2109840 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2109860 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 2110312 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2110791 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 2110791 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 2110821 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2110862 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2110862 INFO (TEST-MaxSizeAutoCommitTest.endToEndTest-seed#[3D1B3B37BA65E6C9]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@53c55c5 [junit4] 2> 2110867 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2110917 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 2110961 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 2111170 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2111190 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 2111214 INFO (coreLoadExecutor-5685-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@53c55c5 [junit4] 2> 2111214 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 2111214 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J2/temp/solr.update.MaxSizeAutoCommitTest_3D1B3B37BA65E6C9-001/init-core-data-001/] [junit4] 2> 2111216 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=47, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 2111221 WARN (coreLoadExecutor-5685-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> 2111346 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2111346 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2111347 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2111347 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2111348 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=48, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=66.5576171875, floorSegmentMB=1.8759765625, forceMergeDeletesPctAllowed=8.949208482230127, segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.8701368330596397, reclaimDeletesWeight=3.661011280764526 [junit4] 2> 2111348 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@723e7952[collection1] main] [junit4] 2> 2111349 WARN (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead. [junit4] 2> 2111349 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2111349 INFO (coreLoadExecutor-5685-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using n [...truncated too long message...] e = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/null1398111468 [copy] Copying 39 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/null1398111468 [delete] Deleting directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/null1398111468 resolve-example: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: resolve-server: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: ivy-availability-check: [loadresource] Do not set property disallowed.ivy.jars.list as its length is 0. -ivy-fail-disallowed-ivy-version: ivy-fail: ivy-fail: ivy-configure: [ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/lucene/top-level-ivy-settings.xml resolve: jar-checksums: [mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null1033651815 [copy] Copying 247 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null1033651815 [delete] Deleting directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null1033651815 check-working-copy: [ivy:cachepath] :: resolving dependencies :: org.eclipse.jgit#org.eclipse.jgit-caller;working [ivy:cachepath] confs: [default] [ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public [ivy:cachepath] found com.jcraft#jsch;0.1.53 in public [ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public [ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in public [ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public [ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public [ivy:cachepath] found commons-codec#commons-codec;1.6 in public [ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public [ivy:cachepath] :: resolution report :: resolve 69ms :: artifacts dl 8ms --------------------------------------------------------------------- | | modules || artifacts | | conf | number| search|dwnlded|evicted|| number|dwnlded| --------------------------------------------------------------------- | default | 8 | 0 | 0 | 0 || 8 | 0 | --------------------------------------------------------------------- [wc-checker] Initializing working copy... [wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". [wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation [wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. [wc-checker] Checking working copy status... -jenkins-base: BUILD SUCCESSFUL Total time: 170 minutes 30 seconds Archiving artifacts WARN: No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error? WARN: java.lang.InterruptedException: no matches found within 10000 Recording test results 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)
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org