Re: emacs hangs; 100% cpu usage

[Reiner Steib]

On Wed, Jan 12 2005, Daniel Schmitt wrote:

[...]
> Open cpp file, edit it, do M-x compile, edit again, compile again ...
> emacs hangs and uses 100% cpu.  gdb output after "kill -TSTP PID" below.
[...]
> [ CVS checkout on 2005-01-12 ]
>
> In GNU Emacs 21.3.50.19 (x86_64-unknown-linux-gnu, GTK+ Version 2.4.9)
>  of 2005-01-12 on bridgekeeper
> Distributor `The X.Org Foundation', version 11.0.60801000
> configured using `configure '--prefix=/import/xtra/emacs/HEAD' '--with-gtk' 
> '--exec-prefix=/import/xtra/emacs/HEAD-x86_64''

Daniel is my colleague.  He uses the same Emacs built as I do.
Probably it is important to mention that this Emacs is a built (and
run) on 64-bit machines (Daniel: AMD Athlon(tm) 64 Processor 3200+,
me: AMD Athlon(tm) 64 Processor 3500+).

Yesterday and today, I also saw the same symptoms with this built
while using Gnus, doing some editing (see attached gdb output:
emacs-gdb-2005-01-12.log and emacs-gdb-2005-01-13.log; after "kill
-TSTP $pid" as suggested in etc/DEBUG).  Before yesterday I always
build Emacs on a 32-bit machine and run it on both, i686 and x86_64.
There were no such problems with the 32-bit built used on 64-bit
machines.

Bye, Reiner.

[Thread debugging using libthread_db enabled]
[New Thread 182940272320 (LWP 5682)]
Detaching after fork from child process 5685.
Detaching after fork from child process 5686.
Detaching after fork from child process 5687.
Detaching after fork from child process 5692.
Detaching after fork from child process 5695.
Detaching after fork from child process 13764.
Detaching after fork from child process 13765.
Detaching after fork from child process 13792.
Detaching after fork from child process 13793.
Detaching after fork from child process 13820.
Detaching after fork from child process 13821.
Detaching after fork from child process 19071.
Detaching after fork from child process 19074.
Detaching after fork from child process 19075.

Program received signal SIGTSTP, Stopped (user).
[Switching to Thread 182940272320 (LWP 5682)]
0x0000000000533edf in survives_gc_p (obj=35054947) at alloc.c:5523
5523      return survives_p || PURE_POINTER_P ((void *) XPNTR (obj));
(gdb) bt
#0  0x0000000000533edf in survives_gc_p (obj=35054947) at alloc.c:5523
#1  0x00000000005532e2 in sweep_weak_table (h=0x125f620, remove_entries_p=0)
    at fns.c:4803
#2  0x000000000055346f in sweep_weak_hash_tables () at fns.c:4888
#3  0x0000000000537e51 in Fgarbage_collect () at alloc.c:5535
#4  0x0000000000578df4 in Fbyte_code (bytestr=9605921, vector=Variable "vector" 
is not available.
)
    at bytecode.c:531
#5  0x000000000054c1cd in funcall_lambda (fun=18781812, nargs=3, 
    arg_vector=0x7fbfffb718) at eval.c:2962
#6  0x000000000054c72e in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2832
#7  0x00000000005788e9 in Fbyte_code (bytestr=18469745, vector=Variable 
"vector" is not available.
)
    at bytecode.c:686
#8  0x000000000054c1cd in funcall_lambda (fun=18881796, nargs=3, 
    arg_vector=0x7fbfffb8c8) at eval.c:2962
#9  0x000000000054c72e in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2832
#10 0x00000000005788e9 in Fbyte_code (bytestr=18469745, vector=Variable 
"vector" is not available.
)
    at bytecode.c:686
#11 0x000000000054c1cd in funcall_lambda (fun=18834004, nargs=2, 
    arg_vector=0x7fbfffbba0) at eval.c:2962
#12 0x000000000054c72e in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2832
#13 0x000000000054e140 in run_hook_with_args (nargs=3, args=0x7fbfffbb98, 
    cond=to_completion) at eval.c:2443
#14 0x000000000054c9e4 in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2756
#15 0x00000000005788e9 in Fbyte_code (bytestr=10075121, vector=Variable 
"vector" is not available.
)
    at bytecode.c:686
#16 0x000000000054bd80 in Feval (form=Variable "form" is not available.
) at eval.c:2136
#17 0x000000000054e8f8 in Fcondition_case (args=Variable "args" is not 
available.
) at eval.c:1332
#18 0x0000000000577e7f in Fbyte_code (bytestr=10075121, vector=Variable 
"vector" is not available.
)
    at bytecode.c:864
