loading SolrInfoMBeanHandler is slow?
Hi, In my Mac OSX when starting Solr as OOTB, I always have to wait 30 sec for completely loading. It seems that loading SolrInfoMBeanHandler is slow in Solr 4.x (also 4.5). Does anyone have the same problem? log: DEBUG - 2013-10-16 00:51:14.144; org.apache.solr.handler.component.SearchHandler; Adding debug component:org.apache.solr.handler.component.DebugComponent@584391f0 DEBUG - 2013-10-16 00:51:14.151; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.AdminHandlers$StandardHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:14.158; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.LukeRequestHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.166; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.SolrInfoMBeanHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.168; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.PluginInfoHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.169; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.ShowFileRequestHandler from WebAppClassLoader=1510130526@5a02c35e : : : INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: default INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: wordbreak INFO - 2013-10-16 00:51:44.500; org.apache.solr.core.SolrCore; [collection1] Registered new searcher Searcher@3b46ad8b main{StandardDirectoryReader(segments_1:1:nrt)} DEBUG - 2013-10-16 00:51:53.870; org.eclipse.jetty.http.HttpParser; filled 402/402 DEBUG - 2013-10-16 00:51:53.882; org.eclipse.jetty.server.Server; REQUEST /solr/select on BlockingHttpConnection@4302df5,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=23,c=0},r=1 Regards, Shinichiro Abe
Re: loading SolrInfoMBeanHandler is slow?
Shinichrio Perhaps i don't see it, but nowhere in your log is something related to this handler? For me it looks like this: Oct 15, 2013 4:36:47 PM org.apache.solr.core.SolrCore execute INFO: [collection1] webapp=/solr path=/admin/mbeans params={stats=truewt=json} status=0 QTime=3 Stefan On Tuesday, October 15, 2013 at 6:00 PM, Shinichiro Abe wrote: Hi, In my Mac OSX when starting Solr as OOTB, I always have to wait 30 sec for completely loading. It seems that loading SolrInfoMBeanHandler is slow in Solr 4.x (also 4.5). Does anyone have the same problem? log: DEBUG - 2013-10-16 00:51:14.144; org.apache.solr.handler.component.SearchHandler; Adding debug component:org.apache.solr.handler.component.DebugComponent@584391f0 DEBUG - 2013-10-16 00:51:14.151; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.AdminHandlers$StandardHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:14.158; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.LukeRequestHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.166; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.SolrInfoMBeanHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.168; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.PluginInfoHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.169; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.ShowFileRequestHandler from WebAppClassLoader=1510130526@5a02c35e : : : INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: default INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: wordbreak INFO - 2013-10-16 00:51:44.500; org.apache.solr.core.SolrCore; [collection1] Registered new searcher Searcher@3b46ad8b main{StandardDirectoryReader(segments_1:1:nrt)} DEBUG - 2013-10-16 00:51:53.870; org.eclipse.jetty.http.HttpParser; filled 402/402 DEBUG - 2013-10-16 00:51:53.882; org.eclipse.jetty.server.Server; REQUEST /solr/select on BlockingHttpConnection@4302df5,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=23,c=0},r=1 Regards, Shinichiro Abe
Re: loading SolrInfoMBeanHandler is slow?
Thanks Stefan, It occurs when boosting Solr before opening Admin GUI, so the handler such as /admin/mbeans is not called, although I checked log details... Shinichiro On 2013/10/16, at 1:38, Stefan Matheis wrote: Shinichrio Perhaps i don't see it, but nowhere in your log is something related to this handler? For me it looks like this: Oct 15, 2013 4:36:47 PM org.apache.solr.core.SolrCore execute INFO: [collection1] webapp=/solr path=/admin/mbeans params={stats=truewt=json} status=0 QTime=3 Stefan On Tuesday, October 15, 2013 at 6:00 PM, Shinichiro Abe wrote: Hi, In my Mac OSX when starting Solr as OOTB, I always have to wait 30 sec for completely loading. It seems that loading SolrInfoMBeanHandler is slow in Solr 4.x (also 4.5). Does anyone have the same problem? log: DEBUG - 2013-10-16 00:51:14.144; org.apache.solr.handler.component.SearchHandler; Adding debug component:org.apache.solr.handler.component.DebugComponent@584391f0 DEBUG - 2013-10-16 00:51:14.151; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.AdminHandlers$StandardHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:14.158; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.LukeRequestHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.166; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.SolrInfoMBeanHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.168; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.PluginInfoHandler from WebAppClassLoader=1510130526@5a02c35e DEBUG - 2013-10-16 00:51:44.169; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.ShowFileRequestHandler from WebAppClassLoader=1510130526@5a02c35e : : : INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: default INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: wordbreak INFO - 2013-10-16 00:51:44.500; org.apache.solr.core.SolrCore; [collection1] Registered new searcher Searcher@3b46ad8b main{StandardDirectoryReader(segments_1:1:nrt)} DEBUG - 2013-10-16 00:51:53.870; org.eclipse.jetty.http.HttpParser; filled 402/402 DEBUG - 2013-10-16 00:51:53.882; org.eclipse.jetty.server.Server; REQUEST /solr/select on BlockingHttpConnection@4302df5,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=23,c=0},r=1 Regards, Shinichiro Abe
Re: loading SolrInfoMBeanHandler is slow?
: In my Mac OSX when starting Solr as OOTB, : I always have to wait 30 sec for completely loading. : It seems that loading SolrInfoMBeanHandler is slow in Solr 4.x (also 4.5). Are you certain the problem is coming from SolrInfoMBeanHandler and not one of the other admin handler rleated classes? I suspect you are seeing slow DNS resolution due to badly configured hostname for your system. Solr tries to cache this info, but the first time it tries to resolve the hostname can still cause a block on startup (or core reload) if your DNS isn't configured properly. Some background can be found here in an issue proposing that this be done entirely in a background thread... https://issues.apache.org/jira/browse/SOLR-5043 : Does anyone have the same problem? : : : : log: : DEBUG - 2013-10-16 00:51:14.144; org.apache.solr.handler.component.SearchHandler; Adding debug component:org.apache.solr.handler.component.DebugComponent@584391f0 : DEBUG - 2013-10-16 00:51:14.151; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.AdminHandlers$StandardHandler from WebAppClassLoader=1510130526@5a02c35e : DEBUG - 2013-10-16 00:51:14.158; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.LukeRequestHandler from WebAppClassLoader=1510130526@5a02c35e : DEBUG - 2013-10-16 00:51:44.166; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.SolrInfoMBeanHandler from WebAppClassLoader=1510130526@5a02c35e : DEBUG - 2013-10-16 00:51:44.168; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.PluginInfoHandler from WebAppClassLoader=1510130526@5a02c35e : DEBUG - 2013-10-16 00:51:44.169; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.ShowFileRequestHandler from WebAppClassLoader=1510130526@5a02c35e : : : : : : : INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: default : INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: wordbreak : INFO - 2013-10-16 00:51:44.500; org.apache.solr.core.SolrCore; [collection1] Registered new searcher Searcher@3b46ad8b main{StandardDirectoryReader(segments_1:1:nrt)} : DEBUG - 2013-10-16 00:51:53.870; org.eclipse.jetty.http.HttpParser; filled 402/402 : DEBUG - 2013-10-16 00:51:53.882; org.eclipse.jetty.server.Server; REQUEST /solr/select on BlockingHttpConnection@4302df5,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=23,c=0},r=1 : : : : Regards, : Shinichiro Abe : : : -Hoss
Re: loading SolrInfoMBeanHandler is slow?
Thanks Hoss, My system seemed to configure bad DNS setting. I used Google Public DNS instead then Solr started up quickly. I'll try to confirm DNS configuration properly. SolrInfoMBeanHandler was not slow, but SystemInfoHandler.init() before SolrInfoMBeanHandler was slow, I think. So SOLR-5043's background thread solution is good. Regards, Shinichiro Abe On 2013/10/16, at 2:22, Chris Hostetter wrote: : In my Mac OSX when starting Solr as OOTB, : I always have to wait 30 sec for completely loading. : It seems that loading SolrInfoMBeanHandler is slow in Solr 4.x (also 4.5). Are you certain the problem is coming from SolrInfoMBeanHandler and not one of the other admin handler rleated classes? I suspect you are seeing slow DNS resolution due to badly configured hostname for your system. Solr tries to cache this info, but the first time it tries to resolve the hostname can still cause a block on startup (or core reload) if your DNS isn't configured properly. Some background can be found here in an issue proposing that this be done entirely in a background thread... https://issues.apache.org/jira/browse/SOLR-5043 : Does anyone have the same problem? : : : : log: : DEBUG - 2013-10-16 00:51:14.144; org.apache.solr.handler.component.SearchHandler; Adding debug component:org.apache.solr.handler.component.DebugComponent@584391f0 : DEBUG - 2013-10-16 00:51:14.151; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.AdminHandlers$StandardHandler from WebAppClassLoader=1510130526@5a02c35e : DEBUG - 2013-10-16 00:51:14.158; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.LukeRequestHandler from WebAppClassLoader=1510130526@5a02c35e : DEBUG - 2013-10-16 00:51:44.166; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.SolrInfoMBeanHandler from WebAppClassLoader=1510130526@5a02c35e : DEBUG - 2013-10-16 00:51:44.168; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.PluginInfoHandler from WebAppClassLoader=1510130526@5a02c35e : DEBUG - 2013-10-16 00:51:44.169; org.eclipse.jetty.webapp.WebAppClassLoader; loaded class org.apache.solr.handler.admin.ShowFileRequestHandler from WebAppClassLoader=1510130526@5a02c35e : : : : : : : INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: default : INFO - 2013-10-16 00:51:44.499; org.apache.solr.handler.component.SpellCheckComponent$SpellCheckerListener; Loading spell index for spellchecker: wordbreak : INFO - 2013-10-16 00:51:44.500; org.apache.solr.core.SolrCore; [collection1] Registered new searcher Searcher@3b46ad8b main{StandardDirectoryReader(segments_1:1:nrt)} : DEBUG - 2013-10-16 00:51:53.870; org.eclipse.jetty.http.HttpParser; filled 402/402 : DEBUG - 2013-10-16 00:51:53.882; org.eclipse.jetty.server.Server; REQUEST /solr/select on BlockingHttpConnection@4302df5,g=HttpGenerator{s=0,h=-1,b=-1,c=-1},p=HttpParser{s=-5,l=23,c=0},r=1 : : : : Regards, : Shinichiro Abe : : : -Hoss