GNOME.org
 

Re: [Tracker] tracker-miner-fs crash?

2009/11/10 Philip Van Hoof <spam pvanhoof be>:

On Tue, 2009-11-10 at 17:14 +0200, Tshepang Lekhonkhobe wrote:

On Tue, Nov 10, 2009 at 17:08, Tshepang Lekhonkhobe<tshepang gmail com> wrote:



Auwch, this is memory corruption in the gslice magazine allocator.


This new issue isn't related to the corruption btw. But right that you
can't continue with fatal-criticals unless this new issue is fixed.




We'll need to you to run valgrind with

export G_SLICE=always-malloc
export G_DEBUG=gc-friendly

And reproduce to find this issue

You can also set G_DEBUG=fatal-criticals so that we can find where the
criticals are coming from. If we are lucky those criticals are related
to the memory corruption. Meaning that we have good assertions ;-)


running:

$ G_SLICE=always-malloc G_DEBUG=fatal-criticals valgrind
--leak-check=full --show-reachable=yes --leak-resolution=high -v
--log-file=valgrind.log /usr/libexec/tracker-miner-fs

produces a quick crash:

[snip]
Tracker-Message: Starting next miner...
(tracker-miner-fs:23552): Tracker-DEBUG: URN '(null)' (mount point:


Owk, so your device's URN is NULL. That's probably why I'm not seeing
this here.

Can you reproduce this in gdb instead and give me a a copypaste of what
thread apply all bt in gdb tells you?


[snip]
(tracker-miner-fs:23811): Tracker-DEBUG: Adding item
'file:///usr/share/icons/hicolor'
(tracker-miner-fs:23811): Tracker-DEBUG: Adding item
'file:///home/wena/nna/store/NB'
[Thread 0xb42fcb70 (LWP 2125) exited]
Tracker-Message: Received monitor event:8->'IN_CLOSE_WRITE |
IN_CLOSE*' for file:'/home/wena/.pulse-cookie' (cookie:0)
(tracker-miner-fs:23811): Tracker-DEBUG: Setting up cached events timeout check
(tracker-miner-fs:23811): Tracker-DEBUG: Checking for cached events
that have timed out...
(tracker-miner-fs:23811): Tracker-DEBUG: Comparing now:1257917482 to
then:1257917481 (start:1257917481), diff:1 (with start:1)
(tracker-miner-fs:23811): Tracker-DEBUG: Cached event:8 has timed out
(1 seconds have elapsed)
(tracker-miner-fs:23811): Tracker-DEBUG:
Ignored:'/home/wena/.pulse-cookie' (FILE) (update monitor event or
user request)
(tracker-miner-fs:23811): Tracker-DEBUG: No more cached events, removing timeout
Tracker-Message: Received monitor event:8->'IN_CLOSE_WRITE |
IN_CLOSE*' for file:'/home/wena/.pulse-cookie' (cookie:0)
(tracker-miner-fs:23811): Tracker-DEBUG: Setting up cached events timeout check
(tracker-miner-fs:23811): Tracker-DEBUG: Checking for cached events
that have timed out...
(tracker-miner-fs:23811): Tracker-DEBUG: Comparing now:1257917676 to
then:1257917675 (start:1257917675), diff:1 (with start:1)
(tracker-miner-fs:23811): Tracker-DEBUG: Cached event:8 has timed out
(1 seconds have elapsed)
(tracker-miner-fs:23811): Tracker-DEBUG:
Ignored:'/home/wena/.pulse-cookie' (FILE) (update monitor event or
user request)
(tracker-miner-fs:23811): Tracker-DEBUG: No more cached events, removing timeout
Tracker-Message: Received monitor event:256->'IN_CREATE' for
file:'/home/wena/.goutputstream-M84W2U' (cookie:0)
(tracker-miner-fs:23811): Tracker-DEBUG: Setting up cached events timeout check
Tracker-Message: Received monitor event:4->'IN_ATTRIB' for
file:'/home/wena/.goutputstream-M84W2U' (cookie:0)
Tracker-Message: Received monitor event:8->'IN_CLOSE_WRITE |
IN_CLOSE*' for file:'/home/wena/.gtk-bookmarks' (cookie:0)
Tracker-Message: Received monitor event:64->'IN_MOVED_FROM | IN_MOVE*'
for file:'/home/wena/.goutputstream-M84W2U' (cookie:76829)
(tracker-miner-fs:23811): Tracker-DEBUG: Setting up event pair timeout check
(tracker-miner-fs:23811): Tracker-DEBUG: Cached event:256 being
handled before IN_MOVED_FROM | IN_MOVE*

Program received signal SIGSEGV, Segmentation fault.
magazine_chain_pop_head (mem_size=12) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gslice.c:474
474     /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gslice.c:
No such file or directory.
        in /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gslice.c
(gdb) thread apply all bt

Thread 1 (Thread 0xb7a04a50 (LWP 23811)):
#0  magazine_chain_pop_head (mem_size=12) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gslice.c:474
#1  thread_memory_magazine1_alloc (mem_size=12) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gslice.c:777
#2  IA__g_slice_alloc (mem_size=12) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gslice.c:815
#3  0xb7c4c243 in IA__g_string_sized_new (dfl_size=2) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gstring.c:380
#4  0xb7c313a3 in IA__g_log_default_handler (log_domain=0xb7e5eed1
"Tracker", log_level=<value optimized out>,
    message=0xb5b13860 "Found :'/home/wena/.goutputstream-M84W2U'
(FILE) (create monitor event or user request)", unused_data=0x0)
    at /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gmessages.c:950
#5  0xb7f69b11 in tracker_log_handler (domain=0xb7e5eed1 "Tracker",
log_level=G_LOG_LEVEL_DEBUG,
    message=0xb5b13860 "Found :'/home/wena/.goutputstream-M84W2U'
(FILE) (create monitor event or user request)", user_data=0x0) at
tracker-log.c:139
#6  0xb7c319ca in IA__g_logv (log_domain=0xb7e5eed1 "Tracker",
log_level=G_LOG_LEVEL_DEBUG, format=0xb7e6077c "%s:'%s' (%s) (create
monitor event or user request)",
    args1=0xbfffecfc "\206") at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gmessages.c:519