#19 0x000000000054c1cd in funcall_lambda (fun=27235364, nargs=2, 
    arg_vector=0x7fbfffc0e8) at eval.c:2962
#20 0x000000000054c72e in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2832
#21 0x00000000005788e9 in Fbyte_code (bytestr=18152209, vector=Variable 
"vector" is not available.
)
    at bytecode.c:686
#22 0x000000000054bd80 in Feval (form=Variable "form" is not available.
) at eval.c:2136
#23 0x000000000054e8f8 in Fcondition_case (args=Variable "args" is not 
available.
) at eval.c:1332
#24 0x0000000000577e7f in Fbyte_code (bytestr=9875249, vector=Variable "vector" 
is not available.
)
    at bytecode.c:864
#25 0x000000000054c1cd in funcall_lambda (fun=27007332, nargs=0, 
    arg_vector=0x7fbfffc720) at eval.c:2962
#26 0x000000000054c72e in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2832
#27 0x000000000054e419 in Fapply (nargs=2, args=0x7fbfffc718) at eval.c:2224
#28 0x000000000054c9e4 in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2756
#29 0x00000000005788e9 in Fbyte_code (bytestr=13582481, vector=Variable 
"vector" is not available.
)
    at bytecode.c:686
#30 0x000000000054bd80 in Feval (form=Variable "form" is not available.
) at eval.c:2136
#31 0x000000000054e8f8 in Fcondition_case (args=Variable "args" is not 
available.
) at eval.c:1332
#32 0x0000000000577e7f in Fbyte_code (bytestr=13582481, vector=Variable 
"vector" is not available.
)
    at bytecode.c:864
#33 0x000000000054c1cd in funcall_lambda (fun=8400428, nargs=1, 
    arg_vector=0x7fbfffcc58) at eval.c:2962
#34 0x000000000054c72e in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2832
#35 0x000000000054df82 in call1 (fn=Variable "fn" is not available.
) at eval.c:2565
#36 0x00000000004eae6b in timer_check (do_it_now=Variable "do_it_now" is not 
available.
) at keyboard.c:4453
#37 0x00000000004eb13d in readable_filtered_events (do_timers_now=Variable 
"do_timers_now" is not available.
)
    at keyboard.c:3504
#38 0x00000000004eb222 in get_filtered_input_pending (addr=0x916288, 
    do_timers_now=1, filter_events=0) at keyboard.c:6541
#39 0x00000000004eb300 in detect_input_pending_run_timers (do_display=1)
    at keyboard.c:9883
#40 0x000000000057effe in wait_reading_process_output (time_limit=30, 
    microsecs=0, read_kbd=-1, do_display=1, wait_for_cell=9605153, 
    wait_proc=0x0, just_wait_proc=0) at process.c:4452
#41 0x000000000044a331 in sit_for (sec=30, usec=0, reading=dwarf2_read_address: 
Corrupted DWARF expression.
) at dispnew.c:6367
#42 0x00000000004ef348 in read_char (commandflag=1, nmaps=4, 
    maps=0x7fbfffd5d0, prev_event=9605153, used_mouse_menu=0x7fbfffd654)
    at keyboard.c:2762
#43 0x00000000004f1516 in read_key_sequence (keybuf=0x7fbfffd7f0, bufsize=30, 
    prompt=9605153, dont_downcase_last=0, can_return_switch_frame=1, 
    fix_current_buffer=1) at keyboard.c:8818
#44 0x00000000004f313d in command_loop_1 () at keyboard.c:1531
#45 0x000000000054b441 in internal_condition_case (
    bfun=0x4f2fa0 <command_loop_1>, handlers=9716673, 
    hfun=0x4ed5f0 <cmd_error>) at eval.c:1385
#46 0x00000000004ec87a in command_loop_2 () at keyboard.c:1312
#47 0x000000000054b590 in internal_catch (tag=Variable "tag" is not available.
) at eval.c:1144
#48 0x00000000004ed288 in command_loop () at keyboard.c:1291
#49 0x00000000004ed321 in recursive_edit_1 () at keyboard.c:984
#50 0x00000000004ed44e in Frecursive_edit () at keyboard.c:1045
#51 0x00000000004e2e0d in main (argc=9, argv=0x7fbfffe078) at emacs.c:1763


