lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [<thread-prev] [thread-next>] [day] [month] [year] [list]
Message-ID: <20101208214809.GG1709@nowhere>
Date:	Wed, 8 Dec 2010 22:48:13 +0100
From:	Frederic Weisbecker <fweisbec@...il.com>
To:	Nick Piggin <npiggin@...nel.dk>
Cc:	Arnaldo Carvalho de Melo <acme@...hat.com>,
	linux-kernel@...r.kernel.org
Subject: Re: buggy perf callgraph output

On Thu, Dec 09, 2010 at 03:40:15AM +1100, Nick Piggin wrote:
> Hi,
> 
> I get strange looking perf output with the callchain hits not sorted
> properly for graph and fractal:
> 
>      7.34%          open  [kernel.kallsyms]     [k] kmem_cache_alloc
>                     |
>                     --- kmem_cache_alloc
>                        |          
>                        |---0.05%-- get_empty_filp
>                        |          do_filp_open
>                        |          do_sys_open
>                        |          sys_open
>                        |          system_call
>                        |          __open_nocancel
>                        |          
>                         ---0.16%-- getname
>                                   do_sys_open
>                                   sys_open
>                                   system_call
>                                   __open_nocancel
> 
>      6.17%          open  [kernel.kallsyms]     [k] _raw_spin_lock
>                     |
>                     --- _raw_spin_lock
>                        |          
>                        |---0.01%-- add_partial
>                        |          __slab_free
>                        |          kmem_cache_free
>                        |          file_free_rcu
>                        |          __rcu_process_callbacks
>                        |          rcu_process_callbacks
>                        |          __do_softirq
>                        |          call_softirq
>                        |          do_softirq
>                        |          irq_exit
>                        |          smp_apic_timer_interrupt
>                        |          apic_timer_interrupt
>                        |          
>                        |---0.16%-- dput
>                        |          |          
>                        |           --0.57%-- fput
>                        |                     filp_close
>                        |                     sys_close
>                        |                     system_call
>                        |                     __libc_close
>                        |          
>                        |--0.60%-- link_path_walk
>                        |          do_path_lookup
>                        |          do_filp_open
>                        |          do_sys_open
>                        |          sys_open
>                        |          system_call
>                        |          __open_nocancel
>                        |          
>                        |--0.57%-- __slab_free
>                        |          kmem_cache_free
>                        |          file_free_rcu
>                        |          __rcu_process_callbacks
>                        |          rcu_process_callbacks
>                        |          __do_softirq
> 
> 
> With flat it looks a bit better:
>      7.34%          open  [kernel.kallsyms]     [k] kmem_cache_alloc
>              6.09%
>                 kmem_cache_alloc
>                 get_empty_filp
>                 do_filp_open
>                 do_sys_open
>                 sys_open
>                 system_call
>                 __open_nocancel
> 
>              1.07%
>                 kmem_cache_alloc
>                 getname
>                 do_sys_open
>                 sys_open
>                 system_call
>                 __open_nocancel
> 
>      6.17%          open  [kernel.kallsyms]     [k] _raw_spin_lock
>              0.60%
>                 _raw_spin_lock
>                 link_path_walk
>                 do_path_lookup
>                 do_filp_open
>                 do_sys_open
>                 sys_open
>                 system_call
>                 __open_nocancel
> 
>              0.57%
>                 _raw_spin_lock
>                 fd_install
>                 do_sys_open
>                 sys_open
>                 system_call
>                 __open_nocancel
> 
>              0.57%
>                 _raw_spin_lock
>                 dput
>                 fput
>                 filp_close
>                 sys_close
>                 system_call
>                 __libc_close


I can not reproduce it. Could you please try to reproduce,
run perf archive and send me your perf.data.tar.bz2 ?

Thanks.
--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@...r.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html
Please read the FAQ at  http://www.tux.org/lkml/

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