Re: [PATCH 2/4] perf trace: Print content of bpf-output event

From: Arnaldo Carvalho de Melo
Date: Fri Apr 08 2016 - 13:25:20 EST


Em Fri, Apr 08, 2016 at 11:55:11PM +0800, Wangnan (F) escreveu:
> Sorry. This patch should be squash into patch 1/4. The commit message
> is wrong. The main part of described patch is already accepted and merged:
>
> 1d6c940 perf trace: Print content of bpf-output event

I'll check

> Thank you.
>
> On 2016/4/8 23:07, Wang Nan wrote:
> >With this patch the contend of BPF output event is printed by
> >'perf trace'. For example:
> >
> > # ./perf trace -a --ev bpf-output/no-inherit,name=evt/ \
> > --ev ./test_bpf_trace.c/map:channel.event=evt/ \
> > usleep 100000
> > ...
> > 1.787 ( 0.004 ms): usleep/3832 nanosleep(rqtp: 0x7ffc78b18980 ) ...
> > 1.787 ( ): evt:Raise a BPF event!..)
> > 1.788 ( ): perf_bpf_probe:func_begin:(ffffffff810e97d0))
> > ...
> > 101.866 (87.038 ms): gmain/1654 poll(ufds: 0x7f57a80008c0, nfds: 2, timeout_msecs: 1000 ) ...
> > 101.866 ( ): evt:Raise a BPF event!..)
> > 101.867 ( ): perf_bpf_probe:func_end:(ffffffff810e97d0 <- ffffffff81796173))
> > 101.869 (100.087 ms): usleep/3832 ... [continued]: nanosleep()) = 0
> > ...
> >
> > (There is an extra ')' at the end of several lines. However, it is
> > another problem, unrelated to this commit.)
> >
> >Where test_bpf_trace.c is:
> > /************************ BEGIN **************************/
> > #include <uapi/linux/bpf.h>
> > struct bpf_map_def {
> > unsigned int type;
> > unsigned int key_size;
> > unsigned int value_size;
> > unsigned int max_entries;
> > };
> > #define SEC(NAME) __attribute__((section(NAME), used))
> > static u64 (*ktime_get_ns)(void) =
> > (void *)BPF_FUNC_ktime_get_ns;
> > static int (*trace_printk)(const char *fmt, int fmt_size, ...) =
> > (void *)BPF_FUNC_trace_printk;
> > static int (*get_smp_processor_id)(void) =
> > (void *)BPF_FUNC_get_smp_processor_id;
> > static int (*perf_event_output)(void *, struct bpf_map_def *, int, void *, unsigned long) =
> > (void *)BPF_FUNC_perf_event_output;
> >
> > struct bpf_map_def SEC("maps") channel = {
> > .type = BPF_MAP_TYPE_PERF_EVENT_ARRAY,
> > .key_size = sizeof(int),
> > .value_size = sizeof(u32),
> > .max_entries = __NR_CPUS__,
> > };
> >
> > static inline int __attribute__((always_inline))
> > func(void *ctx, int type)
> > {
> > char output_str[] = "Raise a BPF event!";
> > char err_str[] = "BAD %d\n";
> > int err;
> >
> > err = perf_event_output(ctx, &channel, get_smp_processor_id(),
> > &output_str, sizeof(output_str));
> > if (err)
> > trace_printk(err_str, sizeof(err_str), err);
> > return 1;
> > }
> > SEC("func_begin=sys_nanosleep")
> > int func_begin(void *ctx) {return func(ctx, 1);}
> > SEC("func_end=sys_nanosleep%return")
> > int func_end(void *ctx) { return func(ctx, 2);}
> > char _license[] SEC("license") = "GPL";
> > int _version SEC("version") = LINUX_VERSION_CODE;
> > /************************* END ***************************/
> >
> >Signed-off-by: Wang Nan <wangnan0@xxxxxxxxxx>
> >Cc: Arnaldo Carvalho de Melo <acme@xxxxxxxxxx>
> >Cc: Jiri Olsa <jolsa@xxxxxxxxxx>
> >Cc: Li Zefan <lizefan@xxxxxxxxxx>
> >Cc: pi3orama@xxxxxxx
> >---
> > tools/perf/builtin-trace.c | 13 +++++++++----
> > 1 file changed, 9 insertions(+), 4 deletions(-)
> >
> >diff --git a/tools/perf/builtin-trace.c b/tools/perf/builtin-trace.c
> >index 6fbed86..fb8257f 100644
> >--- a/tools/perf/builtin-trace.c
> >+++ b/tools/perf/builtin-trace.c
> >@@ -2680,11 +2680,15 @@ out_enomem:
> > goto out;
> > }
> >-static int validate_evlist(struct perf_evlist *evlist)
> >+static int validate_evlist(struct perf_evlist *evlist, bool *has_bpf_output)
> > {
> > struct perf_evsel *evsel;
> > evlist__for_each(evlist, evsel) {
> >+ if (perf_evsel__is_bpf_output(evsel)) {
> >+ *has_bpf_output = true;
> >+ continue;
> >+ }
> > if (evsel->attr.type != PERF_TYPE_TRACEPOINT)
> > return -EINVAL;
> > }
> >@@ -3268,6 +3272,7 @@ int cmd_trace(int argc, const char **argv, const char *prefix __maybe_unused)
> > const char * const trace_subcommands[] = { "record", NULL };
> > int err;
> > char bf[BUFSIZ];
> >+ bool has_bpf_output = false;
> > signal(SIGSEGV, sighandler_dump_stack);
> > signal(SIGFPE, sighandler_dump_stack);
> >@@ -3284,12 +3289,12 @@ int cmd_trace(int argc, const char **argv, const char *prefix __maybe_unused)
> > argc = parse_options_subcommand(argc, argv, trace_options, trace_subcommands,
> > trace_usage, PARSE_OPT_STOP_AT_NON_OPTION);
> >- if (validate_evlist(trace.evlist)) {
> >- pr_err("Only support tracepoint events!\n");
> >+ if (validate_evlist(trace.evlist, &has_bpf_output)) {
> >+ pr_err("Only support tracepoint and bpf-output events!\n");
> > return -EINVAL;
> > }
> >- if (trace.trace_pgfaults) {
> >+ if (trace.trace_pgfaults || has_bpf_output) {
> > trace.opts.sample_address = true;
> > trace.opts.sample_time = true;
> > }
>