(gdb) xbacktrace 
"font-lock-fontify-syntactically-region"
"font-lock-default-fontify-region"
"font-lock-fontify-region"
"run-hook-with-args"
"byte-code"
"jit-lock-fontify-now"
"byte-code"
"jit-lock-stealth-fontify"
"apply"
"byte-code"
"timer-event-handler"

DISPLAY = :0.0
TERM = screen
Breakpoint 1 at 0x4e1f60: file emacs.c, line 453.
Function "x_error_quitter" not defined.
(gdb) r --eval '(setq-default default-directory "~/")' -name Gnus -xrm 
'Emacs.toolBar:1' -f gnus
Starting program: 
/import/Archive/Groups/Productivity/Editors/Emacs/emacs/cvs-HEAD/x86_64/src/emacs
 --eval '(setq-default default-directory "~/")' -name Gnus -xrm 
'Emacs.toolBar:1' -f gnus
[Thread debugging using libthread_db enabled]
[New Thread 182940272320 (LWP 26327)]
Detaching after fork from child process 26330.
Detaching after fork from child process 26333.
Detaching after fork from child process 26334.
Detaching after fork from child process 26337.
Detaching after fork from child process 28765.
Detaching after fork from child process 28766.
Detaching after fork from child process 28794.
Detaching after fork from child process 28795.
Detaching after fork from child process 28796.
Detaching after fork from child process 28797.
Detaching after fork from child process 28870.
Detaching after fork from child process 28885.
Detaching after fork from child process 28886.

Program received signal SIGTSTP, Stopped (user).
[Switching to Thread 182940272320 (LWP 26327)]
0x000000000055319a in sweep_weak_table (h=0x1227ae0, remove_entries_p=0)
    at fns.c:4799
4799          for (idx = HASH_INDEX (h, bucket); !GC_NILP (idx); idx = next)

(gdb) xbacktrace 
"sit-for"
"byte-code"
"jit-lock-stealth-fontify"
"apply"
"byte-code"
"timer-event-handler"

#0  0x000000000055319a in sweep_weak_table (h=0x1227ae0, remove_entries_p=0)
    at fns.c:4799
#1  0x00000000005533ff in sweep_weak_hash_tables () at fns.c:4888
#2  0x0000000000537de1 in Fgarbage_collect () at alloc.c:5535
#3  0x000000000054ba23 in Feval (form=10270245) at eval.c:2029
#4  0x000000000054b248 in internal_condition_case_1 (bfun=0x54b7a0 <Feval>, 
    arg=10270245, handlers=9605249, hfun=0x46a1a0 <safe_eval_handler>)
    at eval.c:1426
#5  0x00000000004680a1 in safe_eval (sexpr=10270245) at xdisp.c:1876
#6  0x000000000046c3f8 in display_mode_element (it=0x7fbfffa3e0, depth=4, 
    field_width=-2, precision=-2, elt=10270085, props=9605153, risky=0)
    at xdisp.c:15768
#7  0x000000000046c4f2 in display_mode_element (it=0x7fbfffa3e0, depth=3, 
    field_width=-1, precision=-1, elt=10270117, props=9605153, risky=0)
    at xdisp.c:15849
#8  0x000000000046c4f2 in display_mode_element (it=0x7fbfffa3e0, depth=1, 
    field_width=0, precision=0, elt=34094469, props=9605153, risky=0)
    at xdisp.c:15849
#9  0x0000000000471de4 in display_mode_line (w=Variable "w" is not available.
) at xdisp.c:15422
#10 0x0000000000472049 in display_mode_lines (w=0x281d8b0) at xdisp.c:15377
#11 0x000000000047a266 in redisplay_window (window=42064052, just_this_one_p=0)
    at xdisp.c:12254
#12 0x000000000047b9dd in redisplay_window_0 (window=Variable "window" is not 
available.
) at xdisp.c:10710
#13 0x000000000054b248 in internal_condition_case_1 (
    bfun=0x47b9b0 <redisplay_window_0>, arg=42064052, handlers=9634469, 
    hfun=0x45a0f0 <redisplay_window_error>) at eval.c:1426
#14 0x0000000000468015 in redisplay_windows (window=Variable "window" is not 
available.
) at xdisp.c:10689
#15 0x0000000000467fc7 in redisplay_windows (window=Variable "window" is not 
available.
) at xdisp.c:10683
#16 0x0000000000474345 in redisplay_internal (preserve_echo_area=Variable 
"preserve_echo_area" is not available.
)
    at xdisp.c:10271
