Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/136/
4 tests failed. FAILED: org.apache.solr.cloud.ForceLeaderTest.testReplicasInLIRNoLeader Error Message: Doc with id=1 not found in http://127.0.0.1:38337/forceleader_test_collection due to: Path not found: /id; rsp={doc=null} Stack Trace: java.lang.AssertionError: Doc with id=1 not found in http://127.0.0.1:38337/forceleader_test_collection due to: Path not found: /id; rsp={doc=null} at __randomizedtesting.SeedInfo.seed([499930BAE5AABE68:AF0E047ADC284709]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.cloud.HttpPartitionTest.assertDocExists(HttpPartitionTest.java:603) at org.apache.solr.cloud.HttpPartitionTest.assertDocsExistInAllReplicas(HttpPartitionTest.java:556) at org.apache.solr.cloud.ForceLeaderTest.testReplicasInLIRNoLeader(ForceLeaderTest.java:142) 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:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968) 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:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) 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.LeaderElectionContextKeyTest.test Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([499930BAE5AABE68:C1CD0F604B56D390]:0) at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.cloud.LeaderElectionContextKeyTest.test(LeaderElectionContextKeyTest.java:88) 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:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) 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:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.lang.Thread.run(Thread.java:748) FAILED: org.apache.solr.update.AutoCommitTest.testCommitWithin Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([499930BAE5AABE68:F34B5FC26684507D]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886) at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353) 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:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) 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:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) 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: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] xml response was: <?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> </response> request was:q=id:529&qt=&start=0&rows=20&version=2.2 at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879) ... 40 more FAILED: org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testDistributions Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([76E02C3246FD2369:C91F6D989807C3F5]:0) at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testDistributions(StreamExpressionTest.java:6056) 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:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) 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:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) 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 11794 lines...] [junit4] Suite: org.apache.solr.update.AutoCommitTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_499930BAE5AABE68-001/init-core-data-001 [junit4] 2> 1229915 WARN (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 1229915 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 1229916 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 1229917 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 1229917 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1229918 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1229941 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1230003 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 1230147 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1230186 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2e3b83b2 [junit4] 2> 1230189 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2e3b83b2 [junit4] 2> 1230189 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2e3b83b2 [junit4] 2> 1230203 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1230248 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1230293 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1230509 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1230533 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1230535 INFO (coreLoadExecutor-4694-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@2e3b83b2 [junit4] 2> 1230535 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1230535 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_499930BAE5AABE68-001/init-core-data-001/] [junit4] 2> 1230538 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=30, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 1230651 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1230651 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1230652 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1230652 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1230653 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=37, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=60.283203125, floorSegmentMB=0.9453125, forceMergeDeletesPctAllowed=27.5498244395796, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.28442195219432453 [junit4] 2> 1230653 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e655d5c[collection1] main] [junit4] 2> 1230654 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1230666 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1230691 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1230691 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1230691 INFO (coreLoadExecutor-4694-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1575498529394130944 [junit4] 2> 1230692 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1230692 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1230692 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1230692 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1230692 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1230692 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1230692 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1230693 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1230693 INFO (searcherExecutor-4695-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5e655d5c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1230694 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1230696 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime [junit4] 2> 1230696 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1230696 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@ba0fff4[collection1] realtime] [junit4] 2> 1230696 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 0 [junit4] 2> 1230697 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 1230697 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1230740 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1230785 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1230986 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1231021 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1 [junit4] 2> 1231062 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ 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@2e3b83b2 [junit4] 2> 1231062 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_499930BAE5AABE68-001/init-core-data-001/] [junit4] 2> 1231175 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1231175 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1231176 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3948ca57[collection1] main] [junit4] 2> 1231177 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1231177 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1231181 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1231182 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1575498529908981760 [junit4] 2> 1231182 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1231187 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1231187 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1231187 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1231187 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1231188 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=21, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=88.6484375, floorSegmentMB=0.779296875, forceMergeDeletesPctAllowed=24.23835560469157, segmentsPerTier=45.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.3732984808701274 [junit4] 2> 1231188 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1231189 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1231189 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1231189 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1231189 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1231191 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3948ca57[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1231191 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2bf036cd[collection1] main] [junit4] 2> 1231192 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@41096817 [junit4] 2> 1231193 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1091135511 [junit4] 2> 1231193 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2bf036cd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1231217 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1575498529936244736)]} 0 11 [junit4] 2> 1231217 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1232717 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 1232724 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6be35cc4[collection1] main] [junit4] 2> 1232725 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6be35cc4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):C1)))} [junit4] 2> 1232725 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1232971 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1575498531784884224)]} 0 1765 [junit4] 2> 1232972 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1232972 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1232973 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[529 (-1575498531786981376)]} 0 0 [junit4] 2> 1232973 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1234471 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 1234474 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@507a3feb[collection1] main] [junit4] 2> 1234481 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1234483 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@507a3feb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C1)))} [junit4] 2> 1234726 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 (1575498533624086528)]} 0 3519 [junit4] 2> 1234726 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1234726 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533625135104)]} 0 3520 [junit4] 2> 1234727 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533626183680)]} 0 3520 [junit4] 2> 1234727 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533626183681)]} 0 3521 [junit4] 2> 1234727 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533626183682)]} 0 3521 [junit4] 2> 1234727 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533626183683)]} 0 3521 [junit4] 2> 1234727 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533626183684)]} 0 3521 [junit4] 2> 1234727 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533626183685)]} 0 3521 [junit4] 2> 1234727 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533626183686)]} 0 3521 [junit4] 2> 1234728 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533627232256)]} 0 3521 [junit4] 2> 1234728 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1575498533627232257)]} 0 3521 [junit4] 2> 1234728 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1236226 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 1236228 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@15f7fd0[collection1] main] [junit4] 2> 1236228 INFO (commitScheduler-4703-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1236230 INFO (searcherExecutor-4700-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15f7fd0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C1) Uninverting(_2(7.1.0):C11/9:delGen=1)))} [junit4] 2> 1236230 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 (1575498535202193408)]} 0 5024 [junit4] 2> 1236230 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1236231 INFO (TEST-AutoCommitTest.testMaxTime-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime [junit4] 2> 1236233 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs [junit4] 2> 1236233 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1236233 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@413abd65[collection1] realtime] [junit4] 2> 1236233 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 0 [junit4] 2> 1236234 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 1236234 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1236304 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1236330 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1236500 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1236506 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1 [junit4] 2> 1236519 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ 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@2e3b83b2 [junit4] 2> 1236519 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_499930BAE5AABE68-001/init-core-data-001/] [junit4] 2> 1236581 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1236581 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1236582 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@476a158b[collection1] main] [junit4] 2> 1236583 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1236583 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1236586 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1236588 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1236589 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=16, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 1236589 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1236589 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1236589 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1236589 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1236589 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1236589 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1236590 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1236590 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1236590 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1236592 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@476a158b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1236592 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@553bd922[collection1] main] [junit4] 2> 1236592 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@19ebec16 [junit4] 2> 1236592 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=434891798 [junit4] 2> 1236595 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1575498535583875072)]} 0 0 [junit4] 2> 1236595 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1575498535584923648)]} 0 0 [junit4] 2> 1236595 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1575498535584923649)]} 0 0 [junit4] 2> 1236595 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1575498535584923650)]} 0 1 [junit4] 2> 1236598 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1575498535588069376)]} 0 4 [junit4] 2> 1236599 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1575498535589117952)]} 0 4 [junit4] 2> 1236599 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1575498535589117953)]} 0 4 [junit4] 2> 1236599 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1575498535589117954)]} 0 4 [junit4] 2> 1236599 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1575498535589117955)]} 0 5 [junit4] 2> 1236599 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1575498535589117956)]} 0 5 [junit4] 2> 1236600 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1575498535590166528)]} 0 5 [junit4] 2> 1236600 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1575498535590166529)]} 0 5 [junit4] 2> 1236600 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1575498535590166530)]} 0 5 [junit4] 2> 1236601 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1575498535590166531)]} 0 6 [junit4] 2> 1236601 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@553bd922[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1236601 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1236602 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1575498535592263680)]} 0 7 [junit4] 2> 1236604 INFO (commitScheduler-4707-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 1236606 INFO (commitScheduler-4707-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3e26d223[collection1] main] [junit4] 2> 1236608 INFO (searcherExecutor-4704-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3e26d223[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.1.0):C15)))} [junit4] 2> 1236609 INFO (commitScheduler-4707-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1236853 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1575498535854407680)]} 0 258 [junit4] 2> 1236853 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:14&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 1236854 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:15&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1236854 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs [junit4] 2> 1236856 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin [junit4] 2> 1236856 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1236856 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4abaa68e[collection1] realtime] [junit4] 2> 1236856 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:* (-9223372036854775807)} 0 0 [junit4] 2> 1236856 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 1236857 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1236930 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1236982 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1237171 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1237177 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1 [junit4] 2> 1237222 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ 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@2e3b83b2 [junit4] 2> 1237223 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_499930BAE5AABE68-001/init-core-data-001/] [junit4] 2> 1237277 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1237277 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1237278 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@54bdc194[collection1] main] [junit4] 2> 1237278 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1237279 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1237281 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1237283 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1237284 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=98.369140625, floorSegmentMB=1.7412109375, forceMergeDeletesPctAllowed=7.725711583690903, segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.18358191785207076 [junit4] 2> 1237284 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1237284 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1237284 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1237284 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1237284 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1237284 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1237285 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1237285 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1237285 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1237287 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@54bdc194[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1237287 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2c48a710[collection1] main] [junit4] 2> 1237287 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1ea3b1dc [junit4] 2> 1237287 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=514044380 [junit4] 2> 1237293 INFO (searcherExecutor-4708-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2c48a710[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1237293 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1575498536315781120)]} 0 1 [junit4] 2> 1237294 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1237294 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1575498536317878272)]} 0 2 [junit4] 2> 1237294 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1237295 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1575498536317878273)]} 0 2 [junit4] 2> 1237295 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 1237295 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] 2> </response> [junit4] 2> [junit4] 2> request was:q=id:529&qt=&start=0&rows=20&version=2.2 [junit4] 2> 1237295 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=id:529&qt=&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] 2> </response> [junit4] 2> [junit4] 2> request was:q=id:529&qt=&start=0&rows=20&version=2.2 [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879) [junit4] 2> at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> [junit4] 2> 1237296 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[499930BAE5AABE68]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest -Dtests.method=testCommitWithin -Dtests.seed=499930BAE5AABE68 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=de-CH -Dtests.timezone=Europe/Kaliningrad -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] ERROR 0.44s J1 | AutoCommitTest.testCommitWithin <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([499930BAE5AABE68:F34B5FC26684507D]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:886) [junit4] > at org.apache.solr.update.AutoCommitTest.testCommitWithin(AutoCommitTest.java:353) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=//result[@numFound=1] [junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] > <response> [junit4] > <lst name="responseHeader"><int name="status">0</int><int name="QTime">0</int></lst><result name="response" numFound="0" start="0"></result> [junit4] > </response> [junit4] > request was:q=id:529&qt=&start=0&rows=20&version=2.2 [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:879) [junit4] > ... 40 more [junit4] 2> 1237297 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1237297 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2125389253 [junit4] 2> 1237297 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1237298 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1237299 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1237299 INFO (SUITE-AutoCommitTest-seed#[499930BAE5AABE68]-worker) [ x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1237299 INFO (coreCloseExecutor-4712-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@48432ed [junit4] 2> 1237300 INFO (coreCloseExecutor-4712-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 1237300 INFO (coreCloseExecutor-4712-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5bd5ca48 commitCommandVersion:0 [junit4] 2> 1237334 INFO (coreCloseExecutor-4712-thread-1-processing-x:collection1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=75772653 [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_499930BAE5AABE68-001 [junit4] 2> Aug 12, 2017 4:34:49 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 4 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=true): {}, locale=de-CH, timezone=Europe/Kaliningrad [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=4,threads=1,free=143242208,total=516423680 [junit4] 2> NOTE: All tests run in this JVM: [TestAddFieldRealTimeGet, HdfsBasicDistributedZk2Test, DistributedFacetPivotLongTailTest, SolrCLIZkUtilsTest, TestManagedSynonymFilterFactory, TestMultiValuedNumericRangeQuery, DirectSolrConnectionTest, TestAuthenticationFramework, TestCloudSchemaless, TestSerializedLuceneMatchVersion, OpenCloseCoreStressTest, TestReRankQParserPlugin, TestNumericTokenStream, TestBM25SimilarityFactory, ResourceLoaderTest, TestExclusionRuleCollectionAccess, TestCloudNestedDocsSort, MetricsConfigTest, TestSolr4Spatial2, DistributedVersionInfoTest, TestSimpleTrackingShardHandler, TestUseDocValuesAsStored, SpatialFilterTest, LoggingHandlerTest, DateRangeFieldTest, MoveReplicaHDFSUlogDirTest, CollectionsAPIDistributedZkTest, TestLeaderElectionZkExpiry, SampleTest, TestSolrConfigHandlerConcurrent, SOLR749Test, TestJavabinTupleStreamParser, TestAtomicUpdateErrorCases, MoreLikeThisHandlerTest, ZkControllerTest, ManagedSchemaRoundRobinCloudTest, SimpleMLTQParserTest, TestMacroExpander, LeaderFailureAfterFreshStartTest, TestXmlQParser, TestStressVersions, CSVRequestHandlerTest, SolrGraphiteReporterTest, SSLMigrationTest, TestConfigSetsAPIExclusivity, ChaosMonkeySafeLeaderWithPullReplicasTest, DistributedFacetPivotWhiteBoxTest, ScriptEngineTest, HLLUtilTest, TestMissingGroups, CacheHeaderTest, HttpPartitionTest, StatelessScriptUpdateProcessorFactoryTest, TestBlobHandler, TestJsonFacets, WrapperMergePolicyFactoryTest, HighlighterTest, TestDefaultStatsCache, TestCoreContainer, TestInfoStreamLogging, TestExactStatsCache, CloneFieldUpdateProcessorFactoryTest, SolrCloudReportersTest, SliceStateTest, AnalyticsQueryTest, BasicAuthStandaloneTest, ConvertedLegacyTest, FileBasedSpellCheckerTest, UUIDUpdateProcessorFallbackTest, TestLRUCache, DistribDocExpirationUpdateProcessorTest, ConfigureRecoveryStrategyTest, IndexSchemaRuntimeFieldTest, TermVectorComponentTest, BlockJoinFacetRandomTest, TestCloudRecovery, TestManagedResource, TestZkAclsWithHadoopAuth, V2StandaloneTest, TestSolrConfigHandler, PrimUtilsTest, TestInitQParser, SolrMetricReporterTest, TestPrepRecovery, ExitableDirectoryReaderTest, PropertiesRequestHandlerTest, TestValueSourceCache, DisMaxRequestHandlerTest, TestSubQueryTransformer, TestTestInjection, TestCollectionAPI, CreateCollectionCleanupTest, SystemInfoHandlerTest, TestSolrIndexConfig, FileUtilsTest, DOMUtilTest, TestManagedSchema, ReplicaListTransformerTest, IndexSchemaTest, TestElisionMultitermQuery, TestPKIAuthenticationPlugin, ConcurrentDeleteAndCreateCollectionTest, VMParamsZkACLAndCredentialsProvidersTest, TestStressRecovery, CoreMergeIndexesAdminHandlerTest, MigrateRouteKeyTest, AddSchemaFieldsUpdateProcessorFactoryTest, CoreAdminHandlerTest, TestDeleteCollectionOnDownNodes, TestExceedMaxTermLength, TestSQLHandler, ImplicitSnitchTest, DistributedMLTComponentTest, SpellCheckComponentTest, TestCursorMarkWithoutUniqueKey, TestCharFilters, TestEmbeddedSolrServerSchemaAPI, SmileWriterTest, CollectionTooManyReplicasTest, BooleanFieldTest, TestPostingsSolrHighlighter, UnloadDistributedZkTest, BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, TestZkChroot, ShardRoutingCustomTest, AutoCommitTest] [junit4] Completed [320/728 (1!)] on J1 in 7.72s, 3 tests, 1 error <<< FAILURES! [...truncated 559 lines...] [junit4] Suite: org.apache.solr.cloud.LeaderElectionContextKeyTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_499930BAE5AABE68-001/init-core-data-001 [junit4] 2> 1535393 WARN (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=51 numCloses=51 [junit4] 2> 1535393 INFO (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 1535394 INFO (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 1535395 INFO (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 1535395 INFO (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_499930BAE5AABE68-001/tempDir-001 [junit4] 2> 1535395 INFO (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1535396 INFO (Thread-5951) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1535396 INFO (Thread-5951) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1535402 ERROR (Thread-5951) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 1535496 INFO (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:45883 [junit4] 2> 1535507 INFO (jetty-launcher-2098-thread-1) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 1535508 INFO (jetty-launcher-2098-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@16e362b5{/solr,null,AVAILABLE} [junit4] 2> 1535509 INFO (jetty-launcher-2098-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7b12bf9f{SSL,[ssl, http/1.1]}{127.0.0.1:60236} [junit4] 2> 1535509 INFO (jetty-launcher-2098-thread-1) [ ] o.e.j.s.Server Started @1542539ms [junit4] 2> 1535509 INFO (jetty-launcher-2098-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=60236} [junit4] 2> 1535510 ERROR (jetty-launcher-2098-thread-1) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1535510 INFO (jetty-launcher-2098-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.1.0 [junit4] 2> 1535511 INFO (jetty-launcher-2098-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1535511 INFO (jetty-launcher-2098-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config dir: null [junit4] 2> 1535511 INFO (jetty-launcher-2098-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-08-12T04:39:51.332Z [junit4] 2> 1535512 INFO (jetty-launcher-2098-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1535539 INFO (jetty-launcher-2098-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45883/solr [junit4] 2> 1535598 INFO (jetty-launcher-2098-thread-1) [n:127.0.0.1:60236_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 1535598 INFO (jetty-launcher-2098-thread-1) [n:127.0.0.1:60236_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60236_solr [junit4] 2> 1535599 INFO (jetty-launcher-2098-thread-1) [n:127.0.0.1:60236_solr ] o.a.s.c.Overseer Overseer (id=98468678285197315-127.0.0.1:60236_solr-n_0000000000) starting [junit4] 2> 1535603 INFO (jetty-launcher-2098-thread-1) [n:127.0.0.1:60236_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60236_solr [junit4] 2> 1535610 INFO (zkCallback-2105-thread-1-processing-n:127.0.0.1:60236_solr) [n:127.0.0.1:60236_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1535669 INFO (jetty-launcher-2098-thread-1) [n:127.0.0.1:60236_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_60236.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46b3a845 [junit4] 2> 1535672 INFO (jetty-launcher-2098-thread-1) [n:127.0.0.1:60236_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_60236.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46b3a845 [junit4] 2> 1535672 INFO (jetty-launcher-2098-thread-1) [n:127.0.0.1:60236_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_60236.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46b3a845 [junit4] 2> 1535673 INFO (jetty-launcher-2098-thread-1) [n:127.0.0.1:60236_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_499930BAE5AABE68-001/tempDir-001/node1/. [junit4] 2> 1535686 INFO (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1535686 INFO (SUITE-LeaderElectionContextKeyTest-seed#[499930BAE5AABE68]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45883/solr ready [junit4] 2> 1535715 INFO (qtp2059570099-17132) [n:127.0.0.1:60236_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=config&maxShardsPerNode=1000&name=testCollection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 1535717 INFO (OverseerThreadFactory-6658-thread-1-processing-n:127.0.0.1:60236_solr) [n:127.0.0.1:60236_solr ] o.a.s.c.CreateCollectionCmd Create collection testCollection1 [junit4] 2> 1535822 INFO (OverseerStateUpdate-98468678285197315-127.0.0.1:60236_solr-n_0000000000) [n:127.0.0.1:60236_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testCollection1", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testCollection1_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:60236/solr";, [junit4] 2> "type":"NRT"} [junit4] 2> 1535824 INFO (OverseerStateUpdate-98468678285197315-127.0.0.1:60236_solr-n_0000000000) [n:127.0.0.1:60236_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testCollection1", [junit4] 2> "shard":"shard2", [junit4] 2> "core":"testCollection1_shard2_replica_n2", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:60236/solr";, [junit4] 2> "type":"NRT"} [junit4] 2> 1536039 INFO (qtp2059570099-17129) [n:127.0.0.1:60236_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=config&newCollection=true&name=testCollection1_shard1_replica_n1&action=CREATE&numShards=2&collection=testCollection1&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 1536039 INFO (qtp2059570099-17130) [n:127.0.0.1:60236_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=config&newCollection=true&name=testCollection1_shard2_replica_n2&action=CREATE&numShards=2&collection=testCollection1&shard=shard2&wt=javabin&version=2&replicaType=NRT [junit4] 2> 1536040 INFO (qtp2059570099-17130) [n:127.0.0.1:60236_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1536148 INFO (zkCallback-2105-thread-1-processing-n:127.0.0.1:60236_solr) [n:127.0.0.1:60236_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection1/state.json] for collection [testCollection1] has occurred - updating... (live nodes size: [1]) [junit4] 2> 1536148 INFO (zkCallback-2105-thread-2-processing-n:127.0.0.1:60236_solr) [n:127.0.0.1:60236_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCollection1/state.json] for collection [testCollection1] has occurred - updating... (live nodes size: [1]) [junit4] 2> 1537055 INFO (qtp2059570099-17129) [n:127.0.0.1:60236_solr c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1537058 INFO (qtp2059570099-17130) [n:127.0.0.1:60236_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1537061 INFO (qtp2059570099-17129) [n:127.0.0.1:60236_solr c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1] o.a.s.s.IndexSchema [testCollection1_shard1_replica_n1] Schema name=minimal [junit4] 2> 1537064 INFO (qtp2059570099-17129) [n:127.0.0.1:60236_solr c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 1537064 INFO (qtp2059570099-17129) [n:127.0.0.1:60236_solr c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testCollection1_shard1_replica_n1' using configuration from collection testCollection1, trusted=true [junit4] 2> 1537064 INFO (qtp2059570099-17130) [n:127.0.0.1:60236_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2] o.a.s.s.IndexSchema [testCollection1_shard2_replica_n2] Schema name=minimal [junit4] 2> 1537072 INFO (qtp2059570099-17129) [n:127.0.0.1:60236_solr c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_60236.solr.core.testCollection1.shard1.replica_n1' (registry 'solr.core.testCollection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46b3a845 [junit4] 2> 1537072 INFO (qtp2059570099-17129) [n:127.0.0.1:60236_solr c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1537072 INFO (qtp2059570099-17129) [n:127.0.0.1:60236_solr c:testCollection1 s:shard1 r:core_node3 x:testCollection1_shard1_replica_n1] o.a.s.c.SolrCore [[testCollection1_shard1_replica_n1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_499930BAE5AABE68-001/tempDir-001/node1/testCollection1_shard1_replica_n1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.cloud.LeaderElectionContextKeyTest_499930BAE5AABE68-001/tempDir-001/node1/./testCollection1_shard1_replica_n1/data/] [junit4] 2> 1537076 INFO (qtp2059570099-17130) [n:127.0.0.1:60236_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 1537076 INFO (qtp2059570099-17130) [n:127.0.0.1:60236_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'testCollection1_shard2_replica_n2' using configuration from collection testCollection1, trusted=true [junit4] 2> 1537076 INFO (qtp2059570099-17130) [n:127.0.0.1:60236_solr c:testCollection1 s:shard2 r:core_node4 x:testCollection1_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_60236.solr.core.testCollection1.shard2.replica_n2' (registry 'solr.core.testCollection1.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@46b3a845 [junit4] 2> 1537076 INFO (qtp2059570099-17130) [n:127.0.0.1:60236_solr c: [...truncated too long message...] -130-thread-1-processing-n:127.0.0.1:60492_solr) [n:127.0.0.1:60492_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 202425 INFO (jetty-closer-110-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 202426 INFO (coreCloseExecutor-456-thread-1) [n:127.0.0.1:34454_solr c:collection1_collection s:shard1 r:core_node3 x:collection1_collection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1_collection.shard1.leader, tag=310833772 [junit4] 2> 202431 INFO (coreCloseExecutor-454-thread-1) [n:127.0.0.1:60492_solr c:collection1_collection s:shard2 r:core_node4 x:collection1_collection_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1_collection.shard2.replica_n2, tag=1183308795 [junit4] 2> 202433 INFO (coreCloseExecutor-454-thread-1) [n:127.0.0.1:60492_solr c:collection1_collection s:shard2 r:core_node4 x:collection1_collection_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1_collection.shard2.leader, tag=1183308795 [junit4] 2> 202434 INFO (jetty-closer-110-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 202435 INFO (jetty-closer-110-thread-2) [ ] o.a.s.c.Overseer Overseer (id=98468738191917068-127.0.0.1:60492_solr-n_0000000000) closing [junit4] 2> 202435 INFO (OverseerStateUpdate-98468738191917068-127.0.0.1:60492_solr-n_0000000000) [n:127.0.0.1:60492_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:60492_solr [junit4] 2> 202436 INFO (zkCallback-130-thread-2-processing-n:127.0.0.1:60492_solr) [n:127.0.0.1:60492_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 202436 INFO (zkCallback-131-thread-2-processing-n:127.0.0.1:58715_solr) [n:127.0.0.1:58715_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 202437 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15dd4cbb169000b, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> 202437 INFO (jetty-closer-110-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2daffdc1{/solr,null,UNAVAILABLE} [junit4] 2> 203917 WARN (zkCallback-128-thread-2-processing-n:127.0.0.1:41897_solr) [n:127.0.0.1:41897_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 203918 INFO (jetty-closer-110-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@46e076f9{/solr,null,UNAVAILABLE} [junit4] 2> 203933 WARN (zkCallback-129-thread-1-processing-n:127.0.0.1:34454_solr) [n:127.0.0.1:34454_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 203933 INFO (jetty-closer-110-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7088830a{/solr,null,UNAVAILABLE} [junit4] 2> 203938 WARN (zkCallback-130-thread-2-processing-n:127.0.0.1:60492_solr) [n:127.0.0.1:60492_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 203938 INFO (jetty-closer-110-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1a567ab8{/solr,null,UNAVAILABLE} [junit4] 2> 203939 ERROR (SUITE-StreamExpressionTest-seed#[76E02C3246FD2369]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 203939 INFO (SUITE-StreamExpressionTest-seed#[76E02C3246FD2369]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59164 59164 [junit4] 2> 204026 INFO (Thread-159) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59164 59164 [junit4] 2> 204027 WARN (Thread-159) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 74 /solr/aliases.json [junit4] 2> 11 /solr/configs/conf [junit4] 2> 4 /solr/security.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 74 /solr/clusterprops.json [junit4] 2> 74 /solr/clusterstate.json [junit4] 2> 20 /solr/collections/destination/state.json [junit4] 2> 20 /solr/collections/parallelDestinationCollection/state.json [junit4] 2> 20 /solr/collections/workQueue/state.json [junit4] 2> 20 /solr/collections/destinationCollection/state.json [junit4] 2> 20 /solr/collections/mainCorpus/state.json [junit4] 2> 18 /solr/collections/parallelDestinationCollection1/state.json [junit4] 2> 10 /solr/collections/collection1_collection/state.json [junit4] 2> 2 /solr/overseer_elect/election/98468738191917068-127.0.0.1:60492_solr-n_0000000000 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 74 /solr/live_nodes [junit4] 2> 74 /solr/collections [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-solrj/test/J2/temp/solr.client.solrj.io.stream.StreamExpressionTest_76E02C3246FD2369-001 [junit4] 2> Aug 12, 2017 4:56:28 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {expr_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), join2_s=PostingsFormat(name=Asserting), multiDefault=PostingsFormat(name=Asserting), subject=PostingsFormat(name=Asserting), a1_s=PostingsFormat(name=Asserting), a2_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), level1_s=PostingsFormat(name=LuceneVarGapDocFreqInterval), test_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), ident_s=PostingsFormat(name=Asserting), body_t=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), s_multi=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), level2_s=Lucene50(blocksize=128), col_s=PostingsFormat(name=Asserting), a_ss=Lucene50(blocksize=128), a_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), a_t=Lucene50(blocksize=128), side_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), id=PostingsFormat(name=LuceneVarGapDocFreqInterval), text=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))}, docValues:{expr_s=DocValuesFormat(name=Lucene70), join2_s=DocValuesFormat(name=Asserting), multiDefault=DocValuesFormat(name=Asserting), price_f=DocValuesFormat(name=Asserting), a1_s=DocValuesFormat(name=Asserting), a_f=DocValuesFormat(name=Asserting), intDefault=DocValuesFormat(name=Lucene70), join1_i=DocValuesFormat(name=Lucene70), a2_s=DocValuesFormat(name=Memory), a_i=DocValuesFormat(name=Lucene70), join3_i=DocValuesFormat(name=Memory), test_i=DocValuesFormat(name=Asserting), field_i=DocValuesFormat(name=Asserting), level1_s=DocValuesFormat(name=Lucene70), s_multi=DocValuesFormat(name=Memory), level2_s=DocValuesFormat(name=Lucene70), col_s=DocValuesFormat(name=Asserting), a_ss=DocValuesFormat(name=Lucene70), a_s=DocValuesFormat(name=Memory), id=DocValuesFormat(name=Lucene70), timestamp=DocValuesFormat(name=Lucene70), i_multi=DocValuesFormat(name=Lucene70), b_ls=DocValuesFormat(name=Asserting), test_dt=DocValuesFormat(name=Lucene70), ident_s=DocValuesFormat(name=Asserting), order_i=DocValuesFormat(name=Asserting), _version_=DocValuesFormat(name=Lucene70), side_s=DocValuesFormat(name=Memory), miles_i=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=633, maxMBSortInHeap=6.4271913359858175, sim=RandomSimilarity(queryNorm=false): {}, locale=ar-QA, timezone=Africa/Harare [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=4,threads=1,free=243505784,total=476053504 [junit4] 2> NOTE: All tests run in this JVM: [TestDelegationTokenRequest, CommonAdminParamsTest, NamedListTest, SolrExceptionTest, TestRetryUtil, RawValueEvaluatorTest, SolrExampleJettyTest, SolrZkClientTest, FloorEvaluatorTest, LengthEvaluatorTest, SolrParamTest, EqualsEvaluatorTest, TestJavaBinCodec, CloudSolrClientCacheTest, NotEvaluatorTest, TestDelegationTokenResponse, SolrSchemalessExampleTest, SolrExampleXMLTest, SolrExampleBinaryTest, AndEvaluatorTest, HyperbolicCosineEvaluatorTest, SolrExampleStreamingBinaryTest, SolrExampleEmbeddedTest, LargeVolumeBinaryJettyTest, TestBatchUpdate, JettyWebappTest, LargeVolumeEmbeddedTest, LargeVolumeJettyTest, SolrQueryTest, TestHash, ContentStreamTest, ModifiableSolrParamsTest, TestFastInputStream, DocumentAnalysisResponseTest, TestUpdateRequestCodec, FieldAnalysisResponseTest, AnlysisResponseBaseTest, GetByIdTest, TestPolicy, CloudSolrClientMultiConstructorTest, CloudSolrClientTest, StreamExpressionTest] [junit4] Completed [135/135 (1!)] on J2 in 83.76s, 94 tests, 1 failure, 9 skipped <<< FAILURES! [...truncated 42481 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
