Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/15/
1 tests failed. FAILED: org.apache.solr.update.AutoCommitTest.testMaxTime Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([DD92275271A5C971:47665AB0EF3F554D]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878) at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270) 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:871) ... 40 more Build Log: [...truncated 12056 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/J2/temp/solr.update.AutoCommitTest_DD92275271A5C971-001/init-core-data-001 [junit4] 2> 1158786 WARN (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1 [junit4] 2> 1158786 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 1158787 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 1158787 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 1158787 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-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> 1158830 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1158853 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 1158971 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1158997 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c2b680f [junit4] 2> 1158999 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c2b680f [junit4] 2> 1158999 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7c2b680f [junit4] 2> 1159001 INFO (coreLoadExecutor-4535-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> 1159027 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1159046 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1159169 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1159176 INFO (coreLoadExecutor-4535-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> 1159176 INFO (coreLoadExecutor-4535-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@7c2b680f [junit4] 2> 1159176 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 1159176 INFO (coreLoadExecutor-4535-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/J2/temp/solr.update.AutoCommitTest_DD92275271A5C971-001/init-core-data-001/] [junit4] 2> 1159178 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=23.439453125, floorSegmentMB=1.43359375, forceMergeDeletesPctAllowed=13.490600673549697, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1159233 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1159233 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1159236 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1159236 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1159237 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 1159237 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@796d15f1[collection1] main] [junit4] 2> 1159238 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1159252 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1159290 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1159290 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1159291 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1159291 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1159291 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1159291 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1159291 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1159291 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1159291 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1159292 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1159293 INFO (searcherExecutor-4536-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@796d15f1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1159293 INFO (coreLoadExecutor-4535-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1572360823720902656 [junit4] 2> 1159296 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 1159299 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testMaxTime [junit4] 2> 1159299 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1159301 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7980807f[collection1] realtime] [junit4] 2> 1159301 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] 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 2 [junit4] 2> 1159301 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] 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> 1159302 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] 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> 1159330 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1159374 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1159480 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1159486 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ ] 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> 1159499 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ 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@7c2b680f [junit4] 2> 1159499 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ 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/J2/temp/solr.update.AutoCommitTest_DD92275271A5C971-001/init-core-data-001/] [junit4] 2> 1159541 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1159541 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1159542 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6126856a[collection1] main] [junit4] 2> 1159542 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1159543 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1159545 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1159545 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1572360823985143808 [junit4] 2> 1159547 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1159547 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1159547 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1159547 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1159548 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1159548 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1159548 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=43.01171875, floorSegmentMB=1.0185546875, forceMergeDeletesPctAllowed=1.613155250083611, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1159548 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1159548 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1159549 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1159549 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1159550 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6126856a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1159551 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@49830894[collection1] main] [junit4] 2> 1159551 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@288037cb [junit4] 2> 1159551 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=679491531 [junit4] 2> 1159557 INFO (searcherExecutor-4541-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@49830894[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1159558 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1572360823996678144)]} 0 2 [junit4] 2> 1159558 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ 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> 1159560 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1572360824000872448)]} 0 4 [junit4] 2> 1159560 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ 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> 1159561 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ 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> 1159561 ERROR (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ 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:871) [junit4] 2> at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270) [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> 1159561 INFO (TEST-AutoCommitTest.testMaxTime-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxTime [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=AutoCommitTest -Dtests.method=testMaxTime -Dtests.seed=DD92275271A5C971 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ms -Dtests.timezone=NZ -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.27s J2 | AutoCommitTest.testMaxTime <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([DD92275271A5C971:47665AB0EF3F554D]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:878) [junit4] > at org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270) [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:871) [junit4] > ... 40 more [junit4] 2> 1159566 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin [junit4] 2> 1159566 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1159566 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@10750cc4[collection1] realtime] [junit4] 2> 1159566 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1159567 ERROR (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1159567 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1159591 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1159610 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1159723 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1159729 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1159739 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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@7c2b680f [junit4] 2> 1159739 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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/J2/temp/solr.update.AutoCommitTest_DD92275271A5C971-001/init-core-data-001/] [junit4] 2> 1159777 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1159777 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1159778 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@74f5ca22[collection1] main] [junit4] 2> 1159779 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1159779 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1159781 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1159783 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1159783 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1159783 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1159783 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1159783 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1159783 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1159783 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1159784 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=22, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 1159784 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1159784 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1159784 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1159786 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@74f5ca22[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1159786 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4ceef29d[collection1] main] [junit4] 2> 1159786 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3f28c005 [junit4] 2> 1159786 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1059635205 [junit4] 2> 1159788 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4ceef29d[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1159789 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 (1572360824239947776)]} 0 0 [junit4] 2> 1159789 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1163789 INFO (commitScheduler-4548-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> 1163794 INFO (commitScheduler-4548-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7ab502a7[collection1] main] [junit4] 2> 1163794 INFO (commitScheduler-4548-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1163796 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7ab502a7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C1)))} [junit4] 2> 1164041 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 (1572360828699541504)]} 0 4253 [junit4] 2> 1164042 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1164042 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 (-1572360828700590080)]} 0 4254 [junit4] 2> 1164042 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1166042 INFO (commitScheduler-4548-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> 1166044 INFO (commitScheduler-4548-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@71d72ee0[collection1] main] [junit4] 2> 1166045 INFO (commitScheduler-4548-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1166046 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@71d72ee0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.1.0):C1)))} [junit4] 2> 1166294 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1166294 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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=1 status=0 QTime=0 [junit4] 2> 1166295 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831063031808)]} 0 6506 [junit4] 2> 1166295 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831063031809)]} 0 6506 [junit4] 2> 1166295 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831063031810)]} 0 6507 [junit4] 2> 1166295 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831063031811)]} 0 6507 [junit4] 2> 1166295 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831063031812)]} 0 6507 [junit4] 2> 1166296 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831063031813)]} 0 6507 [junit4] 2> 1166296 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831064080384)]} 0 6507 [junit4] 2> 1166296 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831064080385)]} 0 6507 [junit4] 2> 1166296 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831064080386)]} 0 6507 [junit4] 2> 1166296 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 (1572360831064080387)]} 0 6507 [junit4] 2> 1166296 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831064080388)]} 0 6508 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128960)]} 0 6508 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128961)]} 0 6508 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128962)]} 0 6508 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128963)]} 0 6508 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128964)]} 0 6508 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128965)]} 0 6509 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128966)]} 0 6509 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128967)]} 0 6509 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 (-1572360831065128968)]} 0 6509 [junit4] 2> 1166297 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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=1 status=0 QTime=0 [junit4] 2> 1167297 INFO (commitScheduler-4548-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> 1167299 INFO (commitScheduler-4548-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@504edd5c[collection1] main] [junit4] 2> 1167299 INFO (commitScheduler-4548-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1167300 INFO (searcherExecutor-4545-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@504edd5c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.1.0):C10/9:delGen=1)))} [junit4] 2> 1167548 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1167549 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ 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> 1167549 INFO (TEST-AutoCommitTest.testCommitWithin-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin [junit4] 2> 1167552 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs [junit4] 2> 1167552 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1167552 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4aa251f4[collection1] realtime] [junit4] 2> 1167552 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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> 1167552 ERROR (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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> 1167553 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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> 1167575 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0 [junit4] 2> 1167602 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1167699 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1167705 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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> 1167717 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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@7c2b680f [junit4] 2> 1167717 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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/J2/temp/solr.update.AutoCommitTest_DD92275271A5C971-001/init-core-data-001/] [junit4] 2> 1167756 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1167756 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1167757 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@112626b3[collection1] main] [junit4] 2> 1167758 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1167758 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1167760 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1167761 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1167761 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1167761 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1167762 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1167762 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1167762 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1167762 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1167762 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1167762 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1167764 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@112626b3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1167765 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=17, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=49.26171875, floorSegmentMB=0.9697265625, forceMergeDeletesPctAllowed=6.095087343843995, segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11832336138351024 [junit4] 2> 1167765 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1167765 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@ed3872c[collection1] main] [junit4] 2> 1167765 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5a81ddf0 [junit4] 2> 1167766 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1518460400 [junit4] 2> 1167767 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@ed3872c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1167771 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 (1572360832610729984)]} 0 0 [junit4] 2> 1167771 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 (1572360832610729985)]} 0 0 [junit4] 2> 1167771 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (1572360832610729986)]} 0 0 [junit4] 2> 1167771 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 (1572360832610729987)]} 0 0 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 (1572360832610729988)]} 0 0 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 (1572360832611778560)]} 0 1 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 (1572360832611778561)]} 0 1 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 (1572360832611778562)]} 0 1 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 (1572360832611778563)]} 0 1 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 (1572360832611778564)]} 0 1 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 (1572360832611778565)]} 0 1 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 (1572360832611778566)]} 0 1 [junit4] 2> 1167772 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 (1572360832611778567)]} 0 1 [junit4] 2> 1167773 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 (1572360832612827136)]} 0 2 [junit4] 2> 1167773 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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> 1167773 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 (1572360832612827137)]} 0 2 [junit4] 2> 1167774 INFO (commitScheduler-4552-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> 1167777 INFO (commitScheduler-4552-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@44a6e06a[collection1] main] [junit4] 2> 1167778 INFO (searcherExecutor-4549-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@44a6e06a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.1.0):C15)))} [junit4] 2> 1167778 INFO (commitScheduler-4552-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1168024 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 (1572360832876019712)]} 0 253 [junit4] 2> 1168024 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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> 1168025 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ 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> 1168025 INFO (TEST-AutoCommitTest.testMaxDocs-seed#[DD92275271A5C971]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs [junit4] 2> 1168025 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 1168025 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=203171352 [junit4] 2> 1168025 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1168026 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1168027 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1168027 INFO (SUITE-AutoCommitTest-seed#[DD92275271A5C971]-worker) [ x:collection1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1168028 INFO (coreCloseExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@8d0f412 [junit4] 2> 1168028 INFO (coreCloseExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close. [junit4] 2> 1168028 INFO (coreCloseExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3ce8d6d2 commitCommandVersion:0 [junit4] 2> 1168030 INFO (coreCloseExecutor-4553-thread-1-processing-x:collection1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=147911698 [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_DD92275271A5C971-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {field_t=PostingsFormat(name=Asserting), multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), subject=PostingsFormat(name=LuceneVarGapDocFreqInterval), id=PostingsFormat(name=LuceneVarGapFixedInterval), text=PostingsFormat(name=Asserting)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), _version_=DocValuesFormat(name=Lucene70), range_facet_i_dv=DocValuesFormat(name=Lucene70), intDvoDefault=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=423, maxMBSortInHeap=6.57177277149831, sim=RandomSimilarity(queryNorm=true): {}, locale=ms, timezone=NZ [junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_131 (64-bit)/cpus=4,threads=1,free=254736808,total=523763712 [junit4] 2> NOTE: All tests run in this JVM: [BlockJoinFacetSimpleTest, TestDistribIDF, TestSolrConfigHandlerConcurrent, PKIAuthenticationIntegrationTest, TestSubQueryTransformer, TestPrepRecovery, UniqFieldsUpdateProcessorFactoryTest, SolrCoreCheckLockOnStartupTest, TestFieldCacheReopen, XsltUpdateRequestHandlerTest, TestBlobHandler, TestMultiValuedNumericRangeQuery, SuggesterFSTTest, PolyFieldTest, TestReplicaProperties, TestAuthenticationFramework, TestDistributedMissingSort, RequiredFieldsTest, TestFieldCacheVsDocValues, HLLSerializationTest, TestTrackingShardHandlerFactory, SortByFunctionTest, TestSchemaNameResource, PropertiesRequestHandlerTest, RecoveryAfterSoftCommitTest, TestManagedSchemaAPI, TestRandomFlRTGCloud, SignatureUpdateProcessorFactoryTest, TestUseDocValuesAsStored2, TestRecoveryHdfs, StatsComponentTest, TestSizeLimitedDistributedMap, VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZk2Test, AliasIntegrationTest, FullSolrCloudDistribCmdsTest, TestSimpleQParserPlugin, TestExportWriter, V2StandaloneTest, NotRequiredUniqueKeyTest, TestLeaderElectionWithEmptyReplica, PathHierarchyTokenizerFactoryTest, DirectUpdateHandlerOptimizeTest, OverseerStatusTest, TestSuggestSpellingConverter, TestRawTransformer, ShowFileRequestHandlerTest, CollectionsAPISolrJTest, TestTolerantUpdateProcessorRandomCloud, TolerantUpdateProcessorTest, BlobRepositoryCloudTest, BadIndexSchemaTest, CoreMergeIndexesAdminHandlerTest, TestCryptoKeys, TestSolrCoreProperties, TestCustomStream, TestNumericTokenStream, TestSort, TestLegacyNumericRangeQueryBuilder, LeaderInitiatedRecoveryOnShardRestartTest, CircularListTest, PrimitiveFieldTypeTest, BlockDirectoryTest, NumericFieldsTest, SolrMetricReporterTest, TestRecovery, ForceLeaderTest, TestNumericTerms32, TestMacroExpander, MetricsConfigTest, SolrTestCaseJ4Test, MoveReplicaHDFSTest, CopyFieldTest, TestImpersonationWithHadoopAuth, ClassificationUpdateProcessorTest, TestConfigsApi, TestClassicSimilarityFactory, DeleteInactiveReplicaTest, CleanupOldIndexTest, SuggestComponentContextFilterQueryTest, SuggesterTest, RankQueryTest, TestLFUCache, TestSchemaVersionResource, TestClusterStateMutator, TestExpandComponent, BadCopyFieldTest, TestFastWriter, ClusterStateTest, TestGraphTermsQParserPlugin, ConnectionManagerTest, HdfsUnloadDistributedZkTest, TestReversedWildcardFilterFactory, FastVectorHighlighterTest, TestFoldingMultitermQuery, TestQuerySenderListener, TestReload, TestPseudoReturnFields, ResponseHeaderTest, DateFieldTest, CurrencyFieldTypeTest, TestJmxIntegration, UnloadDistributedZkTest, DistributedSuggestComponentTest, ExitableDirectoryReaderTest, TestDownShardTolerantSearch, TestSolrCLIRunExample, QueryEqualityTest, TestLegacyFieldReuse, CdcrReplicationHandlerTest, TestTrie, BitVectorTest, HardAutoCommitTest, SharedFSAutoReplicaFailoverTest, BasicDistributedZk2Test, AddBlockUpdateTest, ChaosMonkeySafeLeaderTest, CollectionsAPIDistributedZkTest, ShardRoutingTest, ZkSolrClientTest, AutoCommitTest] [junit4] Completed [379/727 (1!)] on J2 in 9.27s, 3 tests, 1 error <<< FAILURES! [...truncated 44460 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org