#17 0x0000000000474cea in redisplay_preserve_echo_area (from_where=Variable 
"from_where" is not available.
)
    at xdisp.c:10500
#18 0x000000000044a2ff in sit_for (sec=0, usec=125000, reading=0, display=1, 
    initial_display=1) at dispnew.c:6358
#19 0x000000000054c926 in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2782
#20 0x0000000000578879 in Fbyte_code (bytestr=27099841, vector=Variable 
"vector" is not available.
)
    at bytecode.c:686
#21 0x000000000054bd10 in Feval (form=Variable "form" is not available.
) at eval.c:2136
#22 0x000000000054e888 in Fcondition_case (args=Variable "args" is not 
available.
) at eval.c:1332
#23 0x0000000000577e0f in Fbyte_code (bytestr=9875249, vector=Variable "vector" 
is not available.
)
    at bytecode.c:864
#24 0x000000000054c15d in funcall_lambda (fun=27004532, nargs=0, 
    arg_vector=0x7fbfffc720) at eval.c:2962
#25 0x000000000054c6be in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2832
#26 0x000000000054e3a9 in Fapply (nargs=2, args=0x7fbfffc718) at eval.c:2224
#27 0x000000000054c974 in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2756
#28 0x0000000000578879 in Fbyte_code (bytestr=13512993, vector=Variable 
"vector" is not available.
)
    at bytecode.c:686
#29 0x000000000054bd10 in Feval (form=Variable "form" is not available.
) at eval.c:2136
#30 0x000000000054e888 in Fcondition_case (args=Variable "args" is not 
available.
) at eval.c:1332
#31 0x0000000000577e0f in Fbyte_code (bytestr=13512993, vector=Variable 
"vector" is not available.
)
    at bytecode.c:864
#32 0x000000000054c15d in funcall_lambda (fun=8400764, nargs=1, 
    arg_vector=0x7fbfffcc58) at eval.c:2962
#33 0x000000000054c6be in Ffuncall (nargs=Variable "nargs" is not available.
) at eval.c:2832
#34 0x000000000054df12 in call1 (fn=Variable "fn" is not available.
) at eval.c:2565
#35 0x00000000004eadfb in timer_check (do_it_now=Variable "do_it_now" is not 
available.
) at keyboard.c:4453
#36 0x00000000004eb0cd in readable_filtered_events (do_timers_now=Variable 
"do_timers_now" is not available.
)
    at keyboard.c:3504
#37 0x00000000004eb1b2 in get_filtered_input_pending (addr=0x916288, 
---Type <return> to continue, or q <return> to quit---
    do_timers_now=1, filter_events=0) at keyboard.c:6541
#38 0x00000000004eb290 in detect_input_pending_run_timers (do_display=1)
    at keyboard.c:9883
#39 0x000000000057ef8e in wait_reading_process_output (time_limit=30, 
    microsecs=0, read_kbd=-1, do_display=1, wait_for_cell=9605153, 
    wait_proc=0x0, just_wait_proc=0) at process.c:4452
#40 0x000000000044a331 in sit_for (sec=30, usec=0, reading=1, display=1, 
    initial_display=0) at dispnew.c:6367
#41 0x00000000004ef2d8 in read_char (commandflag=1, nmaps=4, 
    maps=0x7fbfffd5d0, prev_event=9605153, used_mouse_menu=0x7fbfffd654)
    at keyboard.c:2762
#42 0x00000000004f14a6 in read_key_sequence (keybuf=0x7fbfffd7f0, bufsize=30, 
    prompt=9605153, dont_downcase_last=0, can_return_switch_frame=1, 
    fix_current_buffer=1) at keyboard.c:8818
#43 0x00000000004f30cd in command_loop_1 () at keyboard.c:1531
#44 0x000000000054b3d1 in internal_condition_case (
    bfun=0x4f2f30 <command_loop_1>, handlers=9716673, 
    hfun=0x4ed580 <cmd_error>) at eval.c:1385
#45 0x00000000004ec80a in command_loop_2 () at keyboard.c:1312
#46 0x000000000054b520 in internal_catch (tag=Variable "tag" is not available.
) at eval.c:1144
#47 0x00000000004ed218 in command_loop () at keyboard.c:1291
#48 0x00000000004ed2b1 in recursive_edit_1 () at keyboard.c:984
#49 0x00000000004ed3de in Frecursive_edit () at keyboard.c:1045
#50 0x00000000004e2d9d in main (argc=9, argv=0x7fbfffe078) at emacs.c:1763