You are viewing a plain text version of this content. The canonical link for it is here.
Posted to solr-user@lucene.apache.org by Loren Siebert <lo...@siebert.org> on 2012/02/27 08:25:39 UTC
General question on understanding Solr log output
I'm trying to understand what Solr is doing regarding commits based on the
logs below. I have a 60 second autocommit and no explicit commits coming in.
What I am seeing in my Solr log appears to be 2 (or 3?) commits per 60
second commit cycle. Everything below happens within a few seconds. I say
maybe 3 commits because the third one reports the same generation as the
second one. At any rate, I would expect to only see one commit and one group
of cache statistics, not three. Am I misinterpreting the logs?
Feb 27, 2012 6:22:36 AM org.apache.solr.update.DirectUpdateHandler2 commit
INFO: start
commit(optimize=false,waitFlush=false,waitSearcher=true,expungeDeletes=false)
Feb 27, 2012 6:22:37 AM org.apache.solr.core.SolrDeletionPolicy onCommit
INFO: SolrDeletionPolicy.onCommit: commits:num=2
commit{dir=/home/search/solr/solr/data/index,segFN=segments_141z,version=1328113878743,generation=51911,filenames=[_189h.tii,
_189f.frq, _189h.fdx, _17nb.fdx, _187m.tis, _17nb.fdt, _187w_3.del,
_187m.tii, _187w.fdt, _17nb.tis, _1894.tii, _189f.prx, _189l.tii, _187w.fdx,
_189k.frq, _189n.frq, _1887.frq, _1894.tis, _189n.fdt, _1887.prx, _189n.fdx,
_16q1.nrm, _189i.frq, _189l.frq, _1887.tii, _17nb.prx, _189f_1.del,
_189f.nrm, _187m.prx, _187m.fnm, _189j.fnm, _1894.nrm, _189i.tii, _1887.tis,
_17nb.tii, _189h.fdt, _1887.nrm, _189m.fnm, _16q1.frq, _189l.nrm, _189k.prx,
_189i.prx, _189n_1.del, _17nb.fnm, _189i.tis, _16q1.tii, _17nb_2f.del,
_189j.nrm, _16q1.tis, _189j.fdt, _189m.fdt, _189i_1.del, _187w.frq,
_189m.fdx, _189i.nrm, segments_141z, _189g.frq, _188s.frq, _187m.nrm,
_187f.tii, _1894.prx, _189l.tis, _189j.fdx, _189k.nrm, _1894.fnm, _187w.tii,
_187f.prx, _187f.fnm, _189j.prx, _187w.tis, _189h.fnm, _188t.frq, _189h.tis,
_1894.fdt, _187f.frq, _189n.fnm, _187f.fdx, _1894.fdx, _189l.prx, _187w.nrm,
_188s.nrm, _189h.frq, _1887.fnm, _187f.tis, _16q1.prx, _189j.tis, _188s.prx,
_189k_1.del, _189l.fnm, _189f.fnm, _189h.prx, _189k.fnm, _188s_1.del,
_189n.prx, _189m.nrm, _189n.nrm, _189g.tii, _188t.tis, _16q1.fdt, _189i.fnm,
_1887.fdx, _189m.prx, _16q1_1a5.del, _189j.frq, _189n.tis, _1887.fdt,
_187w.prx, _187f.nrm, _189f.fdt, _189f.tis, _189k.tis, _189f.fdx, _189m.frq,
_16q1.fdx, _187m.frq, _189n.tii, _187f.fdt, _188t.tii, _189m.tis, _17nb.frq,
_189k.fdt, _189j_1.del, _189g.prx, _189k.tii, _189k.fdx, _189g.fdx,
_16q1.fnm, _189m.tii, _189g.nrm, _189f.tii, _189m_1.del, _187w.fnm,
_187m.fdt, _188t.fdt, _1894.frq, _189g.fnm, _188t.nrm, _189i.fdx, _188t.fdx,
_188t.prx, _189h.nrm, _189g.tis, _187m.fdx, _188s.fnm, _189i.fdt, _188s.tis,
_17nb.nrm, _189j.tii, _188t.fnm, _187f_5.del, _189l.fdx, _189g.fdt,
_188s.fdx, _189l.fdt, _188s.tii, _188s.fdt]
commit{dir=/home/search/solr/solr/data/index,segFN=segments_1420,version=1328113878746,generation=51912,filenames=[_189h.tii,
_189f.frq, _189h.fdx, _17nb.fdx, _187m.tis, _17nb.fdt, _187w_3.del,
_187m.tii, _187w.fdt, _17nb.tis, _1894.tii, _189o.tii, _189f.prx, _189l.tii,
_187w.fdx, _189k.frq, _189n.frq, _1887.frq, _1894.tis, _189n.fdt, _1887.prx,
_189o.tis, _189n.fdx, _16q1.nrm, _189o.frq, _189i.frq, _189l.frq, _1887.tii,
_17nb.prx, _189f_1.del, _189f.nrm, _187m.prx, _187m.fnm, _189o.prx,
_189j.fnm, _1894.nrm, _189i.tii, _1887.tis, _17nb.tii, _189h.fdt, _1887.nrm,
_189m.fnm, _16q1.frq, _189l.nrm, _189k.prx, _189i.prx, _189n_1.del,
_17nb.fnm, _189i.tis, _16q1.tii, _17nb_2f.del, _189o.fdt, _189j.nrm,
_16q1.tis, _189j.fdt, _189m.fdt, _189i_1.del, _187w.frq, _189o.fdx,
_189m.fdx, _189i.nrm, _189g.frq, _188s.frq, _187m.nrm, _187f.tii, _1894.prx,
_189l.tis, _189j.fdx, _189k.nrm, _1894.fnm, _187w.tii, _187f.prx, _187f.fnm,
_189j.prx, _187w.tis, _189h.fnm, _188t.frq, _189h.tis, _1894.fdt, _187f.frq,
_189n.fnm, _187f.fdx, _1894.fdx, _189l.prx, _187w.nrm, _188s.nrm, _189h.frq,
_1887.fnm, _187f.tis, _16q1.prx, _189j.tis, _188s.prx, _189k_1.del,
_189l.fnm, _189f.fnm, _189h.prx, _189k.fnm, _188s_1.del, _189n.prx,
_189m.nrm, _189n.nrm, _189g.tii, _188t.tis, segments_1420, _16q1.fdt,
_189o.fnm, _189i.fnm, _1887.fdx, _189m.prx, _189j.frq, _189n.tis, _1887.fdt,
_187w.prx, _187f.nrm, _189f.fdt, _189f.tis, _189k.tis, _189f.fdx, _189m.frq,
_16q1.fdx, _187m.frq, _189n.tii, _187f.fdt, _188t.tii, _189m.tis, _17nb.frq,
_189k.fdt, _189j_1.del, _189g.prx, _189k.tii, _189k.fdx, _189g.fdx,
_16q1.fnm, _189m.tii, _189g.nrm, _189f.tii, _189m_1.del, _187w.fnm,
_187m.fdt, _188t.fdt, _1894.frq, _189g.fnm, _188t.nrm, _189i.fdx, _188t.fdx,
_188t.prx, _189h.nrm, _189g.tis, _187m.fdx, _188s.fnm, _189i.fdt,
_16q1_1a6.del, _188s.tis, _17nb.nrm, _189j.tii, _188t.fnm, _187f_5.del,
_189l.fdx, _189g.fdt, _188s.fdx, _189o.nrm, _189l.fdt, _188s.tii, _188s.fdt]
Feb 27, 2012 6:22:37 AM org.apache.solr.core.SolrDeletionPolicy
updateCommits
INFO: newest commit = 1328113878746
Feb 27, 2012 6:22:37 AM org.apache.solr.search.SolrIndexSearcher <init>
INFO: Opening Searcher@14d3aabd main
Feb 27, 2012 6:22:37 AM org.apache.solr.update.DirectUpdateHandler2 commit
INFO: end_commit_flush
Feb 27, 2012 6:22:37 AM org.apache.solr.search.SolrIndexSearcher warm
INFO: autowarming Searcher@14d3aabd main from Searcher@8f0adad main
fieldValueCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=0,cumulative_hits=0,cumulative_hitratio=0.00,cumulative_inserts=0,cumulative_evictions=0}
Feb 27, 2012 6:22:37 AM org.apache.solr.search.SolrIndexSearcher warm
INFO: autowarming result for Searcher@14d3aabd main
fieldValueCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=0,cumulative_hits=0,cumulative_hitratio=0.00,cumulative_inserts=0,cumulative_evictions=0}
Feb 27, 2012 6:22:37 AM org.apache.solr.search.SolrIndexSearcher warm
INFO: autowarming Searcher@14d3aabd main from Searcher@8f0adad main
filterCache{lookups=1686,hits=1528,hitratio=0.90,inserts=158,evictions=0,size=1175,warmupTime=4217,cumulative_lookups=8757745,cumulative_hits=8066991,cumulative_hitratio=0.92,cumulative_inserts=690754,cumulative_evictions=0}
Feb 27, 2012 6:22:38 AM org.apache.solr.core.SolrDeletionPolicy onInit
INFO: SolrDeletionPolicy.onInit: commits:num=1
commit{dir=/home/search/solr/solr/data/index,segFN=segments_1420,version=1328113878746,generation=51912,filenames=[_189h.tii,
_189f.frq, _189h.fdx, _17nb.fdx, _187m.tis, _17nb.fdt, _187w_3.del,
_187m.tii, _187w.fdt, _17nb.tis, _1894.tii, _189o.tii, _189f.prx, _189l.tii,
_187w.fdx, _189k.frq, _189n.frq, _1887.frq, _1894.tis, _189n.fdt, _1887.prx,
_189o.tis, _189n.fdx, _16q1.nrm, _189o.frq, _189i.frq, _189l.frq, _1887.tii,
_17nb.prx, _189f_1.del, _189f.nrm, _187m.prx, _187m.fnm, _189o.prx,
_189j.fnm, _1894.nrm, _189i.tii, _1887.tis, _17nb.tii, _189h.fdt, _1887.nrm,
_189m.fnm, _16q1.frq, _189l.nrm, _189k.prx, _189i.prx, _189n_1.del,
_17nb.fnm, _189i.tis, _16q1.tii, _17nb_2f.del, _189o.fdt, _189j.nrm,
_16q1.tis, _189j.fdt, _189m.fdt, _189i_1.del, _187w.frq, _189o.fdx,
_189m.fdx, _189i.nrm, _189g.frq, _188s.frq, _187m.nrm, _187f.tii, _1894.prx,
_189l.tis, _189j.fdx, _189k.nrm, _1894.fnm, _187w.tii, _187f.prx, _187f.fnm,
_189j.prx, _187w.tis, _189h.fnm, _188t.frq, _189h.tis, _1894.fdt, _187f.frq,
_189n.fnm, _187f.fdx, _1894.fdx, _189l.prx, _187w.nrm, _188s.nrm, _189h.frq,
_1887.fnm, _187f.tis, _16q1.prx, _189j.tis, _188s.prx, _189k_1.del,
_189l.fnm, _189f.fnm, _189h.prx, _189k.fnm, _188s_1.del, _189n.prx,
_189m.nrm, _189n.nrm, _189g.tii, _188t.tis, segments_1420, _16q1.fdt,
_189o.fnm, _189i.fnm, _1887.fdx, _189m.prx, _189j.frq, _189n.tis, _1887.fdt,
_187w.prx, _187f.nrm, _189f.fdt, _189f.tis, _189k.tis, _189f.fdx, _189m.frq,
_16q1.fdx, _187m.frq, _189n.tii, _187f.fdt, _188t.tii, _189m.tis, _17nb.frq,
_189k.fdt, _189j_1.del, _189g.prx, _189k.tii, _189k.fdx, _189g.fdx,
_16q1.fnm, _189m.tii, _189g.nrm, _189f.tii, _189m_1.del, _187w.fnm,
_187m.fdt, _188t.fdt, _1894.frq, _189g.fnm, _188t.nrm, _189i.fdx, _188t.fdx,
_188t.prx, _189h.nrm, _189g.tis, _187m.fdx, _188s.fnm, _189i.fdt,
_16q1_1a6.del, _188s.tis, _17nb.nrm, _189j.tii, _188t.fnm, _187f_5.del,
_189l.fdx, _189g.fdt, _188s.fdx, _189o.nrm, _189l.fdt, _188s.tii, _188s.fdt]
Feb 27, 2012 6:22:38 AM org.apache.solr.core.SolrDeletionPolicy
updateCommits
INFO: newest commit = 1328113878746
Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
INFO: autowarming result for Searcher@14d3aabd main
filterCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=1024,warmupTime=4302,cumulative_lookups=8757984,cumulative_hits=8067213,cumulative_hitratio=0.92,cumulative_inserts=690771,cumulative_evictions=0}
Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
INFO: autowarming Searcher@14d3aabd main from Searcher@8f0adad main
queryResultCache{lookups=454,hits=52,hitratio=0.11,inserts=402,evictions=0,size=406,warmupTime=0,cumulative_lookups=2122786,cumulative_hits=304610,cumulative_hitratio=0.14,cumulative_inserts=1818261,cumulative_evictions=0}
Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
INFO: autowarming result for Searcher@14d3aabd main
queryResultCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=2122786,cumulative_hits=304610,cumulative_hitratio=0.14,cumulative_inserts=1818261,cumulative_evictions=0}
Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
INFO: autowarming Searcher@14d3aabd main from Searcher@8f0adad main
documentCache{lookups=716,hits=533,hitratio=0.74,inserts=183,evictions=0,size=183,warmupTime=0,cumulative_lookups=3052040,cumulative_hits=2346594,cumulative_hitratio=0.76,cumulative_inserts=705446,cumulative_evictions=0}
Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
INFO: autowarming result for Searcher@14d3aabd main
documentCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=3052040,cumulative_hits=2346594,cumulative_hitratio=0.76,cumulative_inserts=705446,cumulative_evictions=0}
INFO: QuerySenderListener sending requests to Searcher@14d3aabd main
INFO: QuerySenderListener done.
Feb 27, 2012 6:22:41 AM org.apache.solr.core.SolrCore registerSearcher
INFO: [] Registered new searcher Searcher@14d3aabd main
Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher close
INFO: Closing Searcher@8f0adad main
fieldValueCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=0,cumulative_hits=0,cumulative_hitratio=0.00,cumulative_inserts=0,cumulative_evictions=0}
filterCache{lookups=1925,hits=1750,hitratio=0.90,inserts=175,evictions=0,size=1190,warmupTime=4217,cumulative_lookups=8757984,cumulative_hits=8067213,cumulative_hitratio=0.92,cumulative_inserts=690771,cumulative_evictions=0}
queryResultCache{lookups=454,hits=52,hitratio=0.11,inserts=402,evictions=0,size=406,warmupTime=0,cumulative_lookups=2122786,cumulative_hits=304610,cumulative_hitratio=0.14,cumulative_inserts=1818261,cumulative_evictions=0}
documentCache{lookups=716,hits=533,hitratio=0.74,inserts=183,evictions=0,size=183,warmupTime=0,cumulative_lookups=3052040,cumulative_hits=2346594,cumulative_hitratio=0.76,cumulative_inserts=705446,cumulative_evictions=0}
--
View this message in context: http://lucene.472066.n3.nabble.com/General-question-on-understanding-Solr-log-output-tp3779907p3779907.html
Sent from the Solr - User mailing list archive at Nabble.com.
Re: General question on understanding Solr log output
Posted by Loren Siebert <lo...@siebert.org>.
Mikhail-
That makes sense about the commits. Solr's reporting that it has 2 commits
(the new one and the prior one), and then it deletes the old one and reports
that there is 1 remaining commit in the directory (the one just applied).
Thanks for explaining that.
My next question is on all the logging around the autowarming for the
various caches. For instance, I see three entries for filterCache:
filterCache{lookups=891,hits=794,hitratio=0.89,inserts=97,evictions=0,size=1125,warmupTime=2760,cumulative_lookups=33112,cumulative_hits=30112,cumulative_hitratio=0.90,cumulative_inserts=3000,cumulative_evictions=0}
filterCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=1024,warmupTime=2602,cumulative_lookups=33137,cumulative_hits=30132,cumulative_hitratio=0.90,cumulative_inserts=3005,cumulative_evictions=0}
filterCache{lookups=916,hits=814,hitratio=0.88,inserts=102,evictions=0,size=1130,warmupTime=2760,cumulative_lookups=33137,cumulative_hits=30132,cumulative_hitratio=0.90,cumulative_inserts=3005,cumulative_evictions=0}
I'm going to take a guess here at answering my own question. The first two,
like with the commits, are a report of what filterCaches are currently
instantiated. The first one is the one that's been around since the last
commit. It's had 891 lookups and took 2760ms to warm up back when it got
launched. The second one is the new one that just got warmed but hasn't been
made active yet. It took 2602ms to warm up. In that time, the original
filterCache got an additional (916-891=25) lookups before getting
decommissioned. That's the third filterCache line.
Am I reading that correctly?
--
View this message in context: http://lucene.472066.n3.nabble.com/General-question-on-understanding-Solr-log-output-tp3779907p3798351.html
Sent from the Solr - User mailing list archive at Nabble.com.
Re: General question on understanding Solr log output
Posted by Mikhail Khludnev <mk...@griddynamics.com>.
Hello Loren,
I suppose you are confused by printing list of *present* commits by
SolrDeletionPolicy
Feb 27, 2012 6:22:37 AM org.apache.solr.core.*SolrDeletionPolicy onCommit*
INFO: SolrDeletionPolicy.*onCommit: commits:num=2*
commit{dir=/home/search/solr/solr/data/index,segFN=segments_141z,version=
1328113878743,generation=*51911*,
...
commit{dir=/home/search/solr/solr/data/index,segFN=segments_1420,version=1328113878746,generation=
*51912*
Looks like your expectation about your the app the reality.
Regards
On Mon, Feb 27, 2012 at 11:25 AM, Loren Siebert <lo...@siebert.org> wrote:
> I'm trying to understand what Solr is doing regarding commits based on the
> logs below. I have a 60 second autocommit and no explicit commits coming
> in.
> What I am seeing in my Solr log appears to be 2 (or 3?) commits per 60
> second commit cycle. Everything below happens within a few seconds. I say
> maybe 3 commits because the third one reports the same generation as the
> second one. At any rate, I would expect to only see one commit and one
> group
> of cache statistics, not three. Am I misinterpreting the logs?
>
> Feb 27, 2012 6:22:36 AM org.apache.solr.update.DirectUpdateHandler2 commit
> INFO: start
>
> commit(optimize=false,waitFlush=false,waitSearcher=true,expungeDeletes=false)
> Feb 27, 2012 6:22:37 AM org.apache.solr.core.SolrDeletionPolicy onCommit
> INFO: SolrDeletionPolicy.onCommit: commits:num=2
>
>
> commit{dir=/home/search/solr/solr/data/index,segFN=segments_141z,version=1328113878743,generation=51911,filenames=[_189h.tii,
> _189f.frq, _189h.fdx, _17nb.fdx, _187m.tis, _17nb.fdt, _187w_3.del,
> _187m.tii, _187w.fdt, _17nb.tis, _1894.tii, _189f.prx, _189l.tii,
> _187w.fdx,
> _189k.frq, _189n.frq, _1887.frq, _1894.tis, _189n.fdt, _1887.prx,
> _189n.fdx,
> _16q1.nrm, _189i.frq, _189l.frq, _1887.tii, _17nb.prx, _189f_1.del,
> _189f.nrm, _187m.prx, _187m.fnm, _189j.fnm, _1894.nrm, _189i.tii,
> _1887.tis,
> _17nb.tii, _189h.fdt, _1887.nrm, _189m.fnm, _16q1.frq, _189l.nrm,
> _189k.prx,
> _189i.prx, _189n_1.del, _17nb.fnm, _189i.tis, _16q1.tii, _17nb_2f.del,
> _189j.nrm, _16q1.tis, _189j.fdt, _189m.fdt, _189i_1.del, _187w.frq,
> _189m.fdx, _189i.nrm, segments_141z, _189g.frq, _188s.frq, _187m.nrm,
> _187f.tii, _1894.prx, _189l.tis, _189j.fdx, _189k.nrm, _1894.fnm,
> _187w.tii,
> _187f.prx, _187f.fnm, _189j.prx, _187w.tis, _189h.fnm, _188t.frq,
> _189h.tis,
> _1894.fdt, _187f.frq, _189n.fnm, _187f.fdx, _1894.fdx, _189l.prx,
> _187w.nrm,
> _188s.nrm, _189h.frq, _1887.fnm, _187f.tis, _16q1.prx, _189j.tis,
> _188s.prx,
> _189k_1.del, _189l.fnm, _189f.fnm, _189h.prx, _189k.fnm, _188s_1.del,
> _189n.prx, _189m.nrm, _189n.nrm, _189g.tii, _188t.tis, _16q1.fdt,
> _189i.fnm,
> _1887.fdx, _189m.prx, _16q1_1a5.del, _189j.frq, _189n.tis, _1887.fdt,
> _187w.prx, _187f.nrm, _189f.fdt, _189f.tis, _189k.tis, _189f.fdx,
> _189m.frq,
> _16q1.fdx, _187m.frq, _189n.tii, _187f.fdt, _188t.tii, _189m.tis,
> _17nb.frq,
> _189k.fdt, _189j_1.del, _189g.prx, _189k.tii, _189k.fdx, _189g.fdx,
> _16q1.fnm, _189m.tii, _189g.nrm, _189f.tii, _189m_1.del, _187w.fnm,
> _187m.fdt, _188t.fdt, _1894.frq, _189g.fnm, _188t.nrm, _189i.fdx,
> _188t.fdx,
> _188t.prx, _189h.nrm, _189g.tis, _187m.fdx, _188s.fnm, _189i.fdt,
> _188s.tis,
> _17nb.nrm, _189j.tii, _188t.fnm, _187f_5.del, _189l.fdx, _189g.fdt,
> _188s.fdx, _189l.fdt, _188s.tii, _188s.fdt]
>
>
> commit{dir=/home/search/solr/solr/data/index,segFN=segments_1420,version=1328113878746,generation=51912,filenames=[_189h.tii,
> _189f.frq, _189h.fdx, _17nb.fdx, _187m.tis, _17nb.fdt, _187w_3.del,
> _187m.tii, _187w.fdt, _17nb.tis, _1894.tii, _189o.tii, _189f.prx,
> _189l.tii,
> _187w.fdx, _189k.frq, _189n.frq, _1887.frq, _1894.tis, _189n.fdt,
> _1887.prx,
> _189o.tis, _189n.fdx, _16q1.nrm, _189o.frq, _189i.frq, _189l.frq,
> _1887.tii,
> _17nb.prx, _189f_1.del, _189f.nrm, _187m.prx, _187m.fnm, _189o.prx,
> _189j.fnm, _1894.nrm, _189i.tii, _1887.tis, _17nb.tii, _189h.fdt,
> _1887.nrm,
> _189m.fnm, _16q1.frq, _189l.nrm, _189k.prx, _189i.prx, _189n_1.del,
> _17nb.fnm, _189i.tis, _16q1.tii, _17nb_2f.del, _189o.fdt, _189j.nrm,
> _16q1.tis, _189j.fdt, _189m.fdt, _189i_1.del, _187w.frq, _189o.fdx,
> _189m.fdx, _189i.nrm, _189g.frq, _188s.frq, _187m.nrm, _187f.tii,
> _1894.prx,
> _189l.tis, _189j.fdx, _189k.nrm, _1894.fnm, _187w.tii, _187f.prx,
> _187f.fnm,
> _189j.prx, _187w.tis, _189h.fnm, _188t.frq, _189h.tis, _1894.fdt,
> _187f.frq,
> _189n.fnm, _187f.fdx, _1894.fdx, _189l.prx, _187w.nrm, _188s.nrm,
> _189h.frq,
> _1887.fnm, _187f.tis, _16q1.prx, _189j.tis, _188s.prx, _189k_1.del,
> _189l.fnm, _189f.fnm, _189h.prx, _189k.fnm, _188s_1.del, _189n.prx,
> _189m.nrm, _189n.nrm, _189g.tii, _188t.tis, segments_1420, _16q1.fdt,
> _189o.fnm, _189i.fnm, _1887.fdx, _189m.prx, _189j.frq, _189n.tis,
> _1887.fdt,
> _187w.prx, _187f.nrm, _189f.fdt, _189f.tis, _189k.tis, _189f.fdx,
> _189m.frq,
> _16q1.fdx, _187m.frq, _189n.tii, _187f.fdt, _188t.tii, _189m.tis,
> _17nb.frq,
> _189k.fdt, _189j_1.del, _189g.prx, _189k.tii, _189k.fdx, _189g.fdx,
> _16q1.fnm, _189m.tii, _189g.nrm, _189f.tii, _189m_1.del, _187w.fnm,
> _187m.fdt, _188t.fdt, _1894.frq, _189g.fnm, _188t.nrm, _189i.fdx,
> _188t.fdx,
> _188t.prx, _189h.nrm, _189g.tis, _187m.fdx, _188s.fnm, _189i.fdt,
> _16q1_1a6.del, _188s.tis, _17nb.nrm, _189j.tii, _188t.fnm, _187f_5.del,
> _189l.fdx, _189g.fdt, _188s.fdx, _189o.nrm, _189l.fdt, _188s.tii,
> _188s.fdt]
> Feb 27, 2012 6:22:37 AM org.apache.solr.core.SolrDeletionPolicy
> updateCommits
> INFO: newest commit = 1328113878746
> Feb 27, 2012 6:22:37 AM org.apache.solr.search.SolrIndexSearcher <init>
> INFO: Opening Searcher@14d3aabd main
> Feb 27, 2012 6:22:37 AM org.apache.solr.update.DirectUpdateHandler2 commit
> INFO: end_commit_flush
> Feb 27, 2012 6:22:37 AM org.apache.solr.search.SolrIndexSearcher warm
> INFO: autowarming Searcher@14d3aabd main from Searcher@8f0adad main
>
>
> fieldValueCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=0,cumulative_hits=0,cumulative_hitratio=0.00,cumulative_inserts=0,cumulative_evictions=0}
> Feb 27, 2012 6:22:37 AM org.apache.solr.search.SolrIndexSearcher warm
> INFO: autowarming result for Searcher@14d3aabd main
>
>
> fieldValueCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=0,cumulative_hits=0,cumulative_hitratio=0.00,cumulative_inserts=0,cumulative_evictions=0}
> Feb 27, 2012 6:22:37 AM org.apache.solr.search.SolrIndexSearcher warm
> INFO: autowarming Searcher@14d3aabd main from Searcher@8f0adad main
>
>
> filterCache{lookups=1686,hits=1528,hitratio=0.90,inserts=158,evictions=0,size=1175,warmupTime=4217,cumulative_lookups=8757745,cumulative_hits=8066991,cumulative_hitratio=0.92,cumulative_inserts=690754,cumulative_evictions=0}
> Feb 27, 2012 6:22:38 AM org.apache.solr.core.SolrDeletionPolicy onInit
> INFO: SolrDeletionPolicy.onInit: commits:num=1
>
>
> commit{dir=/home/search/solr/solr/data/index,segFN=segments_1420,version=1328113878746,generation=51912,filenames=[_189h.tii,
> _189f.frq, _189h.fdx, _17nb.fdx, _187m.tis, _17nb.fdt, _187w_3.del,
> _187m.tii, _187w.fdt, _17nb.tis, _1894.tii, _189o.tii, _189f.prx,
> _189l.tii,
> _187w.fdx, _189k.frq, _189n.frq, _1887.frq, _1894.tis, _189n.fdt,
> _1887.prx,
> _189o.tis, _189n.fdx, _16q1.nrm, _189o.frq, _189i.frq, _189l.frq,
> _1887.tii,
> _17nb.prx, _189f_1.del, _189f.nrm, _187m.prx, _187m.fnm, _189o.prx,
> _189j.fnm, _1894.nrm, _189i.tii, _1887.tis, _17nb.tii, _189h.fdt,
> _1887.nrm,
> _189m.fnm, _16q1.frq, _189l.nrm, _189k.prx, _189i.prx, _189n_1.del,
> _17nb.fnm, _189i.tis, _16q1.tii, _17nb_2f.del, _189o.fdt, _189j.nrm,
> _16q1.tis, _189j.fdt, _189m.fdt, _189i_1.del, _187w.frq, _189o.fdx,
> _189m.fdx, _189i.nrm, _189g.frq, _188s.frq, _187m.nrm, _187f.tii,
> _1894.prx,
> _189l.tis, _189j.fdx, _189k.nrm, _1894.fnm, _187w.tii, _187f.prx,
> _187f.fnm,
> _189j.prx, _187w.tis, _189h.fnm, _188t.frq, _189h.tis, _1894.fdt,
> _187f.frq,
> _189n.fnm, _187f.fdx, _1894.fdx, _189l.prx, _187w.nrm, _188s.nrm,
> _189h.frq,
> _1887.fnm, _187f.tis, _16q1.prx, _189j.tis, _188s.prx, _189k_1.del,
> _189l.fnm, _189f.fnm, _189h.prx, _189k.fnm, _188s_1.del, _189n.prx,
> _189m.nrm, _189n.nrm, _189g.tii, _188t.tis, segments_1420, _16q1.fdt,
> _189o.fnm, _189i.fnm, _1887.fdx, _189m.prx, _189j.frq, _189n.tis,
> _1887.fdt,
> _187w.prx, _187f.nrm, _189f.fdt, _189f.tis, _189k.tis, _189f.fdx,
> _189m.frq,
> _16q1.fdx, _187m.frq, _189n.tii, _187f.fdt, _188t.tii, _189m.tis,
> _17nb.frq,
> _189k.fdt, _189j_1.del, _189g.prx, _189k.tii, _189k.fdx, _189g.fdx,
> _16q1.fnm, _189m.tii, _189g.nrm, _189f.tii, _189m_1.del, _187w.fnm,
> _187m.fdt, _188t.fdt, _1894.frq, _189g.fnm, _188t.nrm, _189i.fdx,
> _188t.fdx,
> _188t.prx, _189h.nrm, _189g.tis, _187m.fdx, _188s.fnm, _189i.fdt,
> _16q1_1a6.del, _188s.tis, _17nb.nrm, _189j.tii, _188t.fnm, _187f_5.del,
> _189l.fdx, _189g.fdt, _188s.fdx, _189o.nrm, _189l.fdt, _188s.tii,
> _188s.fdt]
> Feb 27, 2012 6:22:38 AM org.apache.solr.core.SolrDeletionPolicy
> updateCommits
> INFO: newest commit = 1328113878746
> Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
> INFO: autowarming result for Searcher@14d3aabd main
>
>
> filterCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=1024,warmupTime=4302,cumulative_lookups=8757984,cumulative_hits=8067213,cumulative_hitratio=0.92,cumulative_inserts=690771,cumulative_evictions=0}
> Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
> INFO: autowarming Searcher@14d3aabd main from Searcher@8f0adad main
>
>
> queryResultCache{lookups=454,hits=52,hitratio=0.11,inserts=402,evictions=0,size=406,warmupTime=0,cumulative_lookups=2122786,cumulative_hits=304610,cumulative_hitratio=0.14,cumulative_inserts=1818261,cumulative_evictions=0}
> Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
> INFO: autowarming result for Searcher@14d3aabd main
>
>
> queryResultCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=2122786,cumulative_hits=304610,cumulative_hitratio=0.14,cumulative_inserts=1818261,cumulative_evictions=0}
> Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
> INFO: autowarming Searcher@14d3aabd main from Searcher@8f0adad main
>
>
> documentCache{lookups=716,hits=533,hitratio=0.74,inserts=183,evictions=0,size=183,warmupTime=0,cumulative_lookups=3052040,cumulative_hits=2346594,cumulative_hitratio=0.76,cumulative_inserts=705446,cumulative_evictions=0}
> Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher warm
> INFO: autowarming result for Searcher@14d3aabd main
>
>
> documentCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=3052040,cumulative_hits=2346594,cumulative_hitratio=0.76,cumulative_inserts=705446,cumulative_evictions=0}
> INFO: QuerySenderListener sending requests to Searcher@14d3aabd main
> INFO: QuerySenderListener done.
> Feb 27, 2012 6:22:41 AM org.apache.solr.core.SolrCore registerSearcher
> INFO: [] Registered new searcher Searcher@14d3aabd main
> Feb 27, 2012 6:22:41 AM org.apache.solr.search.SolrIndexSearcher close
> INFO: Closing Searcher@8f0adad main
>
>
> fieldValueCache{lookups=0,hits=0,hitratio=0.00,inserts=0,evictions=0,size=0,warmupTime=0,cumulative_lookups=0,cumulative_hits=0,cumulative_hitratio=0.00,cumulative_inserts=0,cumulative_evictions=0}
>
>
> filterCache{lookups=1925,hits=1750,hitratio=0.90,inserts=175,evictions=0,size=1190,warmupTime=4217,cumulative_lookups=8757984,cumulative_hits=8067213,cumulative_hitratio=0.92,cumulative_inserts=690771,cumulative_evictions=0}
>
>
> queryResultCache{lookups=454,hits=52,hitratio=0.11,inserts=402,evictions=0,size=406,warmupTime=0,cumulative_lookups=2122786,cumulative_hits=304610,cumulative_hitratio=0.14,cumulative_inserts=1818261,cumulative_evictions=0}
>
>
> documentCache{lookups=716,hits=533,hitratio=0.74,inserts=183,evictions=0,size=183,warmupTime=0,cumulative_lookups=3052040,cumulative_hits=2346594,cumulative_hitratio=0.76,cumulative_inserts=705446,cumulative_evictions=0}
>
>
> --
> View this message in context:
> http://lucene.472066.n3.nabble.com/General-question-on-understanding-Solr-log-output-tp3779907p3779907.html
> Sent from the Solr - User mailing list archive at Nabble.com.
>
--
Sincerely yours
Mikhail Khludnev
Lucid Certified
Apache Lucene/Solr Developer
Grid Dynamics
<http://www.griddynamics.com>
<mk...@griddynamics.com>