Loading...
1/*
2 * trace-event-perl. Feed perf script events to an embedded Perl interpreter.
3 *
4 * Copyright (C) 2009 Tom Zanussi <tzanussi@gmail.com>
5 *
6 * This program is free software; you can redistribute it and/or modify
7 * it under the terms of the GNU General Public License as published by
8 * the Free Software Foundation; either version 2 of the License, or
9 * (at your option) any later version.
10 *
11 * This program is distributed in the hope that it will be useful,
12 * but WITHOUT ANY WARRANTY; without even the implied warranty of
13 * MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
14 * GNU General Public License for more details.
15 *
16 * You should have received a copy of the GNU General Public License
17 * along with this program; if not, write to the Free Software
18 * Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA 02111-1307 USA
19 *
20 */
21
22#include <stdio.h>
23#include <stdlib.h>
24#include <string.h>
25#include <ctype.h>
26#include <errno.h>
27#include <linux/bitmap.h>
28#include <linux/time64.h>
29
30#include "../util.h"
31#include <EXTERN.h>
32#include <perl.h>
33
34#include "../../perf.h"
35#include "../callchain.h"
36#include "../machine.h"
37#include "../thread.h"
38#include "../event.h"
39#include "../trace-event.h"
40#include "../evsel.h"
41#include "../debug.h"
42
43void boot_Perf__Trace__Context(pTHX_ CV *cv);
44void boot_DynaLoader(pTHX_ CV *cv);
45typedef PerlInterpreter * INTERP;
46
47void xs_init(pTHX);
48
49void xs_init(pTHX)
50{
51 const char *file = __FILE__;
52 dXSUB_SYS;
53
54 newXS("Perf::Trace::Context::bootstrap", boot_Perf__Trace__Context,
55 file);
56 newXS("DynaLoader::boot_DynaLoader", boot_DynaLoader, file);
57}
58
59INTERP my_perl;
60
61#define TRACE_EVENT_TYPE_MAX \
62 ((1 << (sizeof(unsigned short) * 8)) - 1)
63
64static DECLARE_BITMAP(events_defined, TRACE_EVENT_TYPE_MAX);
65
66extern struct scripting_context *scripting_context;
67
68static char *cur_field_name;
69static int zero_flag_atom;
70
71static void define_symbolic_value(const char *ev_name,
72 const char *field_name,
73 const char *field_value,
74 const char *field_str)
75{
76 unsigned long long value;
77 dSP;
78
79 value = eval_flag(field_value);
80
81 ENTER;
82 SAVETMPS;
83 PUSHMARK(SP);
84
85 XPUSHs(sv_2mortal(newSVpv(ev_name, 0)));
86 XPUSHs(sv_2mortal(newSVpv(field_name, 0)));
87 XPUSHs(sv_2mortal(newSVuv(value)));
88 XPUSHs(sv_2mortal(newSVpv(field_str, 0)));
89
90 PUTBACK;
91 if (get_cv("main::define_symbolic_value", 0))
92 call_pv("main::define_symbolic_value", G_SCALAR);
93 SPAGAIN;
94 PUTBACK;
95 FREETMPS;
96 LEAVE;
97}
98
99static void define_symbolic_values(struct print_flag_sym *field,
100 const char *ev_name,
101 const char *field_name)
102{
103 define_symbolic_value(ev_name, field_name, field->value, field->str);
104 if (field->next)
105 define_symbolic_values(field->next, ev_name, field_name);
106}
107
108static void define_symbolic_field(const char *ev_name,
109 const char *field_name)
110{
111 dSP;
112
113 ENTER;
114 SAVETMPS;
115 PUSHMARK(SP);
116
117 XPUSHs(sv_2mortal(newSVpv(ev_name, 0)));
118 XPUSHs(sv_2mortal(newSVpv(field_name, 0)));
119
120 PUTBACK;
121 if (get_cv("main::define_symbolic_field", 0))
122 call_pv("main::define_symbolic_field", G_SCALAR);
123 SPAGAIN;
124 PUTBACK;
125 FREETMPS;
126 LEAVE;
127}
128
129static void define_flag_value(const char *ev_name,
130 const char *field_name,
131 const char *field_value,
132 const char *field_str)
133{
134 unsigned long long value;
135 dSP;
136
137 value = eval_flag(field_value);
138
139 ENTER;
140 SAVETMPS;
141 PUSHMARK(SP);
142
143 XPUSHs(sv_2mortal(newSVpv(ev_name, 0)));
144 XPUSHs(sv_2mortal(newSVpv(field_name, 0)));
145 XPUSHs(sv_2mortal(newSVuv(value)));
146 XPUSHs(sv_2mortal(newSVpv(field_str, 0)));
147
148 PUTBACK;
149 if (get_cv("main::define_flag_value", 0))
150 call_pv("main::define_flag_value", G_SCALAR);
151 SPAGAIN;
152 PUTBACK;
153 FREETMPS;
154 LEAVE;
155}
156
157static void define_flag_values(struct print_flag_sym *field,
158 const char *ev_name,
159 const char *field_name)
160{
161 define_flag_value(ev_name, field_name, field->value, field->str);
162 if (field->next)
163 define_flag_values(field->next, ev_name, field_name);
164}
165
166static void define_flag_field(const char *ev_name,
167 const char *field_name,
168 const char *delim)
169{
170 dSP;
171
172 ENTER;
173 SAVETMPS;
174 PUSHMARK(SP);
175
176 XPUSHs(sv_2mortal(newSVpv(ev_name, 0)));
177 XPUSHs(sv_2mortal(newSVpv(field_name, 0)));
178 XPUSHs(sv_2mortal(newSVpv(delim, 0)));
179
180 PUTBACK;
181 if (get_cv("main::define_flag_field", 0))
182 call_pv("main::define_flag_field", G_SCALAR);
183 SPAGAIN;
184 PUTBACK;
185 FREETMPS;
186 LEAVE;
187}
188
189static void define_event_symbols(struct event_format *event,
190 const char *ev_name,
191 struct print_arg *args)
192{
193 if (args == NULL)
194 return;
195
196 switch (args->type) {
197 case PRINT_NULL:
198 break;
199 case PRINT_ATOM:
200 define_flag_value(ev_name, cur_field_name, "0",
201 args->atom.atom);
202 zero_flag_atom = 0;
203 break;
204 case PRINT_FIELD:
205 free(cur_field_name);
206 cur_field_name = strdup(args->field.name);
207 break;
208 case PRINT_FLAGS:
209 define_event_symbols(event, ev_name, args->flags.field);
210 define_flag_field(ev_name, cur_field_name, args->flags.delim);
211 define_flag_values(args->flags.flags, ev_name, cur_field_name);
212 break;
213 case PRINT_SYMBOL:
214 define_event_symbols(event, ev_name, args->symbol.field);
215 define_symbolic_field(ev_name, cur_field_name);
216 define_symbolic_values(args->symbol.symbols, ev_name,
217 cur_field_name);
218 break;
219 case PRINT_HEX:
220 define_event_symbols(event, ev_name, args->hex.field);
221 define_event_symbols(event, ev_name, args->hex.size);
222 break;
223 case PRINT_INT_ARRAY:
224 define_event_symbols(event, ev_name, args->int_array.field);
225 define_event_symbols(event, ev_name, args->int_array.count);
226 define_event_symbols(event, ev_name, args->int_array.el_size);
227 break;
228 case PRINT_BSTRING:
229 case PRINT_DYNAMIC_ARRAY:
230 case PRINT_DYNAMIC_ARRAY_LEN:
231 case PRINT_STRING:
232 case PRINT_BITMASK:
233 break;
234 case PRINT_TYPE:
235 define_event_symbols(event, ev_name, args->typecast.item);
236 break;
237 case PRINT_OP:
238 if (strcmp(args->op.op, ":") == 0)
239 zero_flag_atom = 1;
240 define_event_symbols(event, ev_name, args->op.left);
241 define_event_symbols(event, ev_name, args->op.right);
242 break;
243 case PRINT_FUNC:
244 default:
245 pr_err("Unsupported print arg type\n");
246 /* we should warn... */
247 return;
248 }
249
250 if (args->next)
251 define_event_symbols(event, ev_name, args->next);
252}
253
254static SV *perl_process_callchain(struct perf_sample *sample,
255 struct perf_evsel *evsel,
256 struct addr_location *al)
257{
258 AV *list;
259
260 list = newAV();
261 if (!list)
262 goto exit;
263
264 if (!symbol_conf.use_callchain || !sample->callchain)
265 goto exit;
266
267 if (thread__resolve_callchain(al->thread, &callchain_cursor, evsel,
268 sample, NULL, NULL, scripting_max_stack) != 0) {
269 pr_err("Failed to resolve callchain. Skipping\n");
270 goto exit;
271 }
272 callchain_cursor_commit(&callchain_cursor);
273
274
275 while (1) {
276 HV *elem;
277 struct callchain_cursor_node *node;
278 node = callchain_cursor_current(&callchain_cursor);
279 if (!node)
280 break;
281
282 elem = newHV();
283 if (!elem)
284 goto exit;
285
286 if (!hv_stores(elem, "ip", newSVuv(node->ip))) {
287 hv_undef(elem);
288 goto exit;
289 }
290
291 if (node->sym) {
292 HV *sym = newHV();
293 if (!sym) {
294 hv_undef(elem);
295 goto exit;
296 }
297 if (!hv_stores(sym, "start", newSVuv(node->sym->start)) ||
298 !hv_stores(sym, "end", newSVuv(node->sym->end)) ||
299 !hv_stores(sym, "binding", newSVuv(node->sym->binding)) ||
300 !hv_stores(sym, "name", newSVpvn(node->sym->name,
301 node->sym->namelen)) ||
302 !hv_stores(elem, "sym", newRV_noinc((SV*)sym))) {
303 hv_undef(sym);
304 hv_undef(elem);
305 goto exit;
306 }
307 }
308
309 if (node->map) {
310 struct map *map = node->map;
311 const char *dsoname = "[unknown]";
312 if (map && map->dso && (map->dso->name || map->dso->long_name)) {
313 if (symbol_conf.show_kernel_path && map->dso->long_name)
314 dsoname = map->dso->long_name;
315 else if (map->dso->name)
316 dsoname = map->dso->name;
317 }
318 if (!hv_stores(elem, "dso", newSVpv(dsoname,0))) {
319 hv_undef(elem);
320 goto exit;
321 }
322 }
323
324 callchain_cursor_advance(&callchain_cursor);
325 av_push(list, newRV_noinc((SV*)elem));
326 }
327
328exit:
329 return newRV_noinc((SV*)list);
330}
331
332static void perl_process_tracepoint(struct perf_sample *sample,
333 struct perf_evsel *evsel,
334 struct addr_location *al)
335{
336 struct thread *thread = al->thread;
337 struct event_format *event = evsel->tp_format;
338 struct format_field *field;
339 static char handler[256];
340 unsigned long long val;
341 unsigned long s, ns;
342 int pid;
343 int cpu = sample->cpu;
344 void *data = sample->raw_data;
345 unsigned long long nsecs = sample->time;
346 const char *comm = thread__comm_str(thread);
347
348 dSP;
349
350 if (evsel->attr.type != PERF_TYPE_TRACEPOINT)
351 return;
352
353 if (!event)
354 die("ug! no event found for type %" PRIu64, (u64)evsel->attr.config);
355
356 pid = raw_field_value(event, "common_pid", data);
357
358 sprintf(handler, "%s::%s", event->system, event->name);
359
360 if (!test_and_set_bit(event->id, events_defined))
361 define_event_symbols(event, handler, event->print_fmt.args);
362
363 s = nsecs / NSEC_PER_SEC;
364 ns = nsecs - s * NSEC_PER_SEC;
365
366 scripting_context->event_data = data;
367 scripting_context->pevent = evsel->tp_format->pevent;
368
369 ENTER;
370 SAVETMPS;
371 PUSHMARK(SP);
372
373 XPUSHs(sv_2mortal(newSVpv(handler, 0)));
374 XPUSHs(sv_2mortal(newSViv(PTR2IV(scripting_context))));
375 XPUSHs(sv_2mortal(newSVuv(cpu)));
376 XPUSHs(sv_2mortal(newSVuv(s)));
377 XPUSHs(sv_2mortal(newSVuv(ns)));
378 XPUSHs(sv_2mortal(newSViv(pid)));
379 XPUSHs(sv_2mortal(newSVpv(comm, 0)));
380 XPUSHs(sv_2mortal(perl_process_callchain(sample, evsel, al)));
381
382 /* common fields other than pid can be accessed via xsub fns */
383
384 for (field = event->format.fields; field; field = field->next) {
385 if (field->flags & FIELD_IS_STRING) {
386 int offset;
387 if (field->flags & FIELD_IS_DYNAMIC) {
388 offset = *(int *)(data + field->offset);
389 offset &= 0xffff;
390 } else
391 offset = field->offset;
392 XPUSHs(sv_2mortal(newSVpv((char *)data + offset, 0)));
393 } else { /* FIELD_IS_NUMERIC */
394 val = read_size(event, data + field->offset,
395 field->size);
396 if (field->flags & FIELD_IS_SIGNED) {
397 XPUSHs(sv_2mortal(newSViv(val)));
398 } else {
399 XPUSHs(sv_2mortal(newSVuv(val)));
400 }
401 }
402 }
403
404 PUTBACK;
405
406 if (get_cv(handler, 0))
407 call_pv(handler, G_SCALAR);
408 else if (get_cv("main::trace_unhandled", 0)) {
409 XPUSHs(sv_2mortal(newSVpv(handler, 0)));
410 XPUSHs(sv_2mortal(newSViv(PTR2IV(scripting_context))));
411 XPUSHs(sv_2mortal(newSVuv(cpu)));
412 XPUSHs(sv_2mortal(newSVuv(nsecs)));
413 XPUSHs(sv_2mortal(newSViv(pid)));
414 XPUSHs(sv_2mortal(newSVpv(comm, 0)));
415 XPUSHs(sv_2mortal(perl_process_callchain(sample, evsel, al)));
416 call_pv("main::trace_unhandled", G_SCALAR);
417 }
418 SPAGAIN;
419 PUTBACK;
420 FREETMPS;
421 LEAVE;
422}
423
424static void perl_process_event_generic(union perf_event *event,
425 struct perf_sample *sample,
426 struct perf_evsel *evsel)
427{
428 dSP;
429
430 if (!get_cv("process_event", 0))
431 return;
432
433 ENTER;
434 SAVETMPS;
435 PUSHMARK(SP);
436 XPUSHs(sv_2mortal(newSVpvn((const char *)event, event->header.size)));
437 XPUSHs(sv_2mortal(newSVpvn((const char *)&evsel->attr, sizeof(evsel->attr))));
438 XPUSHs(sv_2mortal(newSVpvn((const char *)sample, sizeof(*sample))));
439 XPUSHs(sv_2mortal(newSVpvn((const char *)sample->raw_data, sample->raw_size)));
440 PUTBACK;
441 call_pv("process_event", G_SCALAR);
442 SPAGAIN;
443 PUTBACK;
444 FREETMPS;
445 LEAVE;
446}
447
448static void perl_process_event(union perf_event *event,
449 struct perf_sample *sample,
450 struct perf_evsel *evsel,
451 struct addr_location *al)
452{
453 perl_process_tracepoint(sample, evsel, al);
454 perl_process_event_generic(event, sample, evsel);
455}
456
457static void run_start_sub(void)
458{
459 dSP; /* access to Perl stack */
460 PUSHMARK(SP);
461
462 if (get_cv("main::trace_begin", 0))
463 call_pv("main::trace_begin", G_DISCARD | G_NOARGS);
464}
465
466/*
467 * Start trace script
468 */
469static int perl_start_script(const char *script, int argc, const char **argv)
470{
471 const char **command_line;
472 int i, err = 0;
473
474 command_line = malloc((argc + 2) * sizeof(const char *));
475 command_line[0] = "";
476 command_line[1] = script;
477 for (i = 2; i < argc + 2; i++)
478 command_line[i] = argv[i - 2];
479
480 my_perl = perl_alloc();
481 perl_construct(my_perl);
482
483 if (perl_parse(my_perl, xs_init, argc + 2, (char **)command_line,
484 (char **)NULL)) {
485 err = -1;
486 goto error;
487 }
488
489 if (perl_run(my_perl)) {
490 err = -1;
491 goto error;
492 }
493
494 if (SvTRUE(ERRSV)) {
495 err = -1;
496 goto error;
497 }
498
499 run_start_sub();
500
501 free(command_line);
502 return 0;
503error:
504 perl_free(my_perl);
505 free(command_line);
506
507 return err;
508}
509
510static int perl_flush_script(void)
511{
512 return 0;
513}
514
515/*
516 * Stop trace script
517 */
518static int perl_stop_script(void)
519{
520 dSP; /* access to Perl stack */
521 PUSHMARK(SP);
522
523 if (get_cv("main::trace_end", 0))
524 call_pv("main::trace_end", G_DISCARD | G_NOARGS);
525
526 perl_destruct(my_perl);
527 perl_free(my_perl);
528
529 return 0;
530}
531
532static int perl_generate_script(struct pevent *pevent, const char *outfile)
533{
534 struct event_format *event = NULL;
535 struct format_field *f;
536 char fname[PATH_MAX];
537 int not_first, count;
538 FILE *ofp;
539
540 sprintf(fname, "%s.pl", outfile);
541 ofp = fopen(fname, "w");
542 if (ofp == NULL) {
543 fprintf(stderr, "couldn't open %s\n", fname);
544 return -1;
545 }
546
547 fprintf(ofp, "# perf script event handlers, "
548 "generated by perf script -g perl\n");
549
550 fprintf(ofp, "# Licensed under the terms of the GNU GPL"
551 " License version 2\n\n");
552
553 fprintf(ofp, "# The common_* event handler fields are the most useful "
554 "fields common to\n");
555
556 fprintf(ofp, "# all events. They don't necessarily correspond to "
557 "the 'common_*' fields\n");
558
559 fprintf(ofp, "# in the format files. Those fields not available as "
560 "handler params can\n");
561
562 fprintf(ofp, "# be retrieved using Perl functions of the form "
563 "common_*($context).\n");
564
565 fprintf(ofp, "# See Context.pm for the list of available "
566 "functions.\n\n");
567
568 fprintf(ofp, "use lib \"$ENV{'PERF_EXEC_PATH'}/scripts/perl/"
569 "Perf-Trace-Util/lib\";\n");
570
571 fprintf(ofp, "use lib \"./Perf-Trace-Util/lib\";\n");
572 fprintf(ofp, "use Perf::Trace::Core;\n");
573 fprintf(ofp, "use Perf::Trace::Context;\n");
574 fprintf(ofp, "use Perf::Trace::Util;\n\n");
575
576 fprintf(ofp, "sub trace_begin\n{\n\t# optional\n}\n\n");
577 fprintf(ofp, "sub trace_end\n{\n\t# optional\n}\n");
578
579
580 fprintf(ofp, "\n\
581sub print_backtrace\n\
582{\n\
583 my $callchain = shift;\n\
584 for my $node (@$callchain)\n\
585 {\n\
586 if(exists $node->{sym})\n\
587 {\n\
588 printf( \"\\t[\\%%x] \\%%s\\n\", $node->{ip}, $node->{sym}{name});\n\
589 }\n\
590 else\n\
591 {\n\
592 printf( \"\\t[\\%%x]\\n\", $node{ip});\n\
593 }\n\
594 }\n\
595}\n\n\
596");
597
598
599 while ((event = trace_find_next_event(pevent, event))) {
600 fprintf(ofp, "sub %s::%s\n{\n", event->system, event->name);
601 fprintf(ofp, "\tmy (");
602
603 fprintf(ofp, "$event_name, ");
604 fprintf(ofp, "$context, ");
605 fprintf(ofp, "$common_cpu, ");
606 fprintf(ofp, "$common_secs, ");
607 fprintf(ofp, "$common_nsecs,\n");
608 fprintf(ofp, "\t $common_pid, ");
609 fprintf(ofp, "$common_comm, ");
610 fprintf(ofp, "$common_callchain,\n\t ");
611
612 not_first = 0;
613 count = 0;
614
615 for (f = event->format.fields; f; f = f->next) {
616 if (not_first++)
617 fprintf(ofp, ", ");
618 if (++count % 5 == 0)
619 fprintf(ofp, "\n\t ");
620
621 fprintf(ofp, "$%s", f->name);
622 }
623 fprintf(ofp, ") = @_;\n\n");
624
625 fprintf(ofp, "\tprint_header($event_name, $common_cpu, "
626 "$common_secs, $common_nsecs,\n\t "
627 "$common_pid, $common_comm, $common_callchain);\n\n");
628
629 fprintf(ofp, "\tprintf(\"");
630
631 not_first = 0;
632 count = 0;
633
634 for (f = event->format.fields; f; f = f->next) {
635 if (not_first++)
636 fprintf(ofp, ", ");
637 if (count && count % 4 == 0) {
638 fprintf(ofp, "\".\n\t \"");
639 }
640 count++;
641
642 fprintf(ofp, "%s=", f->name);
643 if (f->flags & FIELD_IS_STRING ||
644 f->flags & FIELD_IS_FLAG ||
645 f->flags & FIELD_IS_SYMBOLIC)
646 fprintf(ofp, "%%s");
647 else if (f->flags & FIELD_IS_SIGNED)
648 fprintf(ofp, "%%d");
649 else
650 fprintf(ofp, "%%u");
651 }
652
653 fprintf(ofp, "\\n\",\n\t ");
654
655 not_first = 0;
656 count = 0;
657
658 for (f = event->format.fields; f; f = f->next) {
659 if (not_first++)
660 fprintf(ofp, ", ");
661
662 if (++count % 5 == 0)
663 fprintf(ofp, "\n\t ");
664
665 if (f->flags & FIELD_IS_FLAG) {
666 if ((count - 1) % 5 != 0) {
667 fprintf(ofp, "\n\t ");
668 count = 4;
669 }
670 fprintf(ofp, "flag_str(\"");
671 fprintf(ofp, "%s::%s\", ", event->system,
672 event->name);
673 fprintf(ofp, "\"%s\", $%s)", f->name,
674 f->name);
675 } else if (f->flags & FIELD_IS_SYMBOLIC) {
676 if ((count - 1) % 5 != 0) {
677 fprintf(ofp, "\n\t ");
678 count = 4;
679 }
680 fprintf(ofp, "symbol_str(\"");
681 fprintf(ofp, "%s::%s\", ", event->system,
682 event->name);
683 fprintf(ofp, "\"%s\", $%s)", f->name,
684 f->name);
685 } else
686 fprintf(ofp, "$%s", f->name);
687 }
688
689 fprintf(ofp, ");\n\n");
690
691 fprintf(ofp, "\tprint_backtrace($common_callchain);\n");
692
693 fprintf(ofp, "}\n\n");
694 }
695
696 fprintf(ofp, "sub trace_unhandled\n{\n\tmy ($event_name, $context, "
697 "$common_cpu, $common_secs, $common_nsecs,\n\t "
698 "$common_pid, $common_comm, $common_callchain) = @_;\n\n");
699
700 fprintf(ofp, "\tprint_header($event_name, $common_cpu, "
701 "$common_secs, $common_nsecs,\n\t $common_pid, "
702 "$common_comm, $common_callchain);\n");
703 fprintf(ofp, "\tprint_backtrace($common_callchain);\n");
704 fprintf(ofp, "}\n\n");
705
706 fprintf(ofp, "sub print_header\n{\n"
707 "\tmy ($event_name, $cpu, $secs, $nsecs, $pid, $comm) = @_;\n\n"
708 "\tprintf(\"%%-20s %%5u %%05u.%%09u %%8u %%-20s \",\n\t "
709 "$event_name, $cpu, $secs, $nsecs, $pid, $comm);\n}\n");
710
711 fprintf(ofp,
712 "\n# Packed byte string args of process_event():\n"
713 "#\n"
714 "# $event:\tunion perf_event\tutil/event.h\n"
715 "# $attr:\tstruct perf_event_attr\tlinux/perf_event.h\n"
716 "# $sample:\tstruct perf_sample\tutil/event.h\n"
717 "# $raw_data:\tperf_sample->raw_data\tutil/event.h\n"
718 "\n"
719 "sub process_event\n"
720 "{\n"
721 "\tmy ($event, $attr, $sample, $raw_data) = @_;\n"
722 "\n"
723 "\tmy @event\t= unpack(\"LSS\", $event);\n"
724 "\tmy @attr\t= unpack(\"LLQQQQQLLQQ\", $attr);\n"
725 "\tmy @sample\t= unpack(\"QLLQQQQQLL\", $sample);\n"
726 "\tmy @raw_data\t= unpack(\"C*\", $raw_data);\n"
727 "\n"
728 "\tuse Data::Dumper;\n"
729 "\tprint Dumper \\@event, \\@attr, \\@sample, \\@raw_data;\n"
730 "}\n");
731
732 fclose(ofp);
733
734 fprintf(stderr, "generated Perl script: %s\n", fname);
735
736 return 0;
737}
738
739struct scripting_ops perl_scripting_ops = {
740 .name = "Perl",
741 .start_script = perl_start_script,
742 .flush_script = perl_flush_script,
743 .stop_script = perl_stop_script,
744 .process_event = perl_process_event,
745 .generate_script = perl_generate_script,
746};
1/*
2 * trace-event-perl. Feed perf script events to an embedded Perl interpreter.
3 *
4 * Copyright (C) 2009 Tom Zanussi <tzanussi@gmail.com>
5 *
6 * This program is free software; you can redistribute it and/or modify
7 * it under the terms of the GNU General Public License as published by
8 * the Free Software Foundation; either version 2 of the License, or
9 * (at your option) any later version.
10 *
11 * This program is distributed in the hope that it will be useful,
12 * but WITHOUT ANY WARRANTY; without even the implied warranty of
13 * MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
14 * GNU General Public License for more details.
15 *
16 * You should have received a copy of the GNU General Public License
17 * along with this program; if not, write to the Free Software
18 * Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA 02111-1307 USA
19 *
20 */
21
22#include <stdio.h>
23#include <stdlib.h>
24#include <string.h>
25#include <ctype.h>
26#include <errno.h>
27
28#include "../../perf.h"
29#include "../util.h"
30#include "../thread.h"
31#include "../event.h"
32#include "../trace-event.h"
33#include "../evsel.h"
34
35#include <EXTERN.h>
36#include <perl.h>
37
38void boot_Perf__Trace__Context(pTHX_ CV *cv);
39void boot_DynaLoader(pTHX_ CV *cv);
40typedef PerlInterpreter * INTERP;
41
42void xs_init(pTHX);
43
44void xs_init(pTHX)
45{
46 const char *file = __FILE__;
47 dXSUB_SYS;
48
49 newXS("Perf::Trace::Context::bootstrap", boot_Perf__Trace__Context,
50 file);
51 newXS("DynaLoader::boot_DynaLoader", boot_DynaLoader, file);
52}
53
54INTERP my_perl;
55
56#define FTRACE_MAX_EVENT \
57 ((1 << (sizeof(unsigned short) * 8)) - 1)
58
59struct event_format *events[FTRACE_MAX_EVENT];
60
61extern struct scripting_context *scripting_context;
62
63static char *cur_field_name;
64static int zero_flag_atom;
65
66static void define_symbolic_value(const char *ev_name,
67 const char *field_name,
68 const char *field_value,
69 const char *field_str)
70{
71 unsigned long long value;
72 dSP;
73
74 value = eval_flag(field_value);
75
76 ENTER;
77 SAVETMPS;
78 PUSHMARK(SP);
79
80 XPUSHs(sv_2mortal(newSVpv(ev_name, 0)));
81 XPUSHs(sv_2mortal(newSVpv(field_name, 0)));
82 XPUSHs(sv_2mortal(newSVuv(value)));
83 XPUSHs(sv_2mortal(newSVpv(field_str, 0)));
84
85 PUTBACK;
86 if (get_cv("main::define_symbolic_value", 0))
87 call_pv("main::define_symbolic_value", G_SCALAR);
88 SPAGAIN;
89 PUTBACK;
90 FREETMPS;
91 LEAVE;
92}
93
94static void define_symbolic_values(struct print_flag_sym *field,
95 const char *ev_name,
96 const char *field_name)
97{
98 define_symbolic_value(ev_name, field_name, field->value, field->str);
99 if (field->next)
100 define_symbolic_values(field->next, ev_name, field_name);
101}
102
103static void define_symbolic_field(const char *ev_name,
104 const char *field_name)
105{
106 dSP;
107
108 ENTER;
109 SAVETMPS;
110 PUSHMARK(SP);
111
112 XPUSHs(sv_2mortal(newSVpv(ev_name, 0)));
113 XPUSHs(sv_2mortal(newSVpv(field_name, 0)));
114
115 PUTBACK;
116 if (get_cv("main::define_symbolic_field", 0))
117 call_pv("main::define_symbolic_field", G_SCALAR);
118 SPAGAIN;
119 PUTBACK;
120 FREETMPS;
121 LEAVE;
122}
123
124static void define_flag_value(const char *ev_name,
125 const char *field_name,
126 const char *field_value,
127 const char *field_str)
128{
129 unsigned long long value;
130 dSP;
131
132 value = eval_flag(field_value);
133
134 ENTER;
135 SAVETMPS;
136 PUSHMARK(SP);
137
138 XPUSHs(sv_2mortal(newSVpv(ev_name, 0)));
139 XPUSHs(sv_2mortal(newSVpv(field_name, 0)));
140 XPUSHs(sv_2mortal(newSVuv(value)));
141 XPUSHs(sv_2mortal(newSVpv(field_str, 0)));
142
143 PUTBACK;
144 if (get_cv("main::define_flag_value", 0))
145 call_pv("main::define_flag_value", G_SCALAR);
146 SPAGAIN;
147 PUTBACK;
148 FREETMPS;
149 LEAVE;
150}
151
152static void define_flag_values(struct print_flag_sym *field,
153 const char *ev_name,
154 const char *field_name)
155{
156 define_flag_value(ev_name, field_name, field->value, field->str);
157 if (field->next)
158 define_flag_values(field->next, ev_name, field_name);
159}
160
161static void define_flag_field(const char *ev_name,
162 const char *field_name,
163 const char *delim)
164{
165 dSP;
166
167 ENTER;
168 SAVETMPS;
169 PUSHMARK(SP);
170
171 XPUSHs(sv_2mortal(newSVpv(ev_name, 0)));
172 XPUSHs(sv_2mortal(newSVpv(field_name, 0)));
173 XPUSHs(sv_2mortal(newSVpv(delim, 0)));
174
175 PUTBACK;
176 if (get_cv("main::define_flag_field", 0))
177 call_pv("main::define_flag_field", G_SCALAR);
178 SPAGAIN;
179 PUTBACK;
180 FREETMPS;
181 LEAVE;
182}
183
184static void define_event_symbols(struct event_format *event,
185 const char *ev_name,
186 struct print_arg *args)
187{
188 switch (args->type) {
189 case PRINT_NULL:
190 break;
191 case PRINT_ATOM:
192 define_flag_value(ev_name, cur_field_name, "0",
193 args->atom.atom);
194 zero_flag_atom = 0;
195 break;
196 case PRINT_FIELD:
197 if (cur_field_name)
198 free(cur_field_name);
199 cur_field_name = strdup(args->field.name);
200 break;
201 case PRINT_FLAGS:
202 define_event_symbols(event, ev_name, args->flags.field);
203 define_flag_field(ev_name, cur_field_name, args->flags.delim);
204 define_flag_values(args->flags.flags, ev_name, cur_field_name);
205 break;
206 case PRINT_SYMBOL:
207 define_event_symbols(event, ev_name, args->symbol.field);
208 define_symbolic_field(ev_name, cur_field_name);
209 define_symbolic_values(args->symbol.symbols, ev_name,
210 cur_field_name);
211 break;
212 case PRINT_BSTRING:
213 case PRINT_DYNAMIC_ARRAY:
214 case PRINT_STRING:
215 break;
216 case PRINT_TYPE:
217 define_event_symbols(event, ev_name, args->typecast.item);
218 break;
219 case PRINT_OP:
220 if (strcmp(args->op.op, ":") == 0)
221 zero_flag_atom = 1;
222 define_event_symbols(event, ev_name, args->op.left);
223 define_event_symbols(event, ev_name, args->op.right);
224 break;
225 case PRINT_FUNC:
226 default:
227 pr_err("Unsupported print arg type\n");
228 /* we should warn... */
229 return;
230 }
231
232 if (args->next)
233 define_event_symbols(event, ev_name, args->next);
234}
235
236static inline struct event_format *find_cache_event(int type)
237{
238 static char ev_name[256];
239 struct event_format *event;
240
241 if (events[type])
242 return events[type];
243
244 events[type] = event = trace_find_event(type);
245 if (!event)
246 return NULL;
247
248 sprintf(ev_name, "%s::%s", event->system, event->name);
249
250 define_event_symbols(event, ev_name, event->print_fmt.args);
251
252 return event;
253}
254
255static void perl_process_tracepoint(union perf_event *pevent __unused,
256 struct perf_sample *sample,
257 struct perf_evsel *evsel,
258 struct machine *machine __unused,
259 struct thread *thread)
260{
261 struct format_field *field;
262 static char handler[256];
263 unsigned long long val;
264 unsigned long s, ns;
265 struct event_format *event;
266 int type;
267 int pid;
268 int cpu = sample->cpu;
269 void *data = sample->raw_data;
270 unsigned long long nsecs = sample->time;
271 char *comm = thread->comm;
272
273 dSP;
274
275 if (evsel->attr.type != PERF_TYPE_TRACEPOINT)
276 return;
277
278 type = trace_parse_common_type(data);
279
280 event = find_cache_event(type);
281 if (!event)
282 die("ug! no event found for type %d", type);
283
284 pid = trace_parse_common_pid(data);
285
286 sprintf(handler, "%s::%s", event->system, event->name);
287
288 s = nsecs / NSECS_PER_SEC;
289 ns = nsecs - s * NSECS_PER_SEC;
290
291 scripting_context->event_data = data;
292
293 ENTER;
294 SAVETMPS;
295 PUSHMARK(SP);
296
297 XPUSHs(sv_2mortal(newSVpv(handler, 0)));
298 XPUSHs(sv_2mortal(newSViv(PTR2IV(scripting_context))));
299 XPUSHs(sv_2mortal(newSVuv(cpu)));
300 XPUSHs(sv_2mortal(newSVuv(s)));
301 XPUSHs(sv_2mortal(newSVuv(ns)));
302 XPUSHs(sv_2mortal(newSViv(pid)));
303 XPUSHs(sv_2mortal(newSVpv(comm, 0)));
304
305 /* common fields other than pid can be accessed via xsub fns */
306
307 for (field = event->format.fields; field; field = field->next) {
308 if (field->flags & FIELD_IS_STRING) {
309 int offset;
310 if (field->flags & FIELD_IS_DYNAMIC) {
311 offset = *(int *)(data + field->offset);
312 offset &= 0xffff;
313 } else
314 offset = field->offset;
315 XPUSHs(sv_2mortal(newSVpv((char *)data + offset, 0)));
316 } else { /* FIELD_IS_NUMERIC */
317 val = read_size(data + field->offset, field->size);
318 if (field->flags & FIELD_IS_SIGNED) {
319 XPUSHs(sv_2mortal(newSViv(val)));
320 } else {
321 XPUSHs(sv_2mortal(newSVuv(val)));
322 }
323 }
324 }
325
326 PUTBACK;
327
328 if (get_cv(handler, 0))
329 call_pv(handler, G_SCALAR);
330 else if (get_cv("main::trace_unhandled", 0)) {
331 XPUSHs(sv_2mortal(newSVpv(handler, 0)));
332 XPUSHs(sv_2mortal(newSViv(PTR2IV(scripting_context))));
333 XPUSHs(sv_2mortal(newSVuv(cpu)));
334 XPUSHs(sv_2mortal(newSVuv(nsecs)));
335 XPUSHs(sv_2mortal(newSViv(pid)));
336 XPUSHs(sv_2mortal(newSVpv(comm, 0)));
337 call_pv("main::trace_unhandled", G_SCALAR);
338 }
339 SPAGAIN;
340 PUTBACK;
341 FREETMPS;
342 LEAVE;
343}
344
345static void perl_process_event_generic(union perf_event *pevent __unused,
346 struct perf_sample *sample,
347 struct perf_evsel *evsel __unused,
348 struct machine *machine __unused,
349 struct thread *thread __unused)
350{
351 dSP;
352
353 if (!get_cv("process_event", 0))
354 return;
355
356 ENTER;
357 SAVETMPS;
358 PUSHMARK(SP);
359 XPUSHs(sv_2mortal(newSVpvn((const char *)pevent, pevent->header.size)));
360 XPUSHs(sv_2mortal(newSVpvn((const char *)&evsel->attr, sizeof(evsel->attr))));
361 XPUSHs(sv_2mortal(newSVpvn((const char *)sample, sizeof(*sample))));
362 XPUSHs(sv_2mortal(newSVpvn((const char *)sample->raw_data, sample->raw_size)));
363 PUTBACK;
364 call_pv("process_event", G_SCALAR);
365 SPAGAIN;
366 PUTBACK;
367 FREETMPS;
368 LEAVE;
369}
370
371static void perl_process_event(union perf_event *pevent,
372 struct perf_sample *sample,
373 struct perf_evsel *evsel,
374 struct machine *machine,
375 struct thread *thread)
376{
377 perl_process_tracepoint(pevent, sample, evsel, machine, thread);
378 perl_process_event_generic(pevent, sample, evsel, machine, thread);
379}
380
381static void run_start_sub(void)
382{
383 dSP; /* access to Perl stack */
384 PUSHMARK(SP);
385
386 if (get_cv("main::trace_begin", 0))
387 call_pv("main::trace_begin", G_DISCARD | G_NOARGS);
388}
389
390/*
391 * Start trace script
392 */
393static int perl_start_script(const char *script, int argc, const char **argv)
394{
395 const char **command_line;
396 int i, err = 0;
397
398 command_line = malloc((argc + 2) * sizeof(const char *));
399 command_line[0] = "";
400 command_line[1] = script;
401 for (i = 2; i < argc + 2; i++)
402 command_line[i] = argv[i - 2];
403
404 my_perl = perl_alloc();
405 perl_construct(my_perl);
406
407 if (perl_parse(my_perl, xs_init, argc + 2, (char **)command_line,
408 (char **)NULL)) {
409 err = -1;
410 goto error;
411 }
412
413 if (perl_run(my_perl)) {
414 err = -1;
415 goto error;
416 }
417
418 if (SvTRUE(ERRSV)) {
419 err = -1;
420 goto error;
421 }
422
423 run_start_sub();
424
425 free(command_line);
426 return 0;
427error:
428 perl_free(my_perl);
429 free(command_line);
430
431 return err;
432}
433
434/*
435 * Stop trace script
436 */
437static int perl_stop_script(void)
438{
439 dSP; /* access to Perl stack */
440 PUSHMARK(SP);
441
442 if (get_cv("main::trace_end", 0))
443 call_pv("main::trace_end", G_DISCARD | G_NOARGS);
444
445 perl_destruct(my_perl);
446 perl_free(my_perl);
447
448 return 0;
449}
450
451static int perl_generate_script(const char *outfile)
452{
453 struct event_format *event = NULL;
454 struct format_field *f;
455 char fname[PATH_MAX];
456 int not_first, count;
457 FILE *ofp;
458
459 sprintf(fname, "%s.pl", outfile);
460 ofp = fopen(fname, "w");
461 if (ofp == NULL) {
462 fprintf(stderr, "couldn't open %s\n", fname);
463 return -1;
464 }
465
466 fprintf(ofp, "# perf script event handlers, "
467 "generated by perf script -g perl\n");
468
469 fprintf(ofp, "# Licensed under the terms of the GNU GPL"
470 " License version 2\n\n");
471
472 fprintf(ofp, "# The common_* event handler fields are the most useful "
473 "fields common to\n");
474
475 fprintf(ofp, "# all events. They don't necessarily correspond to "
476 "the 'common_*' fields\n");
477
478 fprintf(ofp, "# in the format files. Those fields not available as "
479 "handler params can\n");
480
481 fprintf(ofp, "# be retrieved using Perl functions of the form "
482 "common_*($context).\n");
483
484 fprintf(ofp, "# See Context.pm for the list of available "
485 "functions.\n\n");
486
487 fprintf(ofp, "use lib \"$ENV{'PERF_EXEC_PATH'}/scripts/perl/"
488 "Perf-Trace-Util/lib\";\n");
489
490 fprintf(ofp, "use lib \"./Perf-Trace-Util/lib\";\n");
491 fprintf(ofp, "use Perf::Trace::Core;\n");
492 fprintf(ofp, "use Perf::Trace::Context;\n");
493 fprintf(ofp, "use Perf::Trace::Util;\n\n");
494
495 fprintf(ofp, "sub trace_begin\n{\n\t# optional\n}\n\n");
496 fprintf(ofp, "sub trace_end\n{\n\t# optional\n}\n\n");
497
498 while ((event = trace_find_next_event(event))) {
499 fprintf(ofp, "sub %s::%s\n{\n", event->system, event->name);
500 fprintf(ofp, "\tmy (");
501
502 fprintf(ofp, "$event_name, ");
503 fprintf(ofp, "$context, ");
504 fprintf(ofp, "$common_cpu, ");
505 fprintf(ofp, "$common_secs, ");
506 fprintf(ofp, "$common_nsecs,\n");
507 fprintf(ofp, "\t $common_pid, ");
508 fprintf(ofp, "$common_comm,\n\t ");
509
510 not_first = 0;
511 count = 0;
512
513 for (f = event->format.fields; f; f = f->next) {
514 if (not_first++)
515 fprintf(ofp, ", ");
516 if (++count % 5 == 0)
517 fprintf(ofp, "\n\t ");
518
519 fprintf(ofp, "$%s", f->name);
520 }
521 fprintf(ofp, ") = @_;\n\n");
522
523 fprintf(ofp, "\tprint_header($event_name, $common_cpu, "
524 "$common_secs, $common_nsecs,\n\t "
525 "$common_pid, $common_comm);\n\n");
526
527 fprintf(ofp, "\tprintf(\"");
528
529 not_first = 0;
530 count = 0;
531
532 for (f = event->format.fields; f; f = f->next) {
533 if (not_first++)
534 fprintf(ofp, ", ");
535 if (count && count % 4 == 0) {
536 fprintf(ofp, "\".\n\t \"");
537 }
538 count++;
539
540 fprintf(ofp, "%s=", f->name);
541 if (f->flags & FIELD_IS_STRING ||
542 f->flags & FIELD_IS_FLAG ||
543 f->flags & FIELD_IS_SYMBOLIC)
544 fprintf(ofp, "%%s");
545 else if (f->flags & FIELD_IS_SIGNED)
546 fprintf(ofp, "%%d");
547 else
548 fprintf(ofp, "%%u");
549 }
550
551 fprintf(ofp, "\\n\",\n\t ");
552
553 not_first = 0;
554 count = 0;
555
556 for (f = event->format.fields; f; f = f->next) {
557 if (not_first++)
558 fprintf(ofp, ", ");
559
560 if (++count % 5 == 0)
561 fprintf(ofp, "\n\t ");
562
563 if (f->flags & FIELD_IS_FLAG) {
564 if ((count - 1) % 5 != 0) {
565 fprintf(ofp, "\n\t ");
566 count = 4;
567 }
568 fprintf(ofp, "flag_str(\"");
569 fprintf(ofp, "%s::%s\", ", event->system,
570 event->name);
571 fprintf(ofp, "\"%s\", $%s)", f->name,
572 f->name);
573 } else if (f->flags & FIELD_IS_SYMBOLIC) {
574 if ((count - 1) % 5 != 0) {
575 fprintf(ofp, "\n\t ");
576 count = 4;
577 }
578 fprintf(ofp, "symbol_str(\"");
579 fprintf(ofp, "%s::%s\", ", event->system,
580 event->name);
581 fprintf(ofp, "\"%s\", $%s)", f->name,
582 f->name);
583 } else
584 fprintf(ofp, "$%s", f->name);
585 }
586
587 fprintf(ofp, ");\n");
588 fprintf(ofp, "}\n\n");
589 }
590
591 fprintf(ofp, "sub trace_unhandled\n{\n\tmy ($event_name, $context, "
592 "$common_cpu, $common_secs, $common_nsecs,\n\t "
593 "$common_pid, $common_comm) = @_;\n\n");
594
595 fprintf(ofp, "\tprint_header($event_name, $common_cpu, "
596 "$common_secs, $common_nsecs,\n\t $common_pid, "
597 "$common_comm);\n}\n\n");
598
599 fprintf(ofp, "sub print_header\n{\n"
600 "\tmy ($event_name, $cpu, $secs, $nsecs, $pid, $comm) = @_;\n\n"
601 "\tprintf(\"%%-20s %%5u %%05u.%%09u %%8u %%-20s \",\n\t "
602 "$event_name, $cpu, $secs, $nsecs, $pid, $comm);\n}\n");
603
604 fprintf(ofp,
605 "\n# Packed byte string args of process_event():\n"
606 "#\n"
607 "# $event:\tunion perf_event\tutil/event.h\n"
608 "# $attr:\tstruct perf_event_attr\tlinux/perf_event.h\n"
609 "# $sample:\tstruct perf_sample\tutil/event.h\n"
610 "# $raw_data:\tperf_sample->raw_data\tutil/event.h\n"
611 "\n"
612 "sub process_event\n"
613 "{\n"
614 "\tmy ($event, $attr, $sample, $raw_data) = @_;\n"
615 "\n"
616 "\tmy @event\t= unpack(\"LSS\", $event);\n"
617 "\tmy @attr\t= unpack(\"LLQQQQQLLQQ\", $attr);\n"
618 "\tmy @sample\t= unpack(\"QLLQQQQQLL\", $sample);\n"
619 "\tmy @raw_data\t= unpack(\"C*\", $raw_data);\n"
620 "\n"
621 "\tuse Data::Dumper;\n"
622 "\tprint Dumper \\@event, \\@attr, \\@sample, \\@raw_data;\n"
623 "}\n");
624
625 fclose(ofp);
626
627 fprintf(stderr, "generated Perl script: %s\n", fname);
628
629 return 0;
630}
631
632struct scripting_ops perl_scripting_ops = {
633 .name = "Perl",
634 .start_script = perl_start_script,
635 .stop_script = perl_stop_script,
636 .process_event = perl_process_event,
637 .generate_script = perl_generate_script,
638};