#7  0xb7c31d86 in IA__g_log (log_domain=0xb7e5eed1 "Tracker",
log_level=G_LOG_LEVEL_DEBUG, format=0xb7e6077c "%s:'%s' (%s) (create
monitor event or user request)")
    at /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gmessages.c:569
#8  0xb7e4e535 in monitor_item_created_cb (monitor=0x8078140,
file=0x94393b0, is_directory=0, user_data=0x807e010) at
tracker-miner-fs.c:1473
#9  0xb7e48b83 in tracker_marshal_VOID__OBJECT_BOOLEAN
(closure=0x807dd08, return_value=0x0, n_param_values=3,
param_values=0x8062598, invocation_hint=0xbfffeeac,
    marshal_data=0xb7e4e460) at tracker-marshal.c:82
#10 0xb7cb3de3 in IA__g_closure_invoke (closure=0x807dd08,
return_value=0x0, n_param_values=3, param_values=0x8062598,
invocation_hint=0xbfffeeac)
    at /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/gobject/gclosure.c:767
#11 0xb7cc7f0f in signal_emit_unlocked_R (node=0x807a7b0, detail=0,
instance=0x8078140, emission_return=0x0,
instance_and_params=0x8062598)
    at /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/gobject/gsignal.c:3247
#12 0xb7cc9359 in IA__g_signal_emit_valist (instance=0x8078140,
signal_id=26, detail=0, var_args=0xbffff054 "\200")
    at /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/gobject/gsignal.c:2980
#13 0xb7cc97b6 in IA__g_signal_emit (instance=0x8078140, signal_id=26,
detail=0) at /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/gobject/gsignal.c:3037
#14 0xb7e50fa4 in libinotify_cached_event_handle (monitor=0x8078140,
data=0x3, is_directory=0) at tracker-monitor.c:717
#15 0xb7e51036 in libinotify_monitor_force_emission
(monitor=0x8078140, file=<value optimized out>, event_type=64,
is_directory=0) at tracker-monitor.c:866
#16 0xb7e515a5 in libinotify_monitor_event_cb (handle=0x8079848,
monitor_name=0x8066bc8 "/home/wena", filename=0xbffff15c
".goutputstream-M84W2U", event_type=64, cookie=76829,
    user_data=0x8078140) at tracker-monitor.c:1026
#17 0xb7e5e925 in inotify_handle_invoke_callback (inh=0x8079848,
filename=0xbffff15c ".goutputstream-M84W2U", type=64, cookie=76829) at
inotify-handle.c:272
#18 0xb7e5e2fa in process_one_event (source=0x807dc90,
condition=G_IO_IN, data=0x0) at inotify-monitor.c:52
#19 inotify_watch_func (source=0x807dc90, condition=G_IO_IN, data=0x0)
at inotify-monitor.c:96
#20 0xb7c5e7ed in g_io_unix_dispatch (source=0x8078f98,
callback=0xb7e5e1b0 <inotify_watch_func>, user_data=0x0)
    at /build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/giounix.c:162
#21 0xb7c27e98 in g_main_dispatch (context=0x8070538) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gmain.c:1960
#22 IA__g_main_context_dispatch (context=0x8070538) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gmain.c:2513
#23 0xb7c2b623 in g_main_context_iterate (context=0x8070538, block=1,
dispatch=1, self=0x805d850) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gmain.c:2591
#24 0xb7c2baea in IA__g_main_loop_run (loop=0x80867d0) at
/build/buildd-glib2.0_2.22.2-2-i386-R8GTDn/glib2.0-2.22.2/glib/gmain.c:2799
#25 0x08050c0c in main (argc=134684488, argv=0x2) at tracker-main.c:343



-- 
my place on the web:
floss-and-misc.blogspot.com
[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]