bug#12468: 24.2; emacs becomes increasingly sluggish

[Rodney Sparapani]

I recently upgraded to 24.2 from 23.1 and I like 24.2 much better; great
job fixing bugs and adding features!  However, I noticed that after
working for 30 minutes or so; emacs becomes increasingly sluggish.  So,
I decided to profile it.  I've never done profiling before.  But, this
seemed like the perfect time to try it; I really would rather use
24.2!  The profiling is below.  The amount of time consumed by
valid_image_p seems suspicious (the formatting is a little screwy so I'm
attaching it too)...

Flat profile:

Each sample counts as 0.01 seconds.
   %   cumulative   self              self     total
  time   seconds   seconds    calls  ms/call  ms/call  name
  81.64    476.19   476.19   448475     1.06     1.06  valid_image_p
   3.52    496.73    20.54 179104238     0.00     0.00  mark_object
   1.24    503.94     7.21 12594668     0.00     0.00  assq_no_quit
   1.20    510.92     6.98 306405282     0.00     0.00 lookup_char_property
   1.01    516.80     5.88      492    11.95    58.89  Fgarbage_collect
   0.98    522.54     5.74   606419     0.01     0.01 set_buffer_internal_1
   0.81    527.29     4.75 226932614     0.00     0.00  next_interval
   0.50    530.21     2.92  4323713     0.00     0.00  exec_byte_code
   0.41    532.59     2.38 293930408     0.00     0.00  Fassq
   0.32    534.48     1.90 17988524     0.00     0.00  x_produce_glyphs
   0.31    536.28     1.80 38686235     0.00     0.00  find_interval
   0.27    537.84     1.56 18899516     0.00     0.00
bidi_move_to_visually_next
   0.24    539.22     1.38 19355003     0.00     0.00  overlays_at
   0.23    540.57     1.35                             _init
   0.23    541.91     1.34 18899516     0.00     0.00
bidi_level_of_next_char
   0.20    543.05     1.15 533779146     0.00     0.00  Fcdr
   0.18    544.10     1.05  6051358     0.00     0.00  mark_vectorlike

SNIP


If Emacs crashed, and you have the Emacs process in the gdb debugger,
please include the output from the following gdb commands:
    `bt full' and `xbacktrace'.
For information about debugging Emacs, please read the file
/opt/local/share/emacs/24.2/etc/DEBUG.


In GNU Emacs 24.2.1 (x86_64-unknown-linux-gnu, X toolkit, Xaw scroll bars)
 of 2012-09-18 on megatron.pcor.mcw.edu
Windowing system distributor `Sun Microsystems, Inc.', version 11.0.10300000
Configured using:
 `configure '--prefix=/opt/local' '--with-x-toolkit=lucid'
 '--enable-profiling' 'CC=gcc' 'CFLAGS=-g -O2'
 'LDFLAGS=-L/opt/local/lib64 -Wl,-rpath -Wl,/opt/local/lib64'
 'CPPFLAGS=-I/opt/local/include''

Important settings:
  value of $LC_ALL: nil
  value of $LC_COLLATE: nil
  value of $LC_CTYPE: nil
  value of $LC_MESSAGES: nil
  value of $LC_MONETARY: nil
  value of $LC_NUMERIC: nil
  value of $LC_TIME: nil
  value of $LANG: en_US.ISO8859-1
  value of $XMODIFIERS: nil
  locale-coding-system: iso-latin-1-unix
  default enable-multibyte-characters: t

Major mode: iESS

Minor modes in effect:
  delete-selection-mode: t
  tabbar-mwheel-mode: t
  tabbar-mode: t
  recentf-mode: t
  shell-dirtrack-mode: t
  eldoc-mode: t
  show-paren-mode: t
  tooltip-mode: t
  mouse-wheel-mode: t
  tool-bar-mode: t
  menu-bar-mode: t
  file-name-shadow-mode: t
  global-font-lock-mode: t
  font-lock-mode: t
  blink-cursor-mode: t
  auto-composition-mode: t
  auto-encryption-mode: t
  auto-compression-mode: t
  column-number-mode: t
  line-number-mode: t
  transient-mark-mode: t

