Mike Drob created SOLR-16356: -------------------------------- Summary: DBQ is noisy during core close Key: SOLR-16356 URL: https://issues.apache.org/jira/browse/SOLR-16356 Project: Solr Issue Type: Bug Reporter: Mike Drob
This is unrelated to the cause of the test failure, but shows up in the logs. If we have a DBQ running and the core closes then we get lots of scary stack traces in the logs. At the point of the stack trace, I believe the DBQ has already been recorded in the update log, we just need to open our realtime searcher so that RTG has the right info. But if we are closing the core then we don't really care about failure to open a new searcher. {noformat} 520270 INFO (SUITE-DocExpirationUpdateProcessorFactoryTest-seed#[2BB0ACD37A038A84]-worker) [] o.a.s.SolrTestCaseJ4 ###deleteCore 520270 INFO (SUITE-DocExpirationUpdateProcessorFactoryTest-seed#[2BB0ACD37A038A84]-worker) [] o.a.s.c.CoreContainer Shutting down CoreContainer instance=736270622 520271 INFO (coreCloseExecutor-3583-thread-1) [ x:collection1] o.a.s.c.SolrCore CLOSING SolrCore org.apache.solr.core.SolrCore@12243a95 collection1 520271 INFO (coreCloseExecutor-3583-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@12243a95 520277 INFO (coreCloseExecutor-3583-thread-1) [ x:collection1] o.a.s.u.p.DocExpirationUpdateProcessorFactory Triggering Graceful close of DocExpiration Executor 520277 INFO (coreCloseExecutor-3583-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary). 522932 ERROR (autoExpireDocs-3581-thread-1) [] o.a.s.u.UpdateLog Error opening realtime searcher => org.apache.solr.update.SolrCoreState$CoreIsClosedException at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2268) org.apache.solr.update.SolrCoreState$CoreIsClosedException: null at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:2268) ~[main/:?] at org.apache.solr.update.UpdateLog.openRealtimeSearcher(UpdateLog.java:743) [main/:?] at org.apache.solr.update.UpdateLog.deleteByQuery(UpdateLog.java:721) [main/:?] at org.apache.solr.update.DirectUpdateHandler2.deleteByQuery(DirectUpdateHandler2.java:610) [main/:?] at org.apache.solr.update.processor.RunUpdateProcessorFactory$RunUpdateProcessor.processDelete(RunUpdateProcessorFactory.java:86) [main/:?] at org.apache.solr.update.processor.UpdateRequestProcessor.processDelete(UpdateRequestProcessor.java:59) [main/:?] at org.apache.solr.update.processor.UpdateRequestProcessor.processDelete(UpdateRequestProcessor.java:59) [main/:?] at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalDelete(DistributedUpdateProcessor.java:275) [main/:?] at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalDeleteByQuery(DistributedUpdateProcessor.java:1010) [main/:?] at org.apache.solr.update.processor.DistributedUpdateProcessor.versionDeleteByQuery(DistributedUpdateProcessor.java:979) [main/:?] at org.apache.solr.update.processor.DistributedUpdateProcessor.doDeleteByQuery(DistributedUpdateProcessor.java:937) [main/:?] at org.apache.solr.update.processor.DistributedUpdateProcessor.doDeleteByQuery(DistributedUpdateProcessor.java:912) [main/:?] at org.apache.solr.update.processor.DistributedUpdateProcessor.processDelete(DistributedUpdateProcessor.java:829) [main/:?] at org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processDelete(LogUpdateProcessorFactory.java:134) [main/:?] at org.apache.solr.update.processor.UpdateRequestProcessor.processDelete(UpdateRequestProcessor.java:59) [main/:?] at org.apache.solr.update.processor.RecordingUpdateProcessorFactory$RecordingUpdateRequestProcessor.processDelete(RecordingUpdateProcessorFactory.java:96) [test/:?] at org.apache.solr.update.processor.UpdateRequestProcessor.processDelete(UpdateRequestProcessor.java:59) [main/:?] at org.apache.solr.update.processor.DocExpirationUpdateProcessorFactory$DeleteExpiredDocsRunnable.run(DocExpirationUpdateProcessorFactory.java:398) [main/:?] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) [?:?] at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?] at java.lang.Thread.run(Thread.java:833) [?:?] 522934 INFO (autoExpireDocs-3581-thread-1) [] o.a.s.u.p.LogUpdateProcessorFactory {deleteByQuery={!cache=false}eXpField_tdt:[* TO 2022-08-24T08:00:20.233Z] (-1742028690144886784)} 0 7692 522934 ERROR (autoExpireDocs-3581-thread-1) [] o.a.s.u.p.DocExpirationUpdateProcessorFactory Runtime error in periodic deletion of expired docs: => org.apache.solr.common.SolrException: SolrCoreState already closed. at org.apache.solr.update.DefaultSolrCoreState.lock(DefaultSolrCoreState.java:185) org.apache.solr.common.SolrException: SolrCoreState already closed. at org.apache.solr.update.DefaultSolrCoreState.lock(DefaultSolrCoreState.java:185) ~[main/:?] at org.apache.solr.update.DefaultSolrCoreState.getIndexWriter(DefaultSolrCoreState.java:115) ~[main/:?] at org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:729) ~[main/:?] at org.apache.solr.update.processor.RunUpdateProcessorFactory$RunUpdateProcessor.processCommit(RunUpdateProcessorFactory.java:100) ~[main/:?] at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:67) ~[main/:?] at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:67) ~[main/:?] at org.apache.solr.update.processor.DistributedUpdateProcessor.doLocalCommit(DistributedUpdateProcessor.java:1231) ~[main/:?] at org.apache.solr.update.processor.DistributedUpdateProcessor.processCommit(DistributedUpdateProcessor.java:1217) ~[main/:?] at org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.processCommit(LogUpdateProcessorFactory.java:173) ~[main/:?] at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:67) ~[main/:?] at org.apache.solr.update.processor.RecordingUpdateProcessorFactory$RecordingUpdateRequestProcessor.processCommit(RecordingUpdateProcessorFactory.java:108) ~[test/:?] at org.apache.solr.update.processor.UpdateRequestProcessor.processCommit(UpdateRequestProcessor.java:67) ~[main/:?] at org.apache.solr.update.processor.DocExpirationUpdateProcessorFactory$DeleteExpiredDocsRunnable.run(DocExpirationUpdateProcessorFactory.java:405) [main/:?] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) [?:?] at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:305) [?:?] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:305) [?:?] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?] at java.lang.Thread.run(Thread.java:833) [?:?] {noformat} -- This message was sent by Atlassian Jira (v8.20.10#820010) --------------------------------------------------------------------- To unsubscribe, e-mail: issues-unsubscr...@solr.apache.org For additional commands, e-mail: issues-h...@solr.apache.org