Linux Audio

Check our new training course

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