Recent input:
o SPC i n f l o o p <down-mouse-1> <mouse-1> <backspace>
<backspace> <backspace> y o u SPC i n <right> <right>
SPC a b <backspace> n <help-echo> <help-echo> <help-echo>
<help-echo> <help-echo> <help-echo> <help-echo> <tool-bar>
<save-buffer> <help-echo> <help-echo> <help-echo> <switch-frame>
<switch-frame> <down-mouse-1> <mouse-movement> <mouse-1>
M-x a p r o p o s <return> t r a c e - b u g <return>
M-x a p r o p o s e <backspace> <backspace> <tab> <return>
t r a c e b u g <return> <help-echo> <down-mouse-1>
<mouse-2> <switch-frame> <down-mouse-1> <mouse-movement>
<mouse-1> M-x e s s - t r a c e b u g <return> <help-echo>
<help-echo> <down-mouse-1> <mouse-1> i 0 0 0 <help-echo>
<tool-bar> <save-buffer> <help-echo> <down-mouse-5>
<mouse-5> <double-down-mouse-5> <double-mouse-5> <down-mouse-1>
<mouse-movement> <mouse-movement> <drag-mouse-1> C-c
C-r <down-mouse-1> <mouse-1> <backspace> <down-mouse-1>
<mouse-1> <backspace> <up> <return> p r o c . t i <tab>
<tab> <backspace> <backspace> <backspace> p r o <backspace>
<backspace> <backspace> . t i m <tab> <tab> <backspace>
<backspace> <backspace> <backspace> <backspace> <backspace>
<backspace> <backspace> ? p r o c . t i m e <down-mouse-1>
<mouse-movement> <mouse-movement> <drag-mouse-1> <help-echo>
<help-echo> <help-echo> <down-mouse-2> <mouse-2> <return>
<down-mouse-1> <mouse-1> <down-mouse-1> <mouse-1> <backspace>
s t a r t _ <down-mouse-1> <mouse-1> ( ) <return> <down-mouse-1>
<mouse-1> <return> d i f f _ <down-mouse-1> <mouse-movement>
<mouse-movement> <drag-mouse-1> <down-mouse-2> <mouse-2>
SPC - s t a r t <backspace> <backspace> <backspace>
<backspace> <backspace> SPC s t a t <backspace> r t
( ) <down-mouse-1> <mouse-1> <backspace> <backspace>
<backspace> <backspace> e l a p s e d <down-mouse-1>
<mouse-1> ( <down-mouse-1> <mouse-1> ) <help-echo>
<help-echo> <tool-bar> <save-buffer> <help-echo> <down-mouse-1>
<mouse-movement> <mouse-movement> <drag-mouse-1> C-c
C-r <down-mouse-1> <mouse-1> <return> <up> <down-mouse-1>
<mouse-1> <switch-frame> <switch-frame> <help-echo>
<help-echo> <f15> <switch-frame> M-x r e p o r t -
e m a c s - b u g <return>

Recent messages:
Starting evaluation...
Eval region
Auto-saving...done
Mark set
nil [2 times]
Mark set
Saving file /bnp/tools/bbjem.probit.R...
Wrote /bnp/tools/bbjem.probit.R
Starting evaluation...
Eval region

Load-path shadows:
/opt/local/src/cedet/cedet-1.1/speedbar/dframe hides 
/opt/local/share/emacs/24.2/lisp/dframe
/opt/local/src/cedet/cedet-1.1/common/ezimage hides 
/opt/local/share/emacs/24.2/lisp/ezimage
/opt/local/src/cedet/cedet-1.1/speedbar/speedbar hides 
/opt/local/share/emacs/24.2/lisp/speedbar
/opt/local/src/cedet/cedet-1.1/speedbar/sb-image hides 
/opt/local/share/emacs/24.2/lisp/sb-image
/opt/local/src/cedet/cedet-1.1/eieio/eieio hides 
/opt/local/share/emacs/24.2/lisp/emacs-lisp/eieio
/opt/local/src/cedet/cedet-1.1/eieio/eieio-base hides 
/opt/local/share/emacs/24.2/lisp/emacs-lisp/eieio-base
/opt/local/src/cedet/cedet-1.1/eieio/eieio-custom hides 
/opt/local/share/emacs/24.2/lisp/emacs-lisp/eieio-custom
/opt/local/src/cedet/cedet-1.1/eieio/eieio-opt hides 
/opt/local/share/emacs/24.2/lisp/emacs-lisp/eieio-opt
/opt/local/src/cedet/cedet-1.1/eieio/chart hides 
/opt/local/share/emacs/24.2/lisp/emacs-lisp/chart
/opt/local/src/cedet/cedet-1.1/eieio/eieio-datadebug hides 
/opt/local/share/emacs/24.2/lisp/emacs-lisp/eieio-datadebug
/opt/local/src/cedet/cedet-1.1/eieio/eieio-speedbar hides 
/opt/local/share/emacs/24.2/lisp/emacs-lisp/eieio-speedbar

