Build: https://builds.apache.org/job/Lucene-Solr-Tests-master/2059/
1 tests failed. FAILED: org.apache.solr.update.AutoCommitTest.testCommitWithin Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([78B8EACBF4A16770:C26A85B3778F8965]: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 Build Log: [...truncated 12033 lines...] [junit4] Suite: org.apache.solr.update.AutoCommitTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_78B8EACBF4A16770-001/init-core-data-001 [junit4] 2> 1467630 WARN (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=952 numCloses=952 [junit4] 2> 1467630 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 1467633 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 1467633 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 1467634 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1467634 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1467692 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1467720 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 1467878 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1468014 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@655921d0 [junit4] 2> 1468032 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@655921d0 [junit4] 2> 1468032 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@655921d0 [junit4] 2> 1468045 INFO (coreLoadExecutor-4601-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-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1468111 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1468173 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1468419 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1468429 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1468429 INFO (coreLoadExecutor-4601-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@655921d0 [junit4] 2> 1468429 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1468429 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_78B8EACBF4A16770-001/init-core-data-001/] [junit4] 2> 1468431 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=27, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 1468567 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1468568 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1468571 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1468571 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1468573 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=433058734, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 1468573 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6af02023[collection1] main] [junit4] 2> 1468584 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1468596 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1468638 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1468638 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1468639 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1468639 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1468639 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1468639 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1468639 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1468639 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1468640 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1468640 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1468641 INFO (searcherExecutor-4602-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6af02023[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1468642 INFO (coreLoadExecutor-4601-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574986662247661568 [junit4] 2> 1468645 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1468651 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs [junit4] 2> 1468652 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1468652 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3b4a4df[collection1] realtime] [junit4] 2> 1468652 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] 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> 1468653 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 1468653 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1468723 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1468770 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1469275 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1469329 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1 [junit4] 2> 1469377 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ 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@655921d0 [junit4] 2> 1469377 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_78B8EACBF4A16770-001/init-core-data-001/] [junit4] 2> 1469572 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1469572 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1469574 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@136503c1[collection1] main] [junit4] 2> 1469575 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1469575 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1469579 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1469579 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1469579 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1574986663230177280 [junit4] 2> 1469579 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1469579 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1469580 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1469580 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1469580 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1469580 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1469581 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1469581 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1469584 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@136503c1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1469593 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=33, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.43941049447564706] [junit4] 2> 1469593 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1469593 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e20321b[collection1] main] [junit4] 2> 1469594 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@57730d8c [junit4] 2> 1469596 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1467157900 [junit4] 2> 1469597 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5e20321b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1469611 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1574986663258488832)]} 0 5 [junit4] 2> 1469612 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1574986663263731712)]} 0 6 [junit4] 2> 1469619 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1574986663272120320)]} 0 13 [junit4] 2> 1469626 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1574986663279460352)]} 0 20 [junit4] 2> 1469627 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1574986663279460353)]} 0 21 [junit4] 2> 1469627 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1574986663280508928)]} 0 21 [junit4] 2> 1469627 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1574986663280508929)]} 0 21 [junit4] 2> 1469627 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1574986663280508930)]} 0 21 [junit4] 2> 1469628 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1574986663280508931)]} 0 22 [junit4] 2> 1469628 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1574986663281557504)]} 0 22 [junit4] 2> 1469628 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1574986663281557505)]} 0 22 [junit4] 2> 1469628 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1574986663281557506)]} 0 22 [junit4] 2> 1469629 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1574986663281557507)]} 0 23 [junit4] 2> 1469629 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1574986663282606080)]} 0 23 [junit4] 2> 1469629 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ 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> 1469652 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1574986663285751808)]} 0 46 [junit4] 2> 1469653 INFO (commitScheduler-4610-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> 1469659 INFO (commitScheduler-4610-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@75558c29[collection1] main] [junit4] 2> 1469660 INFO (commitScheduler-4610-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1469661 INFO (searcherExecutor-4607-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@75558c29[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c15)))} [junit4] 2> 1469903 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1574986663569915904)]} 0 297 [junit4] 2> 1469904 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ 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> 1469907 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ 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> 1469907 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs [junit4] 2> 1469917 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime [junit4] 2> 1469918 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1469918 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@29fca8d0[collection1] realtime] [junit4] 2> 1469918 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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> 1469919 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 1469919 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1470105 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1470186 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1470462 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1470488 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1 [junit4] 2> 1470511 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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@655921d0 [junit4] 2> 1470511 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_78B8EACBF4A16770-001/init-core-data-001/] [junit4] 2> 1471024 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1471024 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1471036 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3634cc2[collection1] main] [junit4] 2> 1471037 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1471044 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1471053 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1471054 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1471054 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1471054 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1471054 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1471054 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1471054 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1471055 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1471055 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1471055 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1471058 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3634cc2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1471065 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=44, maxMergeAtOnceExplicit=39, maxMergedSegmentMB=40.2353515625, floorSegmentMB=1.3994140625, forceMergeDeletesPctAllowed=3.622670059708639, segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1471066 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1471067 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4292b66e[collection1] main] [junit4] 2> 1471067 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@239c8016 [junit4] 2> 1471067 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=597458966 [junit4] 2> 1471069 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4292b66e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1471092 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1574986664794652672)]} 0 22 [junit4] 2> 1471093 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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> 1472578 INFO (commitScheduler-4614-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> 1472583 INFO (commitScheduler-4614-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2cef4ef1[collection1] main] [junit4] 2> 1472583 INFO (commitScheduler-4614-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1472585 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2cef4ef1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c1)))} [junit4] 2> 1472622 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1574986666418896896)]} 0 1552 [junit4] 2> 1472623 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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> 1472624 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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> 1472624 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{delete=[529 (-1574986666423091200)]} 0 0 [junit4] 2> 1472625 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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> 1474201 INFO (commitScheduler-4614-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> 1474205 INFO (commitScheduler-4614-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@268acee3[collection1] main] [junit4] 2> 1474205 INFO (commitScheduler-4614-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1474207 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@268acee3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.0.0):c1)))} [junit4] 2> 1474453 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[550 (1574986668338839552)]} 0 3382 [junit4] 2> 1474453 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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> 1474453 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668340936704)]} 0 3383 [junit4] 2> 1474454 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668341985280)]} 0 3383 [junit4] 2> 1474454 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668341985281)]} 0 3383 [junit4] 2> 1474454 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668341985282)]} 0 3383 [junit4] 2> 1474454 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668341985283)]} 0 3384 [junit4] 2> 1474454 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668341985284)]} 0 3384 [junit4] 2> 1474455 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668343033856)]} 0 3384 [junit4] 2> 1474455 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668343033857)]} 0 3384 [junit4] 2> 1474455 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668343033858)]} 0 3384 [junit4] 2> 1474455 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1574986668343033859)]} 0 3385 [junit4] 2> 1474455 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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> 1475953 INFO (commitScheduler-4614-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> 1475958 INFO (commitScheduler-4614-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@51f2ca36[collection1] main] [junit4] 2> 1475959 INFO (commitScheduler-4614-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1475961 INFO (searcherExecutor-4611-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@51f2ca36[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.0.0):c1) Uninverting(_4(8.0.0):c11/9:delGen=1)))} [junit4] 2> 1476207 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[531 (1574986670180139008)]} 0 5137 [junit4] 2> 1476208 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ 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> 1476208 INFO (TEST-AutoCommitTest.testMaxTime-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime [junit4] 2> 1476211 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin [junit4] 2> 1476211 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1476211 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@11231e00[collection1] realtime] [junit4] 2> 1476211 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ 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> 1476212 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/core.properties [junit4] 2> 1476214 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1476307 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0 [junit4] 2> 1476409 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1476984 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1477016 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1 [junit4] 2> 1477095 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ 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@655921d0 [junit4] 2> 1477095 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_78B8EACBF4A16770-001/init-core-data-001/] [junit4] 2> 1477380 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1477380 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1477382 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@436c290e[collection1] main] [junit4] 2> 1477383 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1477384 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1477387 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1477390 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1477392 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1477392 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1477392 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1477392 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1477393 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1477398 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=17.525390625, floorSegmentMB=2.02734375, forceMergeDeletesPctAllowed=14.233414087868958, segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5758845083591693 [junit4] 2> 1477398 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1477400 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1477400 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1477401 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1477404 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@436c290e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1477404 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6d2a179d[collection1] main] [junit4] 2> 1477404 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7d364f13 [junit4] 2> 1477405 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=2100711187 [junit4] 2> 1477414 INFO (searcherExecutor-4615-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6d2a179d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1477428 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1574986671444721664)]} 0 15 [junit4] 2> 1477428 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ 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> 1477433 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1574986671464644608)]} 0 20 [junit4] 2> 1477435 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ 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=2 [junit4] 2> 1477438 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1574986671470936064)]} 0 25 [junit4] 2> 1477438 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ 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> 1477438 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ 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> 1477439 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ 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> 1477439 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[78B8EACBF4A16770]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest -Dtests.method=testCommitWithin -Dtests.seed=78B8EACBF4A16770 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-US -Dtests.timezone=Etc/GMT-5 -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 1.23s J1 | AutoCommitTest.testCommitWithin <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([78B8EACBF4A16770:C26A85B3778F8965]: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> 1477442 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1477442 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1452174093 [junit4] 2> 1477442 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1477449 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1477463 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1477472 INFO (SUITE-AutoCommitTest-seed#[78B8EACBF4A16770]-worker) [ x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1477476 INFO (coreCloseExecutor-4619-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@59b70a7 [junit4] 2> 1477478 INFO (coreCloseExecutor-4619-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 1477478 INFO (coreCloseExecutor-4619-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@625d0e6 commitCommandVersion:0 [junit4] 2> 1477608 INFO (coreCloseExecutor-4619-thread-1-processing-x:collection1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=94072999 [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-master/solr/build/solr-core/test/J1/temp/solr.update.AutoCommitTest_78B8EACBF4A16770-001 [junit4] 2> Aug 06, 2017 12:58:57 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 3 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=false): {}, locale=en-US, timezone=Etc/GMT-5 [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=4,threads=1,free=355643424,total=532152320 [junit4] 2> NOTE: All tests run in this JVM: [TestValueSourceCache, MetricsHandlerTest, TestRestoreCore, CloneFieldUpdateProcessorFactoryTest, SearchHandlerTest, SimpleCollectionCreateDeleteTest, TestStressRecovery, SolrXmlInZkTest, TestBM25SimilarityFactory, BadComponentTest, HdfsRestartWhileUpdatingTest, SampleTest, TestJsonFacetRefinement, BadCopyFieldTest, ResourceLoaderTest, HealthCheckHandlerTest, TestUpdate, V2ApiIntegrationTest, TestFieldResource, TestCoreDiscovery, DistributedMLTComponentTest, LeaderFailoverAfterPartitionTest, TestHashQParserPlugin, UUIDUpdateProcessorFallbackTest, TestSolrIndexConfig, TestReloadDeadlock, TestPerFieldSimilarity, UpdateRequestProcessorFactoryTest, ShardRoutingTest, SystemInfoHandlerTest, TestLegacyField, MoreLikeThisHandlerTest, QueryParsingTest, TestRebalanceLeaders, TestDynamicFieldCollectionResource, TestSubQueryTransformerDistrib, BufferStoreTest, TestSmileRequest, DOMUtilTest, DisMaxRequestHandlerTest, TestLocalFSCloudBackupRestore, TestFieldSortValues, UninvertDocValuesMergePolicyTest, TestChildDocTransformer, TestStressVersions, ExplicitHLLTest, BlockJoinFacetDistribTest, TestManagedSchemaThreadSafety, TestRawResponseWriter, HdfsTlogReplayBufferedWhileIndexingTest, ReplaceNodeTest, TermVectorComponentTest, BasicAuthIntegrationTest, TestFuzzyAnalyzedSuggestions, TestFiltering, CloudMLTQParserTest, ConvertedLegacyTest, InfixSuggestersTest, TestRTGBase, SoftAutoCommitTest, GraphQueryTest, SubstringBytesRefFilterTest, TestHdfsBackupRestoreCore, CSVRequestHandlerTest, TestSweetSpotSimilarityFactory, TestCorePropertiesReload, CurrencyFieldTypeTest, TestStressInPlaceUpdates, TestInPlaceUpdatesStandalone, MultiThreadedOCPTest, TestCursorMarkWithoutUniqueKey, TestSolrCloudWithKerberosAlt, JsonLoaderTest, ShardRoutingCustomTest, OverseerRolesTest, DeleteShardTest, TestSolrConfigHandlerCloud, HighlighterMaxOffsetTest, TestSearchPerf, TestSolrCloudSnapshots, TemplateUpdateProcessorTest, ConjunctionSolrSpellCheckerTest, TestPullReplicaErrorHandling, TestFieldCacheWithThreads, TestLeaderElectionWithEmptyReplica, ActionThrottleTest, HdfsNNFailoverTest, TestImplicitCoreProperties, NoCacheHeaderTest, TestManagedStopFilterFactory, TestSolrJ, RulesTest, ChaosMonkeySafeLeaderWithPullReplicasTest, TestLRUCache, CdcrRequestHandlerTest, TestXIncludeConfig, DistributedVersionInfoTest, SolrMetricManagerTest, TestEmbeddedSolrServerSchemaAPI, TestSolrCloudWithHadoopAuthPlugin, SchemaVersionSpecificBehaviorTest, CdcrBootstrapTest, ZkSolrClientTest, TestCloudManagedSchema, SegmentsInfoRequestHandlerTest, MoveReplicaHDFSTest, TestCryptoKeys, TestShortCircuitedRequests, TestConfigSetsAPI, DeleteLastCustomShardedReplicaTest, CoreAdminHandlerTest, TestMaxScoreQueryParser, TestDistributedStatsComponentCardinality, DistributedFacetPivotSmallTest, TestTolerantUpdateProcessorCloud, TestTestInjection, SliceStateTest, PeerSyncWithIndexFingerprintCachingTest, IndexSchemaRuntimeFieldTest, AnalysisAfterCoreReloadTest, TestRandomFaceting, AutoCommitTest] [junit4] Completed [377/728 (1!)] on J1 in 10.28s, 3 tests, 1 error <<< FAILURES! [...truncated 44452 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org