All of lore.kernel.org
 help / color / mirror / Atom feed
From: Felipe Balbi <balbi@ti.com>
To: Peter Zijlstra <a.p.zijlstra@chello.nl>,
	Paul Mackerras <paulus@samba.org>, Ingo Molnar <mingo@redhat.com>,
	Arnaldo Carvalho de Melo <acme@kernel.org>
Cc: Tony Lindgren <tony@atomide.com>,
	Linux Kernel Mailing List <linux-kernel@vger.kernel.org>,
	Linux ARM Kernel Mailing List 
	<linux-arm-kernel@lists.infradead.org>,
	Linux OMAP Mailing List <linux-omap@vger.kernel.org>
Subject: perf not capturing stack traces
Date: Fri, 23 Jan 2015 13:51:28 -0600	[thread overview]
Message-ID: <20150123195128.GE26557@saruman.tx.rr.com> (raw)

[-- Attachment #1: Type: text/plain, Size: 8765 bytes --]

Hi,

I'm using v3.19-rc5 on an ARM Cortex A9 board. Unfortunately, perf is
not able to capture any stack traces even though I CONFIG_STACKTRACE,
CONFIG_FRAME_POINTER and CONFIG_ARM_UNWIND all enabled.

I wonder if anybody else is facing similar issues.

Here's console grab:

perf record -e 'sched:*' -ag sleep 5  && perf report --stdio
[ perf record: Woken up 1 times to write data ]
[ perf record: Captured and wrote 0.092 MB perf.data (~4024 samples) ]
# To display the perf.data header info, please use --header/--header-only option
#
# Samples: 0  of event 'sched:sched_kthread_stop'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_kthread_stop_ret'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 62  of event 'sched:sched_wakeup'
# Event count (approx.): 62
#
# Children      Self  Command      Shared Object  Symbol        
# ........  ........  ...........  .............  ..............
:#
    74.19%    74.19%  swapper      [unknown]      [.] 00000000  
                |
                ---0

    11.29%    11.29%  kworker/0:2  [unknown]      [.] 00000000  
            |
            ---0

     9.68%     9.68%  perf         [unknown]      [.] 00000000  
                   |
                   ---0

     3.23%     3.23%  sleep        [unknown]      [.] 00000000  
                  |
                  ---0

     1.61%     1.61%  ksoftirqd/0  [unknown]      [.] 00000000  
            |
            ---0



:# Samples: 0  of event 'sched:sched_wakeup_new'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 102  of event 'sched:sched_switch'
# Event count (approx.): 102
#
# Children      Self  Command       Shared Object  Symbol        
# ........  ........  ............  .............  ..............
#
    31.37%    31.37%  swapper       [unknown]      [.] 00000000  
                 |
                 ---0

    20.59%    20.59%  kworker/0:2   [unknown]      [.] 00000000  
             |
             ---0

    15.69%    15.69%  ksoftirqd/0   [unknown]      [.] 00000000  
:             |
             ---0

    11.76%    11.76%  perf          [unknown]      [.] 00000000  
                    |
                    ---0

    11.76%    11.76%  sleep         [unknown]      [.] 00000000  
                   |
                   ---0

     7.84%     7.84%  rcu_sched     [unknown]      [.] 00000000  
               |
               ---0

     0.98%     0.98%  kworker/u2:1  [unknown]      [.] 00000000  
            |
            ---0



# Samples: 0  of event 'sched:sched_migrate_task'
# Event count (approx.): 0
:#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_process_free'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 1  of event 'sched:sched_process_exit'
# Event count (approx.): 1
#
# Children      Self  Command  Shared Object  Symbol        
# ........  ........  .......  .............  ..............
#
   100.00%   100.00%  sleep    [unknown]      [.] 00000000  
              |
              ---0
:


# Samples: 0  of event 'sched:sched_wait_task'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_process_wait'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_process_fork'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
:# ........  ........  .......  .............  ......
#


# Samples: 1  of event 'sched:sched_process_exec'
# Event count (approx.): 1
#
# Children      Self  Command  Shared Object  Symbol        
# ........  ........  .......  .............  ..............
#
   100.00%   100.00%  sleep    [unknown]      [.] 00000000  
              |
              ---0



# Samples: 70  of event 'sched:sched_stat_wait'
# Event count (approx.): 17926123
#
# Children      Self  Command      Shared Object  Symbol        
# ........  ........  ...........  .............  ..............
#
    33.13%    33.13%  ksoftirqd/0  [unknown]      [.] 00000000  
:            |
            ---0

    24.83%    24.83%  perf         [unknown]      [.] 00000000  
                   |
                   ---0

    21.44%    21.44%  sleep        [unknown]      [.] 00000000  
                  |
                  ---0

    20.60%    20.60%  rcu_sched    [unknown]      [.] 00000000  
              |
              ---0

     0.00%     0.00%  kworker/0:2  [unknown]      [.] 00000000  
            |
            ---0

     0.00%     0.00%  swapper      [unknown]      [.] 00000000  
                |
                ---0

:

# Samples: 43  of event 'sched:sched_stat_sleep'
# Event count (approx.): 119659990589
#
# Children      Self  Command  Shared Object  Symbol        
# ........  ........  .......  .............  ..............
#
    95.01%    95.01%  swapper  [unknown]      [.] 00000000  
            |
            ---0

     4.93%     4.93%  sleep    [unknown]      [.] 00000000  
              |
              ---0

     0.06%     0.06%  perf     [unknown]      [.] 00000000  
               |
               ---0



# Samples: 7  of event 'sched:sched_stat_iowait'
:# Event count (approx.): 37447751
#
# Children      Self  Command      Shared Object  Symbol        
# ........  ........  ...........  .............  ..............
#
   100.00%   100.00%  kworker/0:2  [unknown]      [.] 00000000  
            |
            ---0



# Samples: 19  of event 'sched:sched_stat_blocked'
# Event count (approx.): 42514750
#
# Children      Self  Command      Shared Object  Symbol        
# ........  ........  ...........  .............  ..............
#
    88.08%    88.08%  kworker/0:2  [unknown]      [.] 00000000  
            |
            ---0

     7.24%     7.24%  swapper      [unknown]      [.] 00000000  
                |
:                ---0

     3.81%     3.81%  ksoftirqd/0  [unknown]      [.] 00000000  
            |
            ---0

     0.86%     0.86%  perf         [unknown]      [.] 00000000  
                   |
                   ---0



# Samples: 79  of event 'sched:sched_stat_runtime'
# Event count (approx.): 46820375
#
# Children      Self  Command       Shared Object  Symbol        
# ........  ........  ............  .............  ..............
#
    27.85%    27.85%  perf          [unknown]      [.] 00000000  
                    |
                    ---0

    27.48%    27.48%  kworker/0:2   [unknown]      [.] 00000000  
:             |
             ---0

    20.79%    20.79%  sleep         [unknown]      [.] 00000000  
                   |
                   ---0

    12.51%    12.51%  ksoftirqd/0   [unknown]      [.] 00000000  
             |
             ---0

     8.96%     8.96%  rcu_sched     [unknown]      [.] 00000000  
               |
               ---0

     2.41%     2.41%  kworker/u2:1  [unknown]      [.] 00000000  
            |
            ---0



# Samples: 0  of event 'sched:sched_pi_setprio'
# Event count (approx.): 0
:#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_move_numa'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_stick_numa'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_swap_numa'
:# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_wake_idle_without_ipi'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#

-- 
balbi

[-- Attachment #2: Digital signature --]
[-- Type: application/pgp-signature, Size: 819 bytes --]

WARNING: multiple messages have this Message-ID (diff)
From: balbi@ti.com (Felipe Balbi)
To: linux-arm-kernel@lists.infradead.org
Subject: perf not capturing stack traces
Date: Fri, 23 Jan 2015 13:51:28 -0600	[thread overview]
Message-ID: <20150123195128.GE26557@saruman.tx.rr.com> (raw)

Hi,

I'm using v3.19-rc5 on an ARM Cortex A9 board. Unfortunately, perf is
not able to capture any stack traces even though I CONFIG_STACKTRACE,
CONFIG_FRAME_POINTER and CONFIG_ARM_UNWIND all enabled.

I wonder if anybody else is facing similar issues.

Here's console grab:

perf record -e 'sched:*' -ag sleep 5  && perf report --stdio
[ perf record: Woken up 1 times to write data ]
[ perf record: Captured and wrote 0.092 MB perf.data (~4024 samples) ]
# To display the perf.data header info, please use --header/--header-only option
#
# Samples: 0  of event 'sched:sched_kthread_stop'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_kthread_stop_ret'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 62  of event 'sched:sched_wakeup'
# Event count (approx.): 62
#
# Children      Self  Command      Shared Object  Symbol        
# ........  ........  ...........  .............  ..............
:#
    74.19%    74.19%  swapper      [unknown]      [.] 00000000  
                |
                ---0

    11.29%    11.29%  kworker/0:2  [unknown]      [.] 00000000  
            |
            ---0

     9.68%     9.68%  perf         [unknown]      [.] 00000000  
                   |
                   ---0

     3.23%     3.23%  sleep        [unknown]      [.] 00000000  
                  |
                  ---0

     1.61%     1.61%  ksoftirqd/0  [unknown]      [.] 00000000  
            |
            ---0



:# Samples: 0  of event 'sched:sched_wakeup_new'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 102  of event 'sched:sched_switch'
# Event count (approx.): 102
#
# Children      Self  Command       Shared Object  Symbol        
# ........  ........  ............  .............  ..............
#
    31.37%    31.37%  swapper       [unknown]      [.] 00000000  
                 |
                 ---0

    20.59%    20.59%  kworker/0:2   [unknown]      [.] 00000000  
             |
             ---0

    15.69%    15.69%  ksoftirqd/0   [unknown]      [.] 00000000  
:             |
             ---0

    11.76%    11.76%  perf          [unknown]      [.] 00000000  
                    |
                    ---0

    11.76%    11.76%  sleep         [unknown]      [.] 00000000  
                   |
                   ---0

     7.84%     7.84%  rcu_sched     [unknown]      [.] 00000000  
               |
               ---0

     0.98%     0.98%  kworker/u2:1  [unknown]      [.] 00000000  
            |
            ---0



# Samples: 0  of event 'sched:sched_migrate_task'
# Event count (approx.): 0
:#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_process_free'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 1  of event 'sched:sched_process_exit'
# Event count (approx.): 1
#
# Children      Self  Command  Shared Object  Symbol        
# ........  ........  .......  .............  ..............
#
   100.00%   100.00%  sleep    [unknown]      [.] 00000000  
              |
              ---0
:


# Samples: 0  of event 'sched:sched_wait_task'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_process_wait'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_process_fork'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
:# ........  ........  .......  .............  ......
#


# Samples: 1  of event 'sched:sched_process_exec'
# Event count (approx.): 1
#
# Children      Self  Command  Shared Object  Symbol        
# ........  ........  .......  .............  ..............
#
   100.00%   100.00%  sleep    [unknown]      [.] 00000000  
              |
              ---0



# Samples: 70  of event 'sched:sched_stat_wait'
# Event count (approx.): 17926123
#
# Children      Self  Command      Shared Object  Symbol        
# ........  ........  ...........  .............  ..............
#
    33.13%    33.13%  ksoftirqd/0  [unknown]      [.] 00000000  
:            |
            ---0

    24.83%    24.83%  perf         [unknown]      [.] 00000000  
                   |
                   ---0

    21.44%    21.44%  sleep        [unknown]      [.] 00000000  
                  |
                  ---0

    20.60%    20.60%  rcu_sched    [unknown]      [.] 00000000  
              |
              ---0

     0.00%     0.00%  kworker/0:2  [unknown]      [.] 00000000  
            |
            ---0

     0.00%     0.00%  swapper      [unknown]      [.] 00000000  
                |
                ---0

:

# Samples: 43  of event 'sched:sched_stat_sleep'
# Event count (approx.): 119659990589
#
# Children      Self  Command  Shared Object  Symbol        
# ........  ........  .......  .............  ..............
#
    95.01%    95.01%  swapper  [unknown]      [.] 00000000  
            |
            ---0

     4.93%     4.93%  sleep    [unknown]      [.] 00000000  
              |
              ---0

     0.06%     0.06%  perf     [unknown]      [.] 00000000  
               |
               ---0



# Samples: 7  of event 'sched:sched_stat_iowait'
:# Event count (approx.): 37447751
#
# Children      Self  Command      Shared Object  Symbol        
# ........  ........  ...........  .............  ..............
#
   100.00%   100.00%  kworker/0:2  [unknown]      [.] 00000000  
            |
            ---0



# Samples: 19  of event 'sched:sched_stat_blocked'
# Event count (approx.): 42514750
#
# Children      Self  Command      Shared Object  Symbol        
# ........  ........  ...........  .............  ..............
#
    88.08%    88.08%  kworker/0:2  [unknown]      [.] 00000000  
            |
            ---0

     7.24%     7.24%  swapper      [unknown]      [.] 00000000  
                |
:                ---0

     3.81%     3.81%  ksoftirqd/0  [unknown]      [.] 00000000  
            |
            ---0

     0.86%     0.86%  perf         [unknown]      [.] 00000000  
                   |
                   ---0



# Samples: 79  of event 'sched:sched_stat_runtime'
# Event count (approx.): 46820375
#
# Children      Self  Command       Shared Object  Symbol        
# ........  ........  ............  .............  ..............
#
    27.85%    27.85%  perf          [unknown]      [.] 00000000  
                    |
                    ---0

    27.48%    27.48%  kworker/0:2   [unknown]      [.] 00000000  
:             |
             ---0

    20.79%    20.79%  sleep         [unknown]      [.] 00000000  
                   |
                   ---0

    12.51%    12.51%  ksoftirqd/0   [unknown]      [.] 00000000  
             |
             ---0

     8.96%     8.96%  rcu_sched     [unknown]      [.] 00000000  
               |
               ---0

     2.41%     2.41%  kworker/u2:1  [unknown]      [.] 00000000  
            |
            ---0



# Samples: 0  of event 'sched:sched_pi_setprio'
# Event count (approx.): 0
:#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_move_numa'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_stick_numa'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_swap_numa'
:# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#


# Samples: 0  of event 'sched:sched_wake_idle_without_ipi'
# Event count (approx.): 0
#
# Children      Self  Command  Shared Object  Symbol
# ........  ........  .......  .............  ......
#

-- 
balbi
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 819 bytes
Desc: Digital signature
URL: <http://lists.infradead.org/pipermail/linux-arm-kernel/attachments/20150123/8cc673a6/attachment-0001.sig>

             reply	other threads:[~2015-01-23 19:52 UTC|newest]

Thread overview: 45+ messages / expand[flat|nested]  mbox.gz  Atom feed  top
2015-01-23 19:51 Felipe Balbi [this message]
2015-01-23 19:51 ` perf not capturing stack traces Felipe Balbi
2015-01-23 19:51 ` Felipe Balbi
2015-01-23 19:53 ` Felipe Balbi
2015-01-23 19:53   ` Felipe Balbi
2015-01-23 19:53   ` Felipe Balbi
2015-01-23 20:59 ` Arnaldo Carvalho de Melo
2015-01-23 20:59   ` Arnaldo Carvalho de Melo
2015-01-23 20:59   ` Arnaldo Carvalho de Melo
2015-01-23 22:37   ` Felipe Balbi
2015-01-23 22:37     ` Felipe Balbi
2015-01-23 22:37     ` Felipe Balbi
2015-01-24 15:12     ` Arnaldo Carvalho de Melo
2015-01-24 15:12       ` Arnaldo Carvalho de Melo
2015-01-24 15:12       ` Arnaldo Carvalho de Melo
2015-01-24 22:23       ` Felipe Balbi
2015-01-24 22:23         ` Felipe Balbi
2015-01-24 22:23         ` Felipe Balbi
2015-01-25 15:56         ` Russell King - ARM Linux
2015-01-25 15:56           ` Russell King - ARM Linux
2015-01-25 15:56           ` Russell King - ARM Linux
2015-01-26 10:27           ` Will Deacon
2015-01-26 10:27             ` Will Deacon
2015-01-26 10:27             ` Will Deacon
2015-01-26 12:12             ` Arnaldo Carvalho de Melo
2015-01-26 12:12               ` Arnaldo Carvalho de Melo
2015-01-26 12:12               ` Arnaldo Carvalho de Melo
2015-01-26 12:16               ` Will Deacon
2015-01-26 12:16                 ` Will Deacon
2015-01-26 12:16                 ` Will Deacon
2015-01-26 12:29                 ` Arnaldo Carvalho de Melo
2015-01-26 12:29                   ` Arnaldo Carvalho de Melo
2015-01-26 12:29                   ` Arnaldo Carvalho de Melo
2015-01-26 13:54               ` Russell King - ARM Linux
2015-01-26 13:54                 ` Russell King - ARM Linux
2015-01-26 13:54                 ` Russell King - ARM Linux
2015-01-26 14:33                 ` Arnaldo Carvalho de Melo
2015-01-26 14:33                   ` Arnaldo Carvalho de Melo
2015-01-26 14:33                   ` Arnaldo Carvalho de Melo
2015-01-26 13:51             ` Russell King - ARM Linux
2015-01-26 13:51               ` Russell King - ARM Linux
2015-01-26 13:51               ` Russell King - ARM Linux
2015-01-26 14:37               ` Arnaldo Carvalho de Melo
2015-01-26 14:37                 ` Arnaldo Carvalho de Melo
2015-01-26 14:37                 ` Arnaldo Carvalho de Melo

Reply instructions:

You may reply publicly to this message via plain-text email
using any one of the following methods:

* Save the following mbox file, import it into your mail client,
  and reply-to-all from there: mbox

  Avoid top-posting and favor interleaved quoting:
  https://en.wikipedia.org/wiki/Posting_style#Interleaved_style

* Reply using the --to, --cc, and --in-reply-to
  switches of git-send-email(1):

  git send-email \
    --in-reply-to=20150123195128.GE26557@saruman.tx.rr.com \
    --to=balbi@ti.com \
    --cc=a.p.zijlstra@chello.nl \
    --cc=acme@kernel.org \
    --cc=linux-arm-kernel@lists.infradead.org \
    --cc=linux-kernel@vger.kernel.org \
    --cc=linux-omap@vger.kernel.org \
    --cc=mingo@redhat.com \
    --cc=paulus@samba.org \
    --cc=tony@atomide.com \
    /path/to/YOUR_REPLY

  https://kernel.org/pub/software/scm/git/docs/git-send-email.html

* If your mail client supports setting the In-Reply-To header
  via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line before the message body.
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.