Features:
(shadow sort mail-extr emacsbug message rfc822 mml mml-sec mm-decode
mm-bodies mm-encode mail-parse rfc2231 mailabbrev gmm-utils mailheader
sendmail rfc2047 rfc2045 ietf-drums mail-utils apropos ess-roxy pp
semanticdb-typecache semantic-tag-file semantic-tag-write ede-emacs
semantic-c semantic-decorate-include hideif semantic-c-by cc-mode
cc-fonts cc-guess cc-menus cc-cmds cc-styles cc-align cc-engine
semantic-decorate-mode semantic-decorate vc-dispatcher vc-svn
semanticdb-file cedet-files noutline outline semantic-el semantic-bovine
bovine-debug semantic-debug ffap ess-eldoc ess-font-lock ess-bugs-d
ess-jags-d ess-smart-underscore ido ess-toolbar ess-mouse mouseme
browse-url ess-menu ess-swv ess-noweb ess-noweb-font-lock-mode
ess-bugs-l essd-els ess-sas-d ess-sas-l ess-sas-a ess-arc-d ess-vst-d
ess-xls-d ess-lsp-l ess-sta-d ess-sta-l cc-vars cc-defs make-regexp
ess-sp6-d ess-sp5-d ess-sp3-d ess-julia ess-r-d ess-tracebug ess-help
ess-developer ess-r-args ess-s-l ess ess-inf newcomment ess-mode
ess-noweb-mode ess-utils ess-custom executable ess-compat ess-site
doc-view jka-compr image-mode tex-site auto-loads delsel dired tabbar
recentf tree-widget tramp tramp-compat auth-source gnus-util mm-util
mail-prsvr password-cache shell pcomplete format-spec tramp-loaddefs
ps-print ps-def lpr ecb ecb-symboldef ecb-analyse ecb-compatibility
ecb-winman-support ecb-autogen autoload ecb-tod ecb-cycle ecb-eshell
ecb-help ecb-jde ecb-method-browser hideshow ecb-file-browser ecb-layout
compile comint regexp-opt ansi-color ecb-create-layout ecb-compilation
ecb-speedbar ecb-common-browser ecb-cedet-wrapper semanticdb-find
ecb-navigate ecb-mode-line ecb-face tree-buffer ecb-upgrade ecb-util
thingatpt ede-generic eieio-opt help-mode view srecode-mode
cogre-srecode semantic-edit srecode-template-mode srecode-template
srecode-template-wy semantic-wisent wisent srecode-map srecode-insert
srecode-args srecode-dictionary srecode-find srecode-ctxt
srecode-compile srecode-table auto-complete easy-mmode popup eassist
edmacro kmacro semantic-lex-spp semanticdb-global semantic-symref-global
semantic-symref cedet-global semantic-gcc semantic-dep semantic-ia pulse
semantic-m3 semantic-analyze-refs cedet-m3 semantic-mru-bookmark
semanticdb-mode semantic-idle eldoc senator which-func semantic-imenu
semantic-sb imenu cedet cedet-contrib-load contrib-loaddefs cogre-load
cogre-loaddefs speedbar-load speedbar-loaddefs ede-load ede-loaddefs
ede-speedbar ede-files ede ede-base ede-auto eieio-speedbar
semantic-ia-sb semantic-analyze semantic-scope semantic-analyze-fcn
semantic-sort semanticdb-javap cedet-java semanticdb-el semanticdb-ref
semantic-find semanticdb semantic-ctxt semantic-format
semantic-util-modes semantic-util semantic semantic-lex semantic-tag-ls
semantic-tag working fame speedbar sb-image ezimage dframe easymenu
assoc eieio-custom wid-edit ede-source eieio-base srecode-load srecode
srecode-loaddefs semantic-load semantic-fw semantic-loaddefs mode-local
find-func derived eieio-load eieio-loaddefs cedet-load cedet-compat
cedet-loaddefs eieio warnings byte-opt bytecomp byte-compile cconv
macroexp cl inversion viper viper-ex viper-macs viper-mous viper-cmd
viper-keym ring viper-util viper-init advice help-fns advice-preload
paren cus-start cus-load time-date tooltip ediff-hook vc-hooks
lisp-float-type mwheel x-win x-dnd tool-bar dnd fontset image fringe
lisp-mode register page menu-bar rfn-eshadow timer select scroll-bar
mouse jit-lock font-lock syntax facemenu font-core frame cham georgian
utf-8-lang misc-lang vietnamese tibetan thai tai-viet lao korean
japanese hebrew greek romanian slovak czech european ethiopic indian
cyrillic chinese case-table epa-hook jka-cmpr-hook help simple abbrev
minibuffer loaddefs button faces cus-face files text-properties overlay
sha1 md5 base64 format env code-pages mule custom widget
hashtable-print-readable backquote make-network-process dbusbind
dynamic-setting system-font-setting font-render-setting x-toolkit x
multi-tty emacs)

--
Rodney Sparapani, PhD  Center for Patient Care and Outcomes Research
Sr. Biostatistician               http://www.mcw.edu/pcor
4 wheels good, 2 wheels better!   Medical College of Wisconsin (MCW)
WWLD?:  What Would Lombardi Do?   Milwaukee, WI, USA

gmon.txt
Description: Text document