1 // SPDX-License-Identifier: GPL-2.0
5 * Copyright (C) 2008 Red Hat Inc, Steven Rostedt <srostedt@redhat.com>
8 #include <linux/module.h>
9 #include <linux/mutex.h>
10 #include <linux/ftrace.h>
11 #include <linux/kprobes.h>
12 #include <linux/sched/clock.h>
13 #include <linux/sched/mm.h>
14 #include <linux/idr.h>
16 #include "trace_output.h"
18 /* must be a power of 2 */
19 #define EVENT_HASHSIZE 128
21 DECLARE_RWSEM(trace_event_sem);
23 static struct hlist_head event_hash[EVENT_HASHSIZE] __read_mostly;
25 enum print_line_t trace_print_bputs_msg_only(struct trace_iterator *iter)
27 struct trace_seq *s = &iter->seq;
28 struct trace_entry *entry = iter->ent;
29 struct bputs_entry *field;
31 trace_assign_type(field, entry);
33 trace_seq_puts(s, field->str);
35 return trace_handle_return(s);
38 enum print_line_t trace_print_bprintk_msg_only(struct trace_iterator *iter)
40 struct trace_seq *s = &iter->seq;
41 struct trace_entry *entry = iter->ent;
42 struct bprint_entry *field;
44 trace_assign_type(field, entry);
46 trace_seq_bprintf(s, field->fmt, field->buf);
48 return trace_handle_return(s);
51 enum print_line_t trace_print_printk_msg_only(struct trace_iterator *iter)
53 struct trace_seq *s = &iter->seq;
54 struct trace_entry *entry = iter->ent;
55 struct print_entry *field;
57 trace_assign_type(field, entry);
59 trace_seq_puts(s, field->buf);
61 return trace_handle_return(s);
65 trace_print_flags_seq(struct trace_seq *p, const char *delim,
67 const struct trace_print_flags *flag_array)
71 const char *ret = trace_seq_buffer_ptr(p);
74 for (i = 0; flag_array[i].name && flags; i++) {
76 mask = flag_array[i].mask;
77 if ((flags & mask) != mask)
80 str = flag_array[i].name;
83 trace_seq_puts(p, delim);
86 trace_seq_puts(p, str);
89 /* check for left over flags */
92 trace_seq_puts(p, delim);
93 trace_seq_printf(p, "0x%lx", flags);
100 EXPORT_SYMBOL(trace_print_flags_seq);
103 trace_print_symbols_seq(struct trace_seq *p, unsigned long val,
104 const struct trace_print_flags *symbol_array)
107 const char *ret = trace_seq_buffer_ptr(p);
109 for (i = 0; symbol_array[i].name; i++) {
111 if (val != symbol_array[i].mask)
114 trace_seq_puts(p, symbol_array[i].name);
118 if (ret == (const char *)(trace_seq_buffer_ptr(p)))
119 trace_seq_printf(p, "0x%lx", val);
121 trace_seq_putc(p, 0);
125 EXPORT_SYMBOL(trace_print_symbols_seq);
127 #if BITS_PER_LONG == 32
129 trace_print_flags_seq_u64(struct trace_seq *p, const char *delim,
130 unsigned long long flags,
131 const struct trace_print_flags_u64 *flag_array)
133 unsigned long long mask;
135 const char *ret = trace_seq_buffer_ptr(p);
138 for (i = 0; flag_array[i].name && flags; i++) {
140 mask = flag_array[i].mask;
141 if ((flags & mask) != mask)
144 str = flag_array[i].name;
147 trace_seq_puts(p, delim);
150 trace_seq_puts(p, str);
153 /* check for left over flags */
156 trace_seq_puts(p, delim);
157 trace_seq_printf(p, "0x%llx", flags);
160 trace_seq_putc(p, 0);
164 EXPORT_SYMBOL(trace_print_flags_seq_u64);
167 trace_print_symbols_seq_u64(struct trace_seq *p, unsigned long long val,
168 const struct trace_print_flags_u64 *symbol_array)
171 const char *ret = trace_seq_buffer_ptr(p);
173 for (i = 0; symbol_array[i].name; i++) {
175 if (val != symbol_array[i].mask)
178 trace_seq_puts(p, symbol_array[i].name);
182 if (ret == (const char *)(trace_seq_buffer_ptr(p)))
183 trace_seq_printf(p, "0x%llx", val);
185 trace_seq_putc(p, 0);
189 EXPORT_SYMBOL(trace_print_symbols_seq_u64);
193 trace_print_bitmask_seq(struct trace_seq *p, void *bitmask_ptr,
194 unsigned int bitmask_size)
196 const char *ret = trace_seq_buffer_ptr(p);
198 trace_seq_bitmask(p, bitmask_ptr, bitmask_size * 8);
199 trace_seq_putc(p, 0);
203 EXPORT_SYMBOL_GPL(trace_print_bitmask_seq);
206 * trace_print_hex_seq - print buffer as hex sequence
207 * @p: trace seq struct to write to
208 * @buf: The buffer to print
209 * @buf_len: Length of @buf in bytes
210 * @concatenate: Print @buf as single hex string or with spacing
212 * Prints the passed buffer as a hex sequence either as a whole,
213 * single hex string if @concatenate is true or with spacing after
214 * each byte in case @concatenate is false.
217 trace_print_hex_seq(struct trace_seq *p, const unsigned char *buf, int buf_len,
221 const char *ret = trace_seq_buffer_ptr(p);
222 const char *fmt = concatenate ? "%*phN" : "%*ph";
224 for (i = 0; i < buf_len; i += 16) {
225 if (!concatenate && i != 0)
226 trace_seq_putc(p, ' ');
227 trace_seq_printf(p, fmt, min(buf_len - i, 16), &buf[i]);
229 trace_seq_putc(p, 0);
233 EXPORT_SYMBOL(trace_print_hex_seq);
236 trace_print_array_seq(struct trace_seq *p, const void *buf, int count,
239 const char *ret = trace_seq_buffer_ptr(p);
240 const char *prefix = "";
241 void *ptr = (void *)buf;
242 size_t buf_len = count * el_size;
244 trace_seq_putc(p, '{');
246 while (ptr < buf + buf_len) {
249 trace_seq_printf(p, "%s0x%x", prefix,
253 trace_seq_printf(p, "%s0x%x", prefix,
257 trace_seq_printf(p, "%s0x%x", prefix,
261 trace_seq_printf(p, "%s0x%llx", prefix,
265 trace_seq_printf(p, "BAD SIZE:%zu 0x%x", el_size,
273 trace_seq_putc(p, '}');
274 trace_seq_putc(p, 0);
278 EXPORT_SYMBOL(trace_print_array_seq);
281 trace_print_hex_dump_seq(struct trace_seq *p, const char *prefix_str,
282 int prefix_type, int rowsize, int groupsize,
283 const void *buf, size_t len, bool ascii)
285 const char *ret = trace_seq_buffer_ptr(p);
287 trace_seq_putc(p, '\n');
288 trace_seq_hex_dump(p, prefix_str, prefix_type,
289 rowsize, groupsize, buf, len, ascii);
290 trace_seq_putc(p, 0);
293 EXPORT_SYMBOL(trace_print_hex_dump_seq);
295 int trace_raw_output_prep(struct trace_iterator *iter,
296 struct trace_event *trace_event)
298 struct trace_event_call *event;
299 struct trace_seq *s = &iter->seq;
300 struct trace_seq *p = &iter->tmp_seq;
301 struct trace_entry *entry;
303 event = container_of(trace_event, struct trace_event_call, event);
306 if (entry->type != event->event.type) {
308 return TRACE_TYPE_UNHANDLED;
312 trace_seq_printf(s, "%s: ", trace_event_name(event));
314 return trace_handle_return(s);
316 EXPORT_SYMBOL(trace_raw_output_prep);
318 void trace_event_printf(struct trace_iterator *iter, const char *fmt, ...)
323 trace_check_vprintf(iter, trace_event_format(iter, fmt), ap);
326 EXPORT_SYMBOL(trace_event_printf);
328 static __printf(3, 0)
329 int trace_output_raw(struct trace_iterator *iter, char *name,
330 char *fmt, va_list ap)
332 struct trace_seq *s = &iter->seq;
334 trace_seq_printf(s, "%s: ", name);
335 trace_seq_vprintf(s, trace_event_format(iter, fmt), ap);
337 return trace_handle_return(s);
340 int trace_output_call(struct trace_iterator *iter, char *name, char *fmt, ...)
346 ret = trace_output_raw(iter, name, fmt, ap);
351 EXPORT_SYMBOL_GPL(trace_output_call);
353 static inline const char *kretprobed(const char *name, unsigned long addr)
355 if (is_kretprobe_trampoline(addr))
356 return "[unknown/kretprobe'd]";
361 trace_seq_print_sym(struct trace_seq *s, unsigned long address, bool offset)
363 #ifdef CONFIG_KALLSYMS
364 char str[KSYM_SYMBOL_LEN];
368 sprint_symbol(str, address);
370 kallsyms_lookup(address, NULL, NULL, NULL, str);
371 name = kretprobed(str, address);
373 if (name && strlen(name)) {
374 trace_seq_puts(s, name);
378 trace_seq_printf(s, "0x%08lx", address);
382 # define IP_FMT "%08lx"
384 # define IP_FMT "%016lx"
387 static int seq_print_user_ip(struct trace_seq *s, struct mm_struct *mm,
388 unsigned long ip, unsigned long sym_flags)
390 struct file *file = NULL;
391 unsigned long vmstart = 0;
398 const struct vm_area_struct *vma;
401 vma = find_vma(mm, ip);
404 vmstart = vma->vm_start;
407 ret = trace_seq_path(s, &file->f_path);
409 trace_seq_printf(s, "[+0x%lx]",
412 mmap_read_unlock(mm);
414 if (ret && ((sym_flags & TRACE_ITER_SYM_ADDR) || !file))
415 trace_seq_printf(s, " <" IP_FMT ">", ip);
416 return !trace_seq_has_overflowed(s);
420 seq_print_ip_sym(struct trace_seq *s, unsigned long ip, unsigned long sym_flags)
423 trace_seq_putc(s, '0');
427 trace_seq_print_sym(s, ip, sym_flags & TRACE_ITER_SYM_OFFSET);
429 if (sym_flags & TRACE_ITER_SYM_ADDR)
430 trace_seq_printf(s, " <" IP_FMT ">", ip);
433 return !trace_seq_has_overflowed(s);
437 * trace_print_lat_fmt - print the irq, preempt and lockdep fields
438 * @s: trace seq struct to write to
439 * @entry: The trace entry field from the ring buffer
441 * Prints the generic fields of irqs off, in hard or softirq, preempt
444 int trace_print_lat_fmt(struct trace_seq *s, struct trace_entry *entry)
454 nmi = entry->flags & TRACE_FLAG_NMI;
455 hardirq = entry->flags & TRACE_FLAG_HARDIRQ;
456 softirq = entry->flags & TRACE_FLAG_SOFTIRQ;
457 bh_off = entry->flags & TRACE_FLAG_BH_OFF;
460 (entry->flags & TRACE_FLAG_IRQS_OFF && bh_off) ? 'D' :
461 (entry->flags & TRACE_FLAG_IRQS_OFF) ? 'd' :
463 (entry->flags & TRACE_FLAG_IRQS_NOSUPPORT) ? 'X' :
466 switch (entry->flags & (TRACE_FLAG_NEED_RESCHED |
467 TRACE_FLAG_PREEMPT_RESCHED)) {
468 case TRACE_FLAG_NEED_RESCHED | TRACE_FLAG_PREEMPT_RESCHED:
471 case TRACE_FLAG_NEED_RESCHED:
474 case TRACE_FLAG_PREEMPT_RESCHED:
483 (nmi && hardirq) ? 'Z' :
485 (hardirq && softirq) ? 'H' :
490 trace_seq_printf(s, "%c%c%c",
491 irqs_off, need_resched, hardsoft_irq);
493 if (entry->preempt_count & 0xf)
494 trace_seq_printf(s, "%x", entry->preempt_count & 0xf);
496 trace_seq_putc(s, '.');
498 if (entry->preempt_count & 0xf0)
499 trace_seq_printf(s, "%x", entry->preempt_count >> 4);
501 trace_seq_putc(s, '.');
503 return !trace_seq_has_overflowed(s);
507 lat_print_generic(struct trace_seq *s, struct trace_entry *entry, int cpu)
509 char comm[TASK_COMM_LEN];
511 trace_find_cmdline(entry->pid, comm);
513 trace_seq_printf(s, "%8.8s-%-7d %3d",
514 comm, entry->pid, cpu);
516 return trace_print_lat_fmt(s, entry);
520 #define MARK(v, s) {.val = v, .sym = s}
521 /* trace overhead mark */
522 static const struct trace_mark {
523 unsigned long long val; /* unit: nsec */
526 MARK(1000000000ULL , '$'), /* 1 sec */
527 MARK(100000000ULL , '@'), /* 100 msec */
528 MARK(10000000ULL , '*'), /* 10 msec */
529 MARK(1000000ULL , '#'), /* 1000 usecs */
530 MARK(100000ULL , '!'), /* 100 usecs */
531 MARK(10000ULL , '+'), /* 10 usecs */
535 char trace_find_mark(unsigned long long d)
538 int size = ARRAY_SIZE(mark);
540 for (i = 0; i < size; i++) {
545 return (i == size) ? ' ' : mark[i].sym;
549 lat_print_timestamp(struct trace_iterator *iter, u64 next_ts)
551 struct trace_array *tr = iter->tr;
552 unsigned long verbose = tr->trace_flags & TRACE_ITER_VERBOSE;
553 unsigned long in_ns = iter->iter_flags & TRACE_FILE_TIME_IN_NS;
554 unsigned long long abs_ts = iter->ts - iter->array_buffer->time_start;
555 unsigned long long rel_ts = next_ts - iter->ts;
556 struct trace_seq *s = &iter->seq;
559 abs_ts = ns2usecs(abs_ts);
560 rel_ts = ns2usecs(rel_ts);
563 if (verbose && in_ns) {
564 unsigned long abs_usec = do_div(abs_ts, USEC_PER_MSEC);
565 unsigned long abs_msec = (unsigned long)abs_ts;
566 unsigned long rel_usec = do_div(rel_ts, USEC_PER_MSEC);
567 unsigned long rel_msec = (unsigned long)rel_ts;
570 s, "[%08llx] %ld.%03ldms (+%ld.%03ldms): ",
575 } else if (verbose && !in_ns) {
577 s, "[%016llx] %lld (+%lld): ",
578 iter->ts, abs_ts, rel_ts);
580 } else if (!verbose && in_ns) {
584 trace_find_mark(rel_ts * NSEC_PER_USEC));
586 } else { /* !verbose && !in_ns */
587 trace_seq_printf(s, " %4lld: ", abs_ts);
590 return !trace_seq_has_overflowed(s);
593 static void trace_print_time(struct trace_seq *s, struct trace_iterator *iter,
594 unsigned long long ts)
596 unsigned long secs, usec_rem;
597 unsigned long long t;
599 if (iter->iter_flags & TRACE_FILE_TIME_IN_NS) {
601 usec_rem = do_div(t, USEC_PER_SEC);
602 secs = (unsigned long)t;
603 trace_seq_printf(s, " %5lu.%06lu", secs, usec_rem);
605 trace_seq_printf(s, " %12llu", ts);
608 int trace_print_context(struct trace_iterator *iter)
610 struct trace_array *tr = iter->tr;
611 struct trace_seq *s = &iter->seq;
612 struct trace_entry *entry = iter->ent;
613 char comm[TASK_COMM_LEN];
615 trace_find_cmdline(entry->pid, comm);
617 trace_seq_printf(s, "%16s-%-7d ", comm, entry->pid);
619 if (tr->trace_flags & TRACE_ITER_RECORD_TGID) {
620 unsigned int tgid = trace_find_tgid(entry->pid);
623 trace_seq_printf(s, "(-------) ");
625 trace_seq_printf(s, "(%7d) ", tgid);
628 trace_seq_printf(s, "[%03d] ", iter->cpu);
630 if (tr->trace_flags & TRACE_ITER_IRQ_INFO)
631 trace_print_lat_fmt(s, entry);
633 trace_print_time(s, iter, iter->ts);
634 trace_seq_puts(s, ": ");
636 return !trace_seq_has_overflowed(s);
639 int trace_print_lat_context(struct trace_iterator *iter)
641 struct trace_entry *entry, *next_entry;
642 struct trace_array *tr = iter->tr;
643 struct trace_seq *s = &iter->seq;
644 unsigned long verbose = (tr->trace_flags & TRACE_ITER_VERBOSE);
647 next_entry = trace_find_next_entry(iter, NULL, &next_ts);
651 /* trace_find_next_entry() may change iter->ent */
655 char comm[TASK_COMM_LEN];
657 trace_find_cmdline(entry->pid, comm);
660 s, "%16s %7d %3d %d %08x %08lx ",
661 comm, entry->pid, iter->cpu, entry->flags,
662 entry->preempt_count & 0xf, iter->idx);
664 lat_print_generic(s, entry, iter->cpu);
667 lat_print_timestamp(iter, next_ts);
669 return !trace_seq_has_overflowed(s);
673 * ftrace_find_event - find a registered event
674 * @type: the type of event to look for
676 * Returns an event of type @type otherwise NULL
677 * Called with trace_event_read_lock() held.
679 struct trace_event *ftrace_find_event(int type)
681 struct trace_event *event;
684 key = type & (EVENT_HASHSIZE - 1);
686 hlist_for_each_entry(event, &event_hash[key], node) {
687 if (event->type == type)
694 static DEFINE_IDA(trace_event_ida);
696 static void free_trace_event_type(int type)
698 if (type >= __TRACE_LAST_TYPE)
699 ida_free(&trace_event_ida, type);
702 static int alloc_trace_event_type(void)
706 /* Skip static defined type numbers */
707 next = ida_alloc_range(&trace_event_ida, __TRACE_LAST_TYPE,
708 TRACE_EVENT_TYPE_MAX, GFP_KERNEL);
714 void trace_event_read_lock(void)
716 down_read(&trace_event_sem);
719 void trace_event_read_unlock(void)
721 up_read(&trace_event_sem);
725 * register_trace_event - register output for an event type
726 * @event: the event type to register
728 * Event types are stored in a hash and this hash is used to
729 * find a way to print an event. If the @event->type is set
730 * then it will use that type, otherwise it will assign a
733 * If you assign your own type, please make sure it is added
734 * to the trace_type enum in trace.h, to avoid collisions
735 * with the dynamic types.
737 * Returns the event type number or zero on error.
739 int register_trace_event(struct trace_event *event)
744 down_write(&trace_event_sem);
749 if (WARN_ON(!event->funcs))
753 event->type = alloc_trace_event_type();
756 } else if (WARN(event->type > __TRACE_LAST_TYPE,
757 "Need to add type to trace.h")) {
760 /* Is this event already used */
761 if (ftrace_find_event(event->type))
765 if (event->funcs->trace == NULL)
766 event->funcs->trace = trace_nop_print;
767 if (event->funcs->raw == NULL)
768 event->funcs->raw = trace_nop_print;
769 if (event->funcs->hex == NULL)
770 event->funcs->hex = trace_nop_print;
771 if (event->funcs->binary == NULL)
772 event->funcs->binary = trace_nop_print;
774 key = event->type & (EVENT_HASHSIZE - 1);
776 hlist_add_head(&event->node, &event_hash[key]);
780 up_write(&trace_event_sem);
784 EXPORT_SYMBOL_GPL(register_trace_event);
787 * Used by module code with the trace_event_sem held for write.
789 int __unregister_trace_event(struct trace_event *event)
791 hlist_del(&event->node);
792 free_trace_event_type(event->type);
797 * unregister_trace_event - remove a no longer used event
798 * @event: the event to remove
800 int unregister_trace_event(struct trace_event *event)
802 down_write(&trace_event_sem);
803 __unregister_trace_event(event);
804 up_write(&trace_event_sem);
808 EXPORT_SYMBOL_GPL(unregister_trace_event);
814 static void print_array(struct trace_iterator *iter, void *pos,
815 struct ftrace_event_field *field)
821 offset = *(int *)pos & 0xffff;
822 len = *(int *)pos >> 16;
825 offset += field->offset + sizeof(int);
827 if (offset + len > iter->ent_size) {
828 trace_seq_puts(&iter->seq, "<OVERFLOW>");
832 pos = (void *)iter->ent + offset;
834 for (i = 0; i < len; i++, pos++) {
836 trace_seq_putc(&iter->seq, ',');
837 trace_seq_printf(&iter->seq, "%02x", *(unsigned char *)pos);
841 static void print_fields(struct trace_iterator *iter, struct trace_event_call *call,
842 struct list_head *head)
844 struct ftrace_event_field *field;
850 list_for_each_entry(field, head, link) {
851 trace_seq_printf(&iter->seq, " %s=", field->name);
852 if (field->offset + field->size > iter->ent_size) {
853 trace_seq_puts(&iter->seq, "<OVERFLOW>");
856 pos = (void *)iter->ent + field->offset;
858 switch (field->filter_type) {
860 case FILTER_STATIC_STRING:
861 trace_seq_printf(&iter->seq, "%.*s", field->size, (char *)pos);
863 case FILTER_RDYN_STRING:
864 case FILTER_DYN_STRING:
865 offset = *(int *)pos & 0xffff;
866 len = *(int *)pos >> 16;
868 if (field->filter_type == FILTER_RDYN_STRING)
869 offset += field->offset + sizeof(int);
871 if (offset + len > iter->ent_size) {
872 trace_seq_puts(&iter->seq, "<OVERFLOW>");
875 pos = (void *)iter->ent + offset;
876 trace_seq_printf(&iter->seq, "%.*s", len, (char *)pos);
878 case FILTER_PTR_STRING:
880 trace_iter_expand_format(iter);
882 ret = strncpy_from_kernel_nofault(iter->fmt, pos,
885 trace_seq_printf(&iter->seq, "(0x%px)", pos);
887 trace_seq_printf(&iter->seq, "(0x%px:%s)",
890 case FILTER_TRACE_FN:
892 trace_seq_printf(&iter->seq, "%pS", pos);
896 switch (field->size) {
898 if (isprint(*(char *)pos)) {
899 trace_seq_printf(&iter->seq, "'%c'",
900 *(unsigned char *)pos);
902 trace_seq_printf(&iter->seq, "(%d)",
903 *(unsigned char *)pos);
906 trace_seq_printf(&iter->seq, "0x%x (%d)",
907 *(unsigned short *)pos,
908 *(unsigned short *)pos);
911 /* dynamic array info is 4 bytes */
912 if (strstr(field->type, "__data_loc")) {
913 print_array(iter, pos, NULL);
917 if (strstr(field->type, "__rel_loc")) {
918 print_array(iter, pos, field);
922 trace_seq_printf(&iter->seq, "0x%x (%d)",
923 *(unsigned int *)pos,
924 *(unsigned int *)pos);
927 trace_seq_printf(&iter->seq, "0x%llx (%lld)",
928 *(unsigned long long *)pos,
929 *(unsigned long long *)pos);
932 trace_seq_puts(&iter->seq, "<INVALID-SIZE>");
937 trace_seq_puts(&iter->seq, "<INVALID-TYPE>");
940 trace_seq_putc(&iter->seq, '\n');
943 enum print_line_t print_event_fields(struct trace_iterator *iter,
944 struct trace_event *event)
946 struct trace_event_call *call;
947 struct list_head *head;
949 /* ftrace defined events have separate call structures */
950 if (event->type <= __TRACE_LAST_TYPE) {
953 down_read(&trace_event_sem);
954 list_for_each_entry(call, &ftrace_events, list) {
955 if (call->event.type == event->type) {
959 /* No need to search all events */
960 if (call->event.type > __TRACE_LAST_TYPE)
963 up_read(&trace_event_sem);
965 trace_seq_printf(&iter->seq, "UNKNOWN TYPE %d\n", event->type);
969 call = container_of(event, struct trace_event_call, event);
971 head = trace_get_fields(call);
973 trace_seq_printf(&iter->seq, "%s:", trace_event_name(call));
975 if (head && !list_empty(head))
976 print_fields(iter, call, head);
978 trace_seq_puts(&iter->seq, "No fields found\n");
981 return trace_handle_return(&iter->seq);
984 enum print_line_t trace_nop_print(struct trace_iterator *iter, int flags,
985 struct trace_event *event)
987 trace_seq_printf(&iter->seq, "type: %d\n", iter->ent->type);
989 return trace_handle_return(&iter->seq);
992 static void print_fn_trace(struct trace_seq *s, unsigned long ip,
993 unsigned long parent_ip, int flags)
995 seq_print_ip_sym(s, ip, flags);
997 if ((flags & TRACE_ITER_PRINT_PARENT) && parent_ip) {
998 trace_seq_puts(s, " <-");
999 seq_print_ip_sym(s, parent_ip, flags);
1004 static enum print_line_t trace_fn_trace(struct trace_iterator *iter, int flags,
1005 struct trace_event *event)
1007 struct ftrace_entry *field;
1008 struct trace_seq *s = &iter->seq;
1010 trace_assign_type(field, iter->ent);
1012 print_fn_trace(s, field->ip, field->parent_ip, flags);
1013 trace_seq_putc(s, '\n');
1015 return trace_handle_return(s);
1018 static enum print_line_t trace_fn_raw(struct trace_iterator *iter, int flags,
1019 struct trace_event *event)
1021 struct ftrace_entry *field;
1023 trace_assign_type(field, iter->ent);
1025 trace_seq_printf(&iter->seq, "%lx %lx\n",
1029 return trace_handle_return(&iter->seq);
1032 static enum print_line_t trace_fn_hex(struct trace_iterator *iter, int flags,
1033 struct trace_event *event)
1035 struct ftrace_entry *field;
1036 struct trace_seq *s = &iter->seq;
1038 trace_assign_type(field, iter->ent);
1040 SEQ_PUT_HEX_FIELD(s, field->ip);
1041 SEQ_PUT_HEX_FIELD(s, field->parent_ip);
1043 return trace_handle_return(s);
1046 static enum print_line_t trace_fn_bin(struct trace_iterator *iter, int flags,
1047 struct trace_event *event)
1049 struct ftrace_entry *field;
1050 struct trace_seq *s = &iter->seq;
1052 trace_assign_type(field, iter->ent);
1054 SEQ_PUT_FIELD(s, field->ip);
1055 SEQ_PUT_FIELD(s, field->parent_ip);
1057 return trace_handle_return(s);
1060 static struct trace_event_functions trace_fn_funcs = {
1061 .trace = trace_fn_trace,
1062 .raw = trace_fn_raw,
1063 .hex = trace_fn_hex,
1064 .binary = trace_fn_bin,
1067 static struct trace_event trace_fn_event = {
1069 .funcs = &trace_fn_funcs,
1072 /* TRACE_CTX an TRACE_WAKE */
1073 static enum print_line_t trace_ctxwake_print(struct trace_iterator *iter,
1076 struct ctx_switch_entry *field;
1077 char comm[TASK_COMM_LEN];
1081 trace_assign_type(field, iter->ent);
1083 T = task_index_to_char(field->next_state);
1084 S = task_index_to_char(field->prev_state);
1085 trace_find_cmdline(field->next_pid, comm);
1086 trace_seq_printf(&iter->seq,
1087 " %7d:%3d:%c %s [%03d] %7d:%3d:%c %s\n",
1096 return trace_handle_return(&iter->seq);
1099 static enum print_line_t trace_ctx_print(struct trace_iterator *iter, int flags,
1100 struct trace_event *event)
1102 return trace_ctxwake_print(iter, "==>");
1105 static enum print_line_t trace_wake_print(struct trace_iterator *iter,
1106 int flags, struct trace_event *event)
1108 return trace_ctxwake_print(iter, " +");
1111 static int trace_ctxwake_raw(struct trace_iterator *iter, char S)
1113 struct ctx_switch_entry *field;
1116 trace_assign_type(field, iter->ent);
1119 S = task_index_to_char(field->prev_state);
1120 T = task_index_to_char(field->next_state);
1121 trace_seq_printf(&iter->seq, "%d %d %c %d %d %d %c\n",
1130 return trace_handle_return(&iter->seq);
1133 static enum print_line_t trace_ctx_raw(struct trace_iterator *iter, int flags,
1134 struct trace_event *event)
1136 return trace_ctxwake_raw(iter, 0);
1139 static enum print_line_t trace_wake_raw(struct trace_iterator *iter, int flags,
1140 struct trace_event *event)
1142 return trace_ctxwake_raw(iter, '+');
1146 static int trace_ctxwake_hex(struct trace_iterator *iter, char S)
1148 struct ctx_switch_entry *field;
1149 struct trace_seq *s = &iter->seq;
1152 trace_assign_type(field, iter->ent);
1155 S = task_index_to_char(field->prev_state);
1156 T = task_index_to_char(field->next_state);
1158 SEQ_PUT_HEX_FIELD(s, field->prev_pid);
1159 SEQ_PUT_HEX_FIELD(s, field->prev_prio);
1160 SEQ_PUT_HEX_FIELD(s, S);
1161 SEQ_PUT_HEX_FIELD(s, field->next_cpu);
1162 SEQ_PUT_HEX_FIELD(s, field->next_pid);
1163 SEQ_PUT_HEX_FIELD(s, field->next_prio);
1164 SEQ_PUT_HEX_FIELD(s, T);
1166 return trace_handle_return(s);
1169 static enum print_line_t trace_ctx_hex(struct trace_iterator *iter, int flags,
1170 struct trace_event *event)
1172 return trace_ctxwake_hex(iter, 0);
1175 static enum print_line_t trace_wake_hex(struct trace_iterator *iter, int flags,
1176 struct trace_event *event)
1178 return trace_ctxwake_hex(iter, '+');
1181 static enum print_line_t trace_ctxwake_bin(struct trace_iterator *iter,
1182 int flags, struct trace_event *event)
1184 struct ctx_switch_entry *field;
1185 struct trace_seq *s = &iter->seq;
1187 trace_assign_type(field, iter->ent);
1189 SEQ_PUT_FIELD(s, field->prev_pid);
1190 SEQ_PUT_FIELD(s, field->prev_prio);
1191 SEQ_PUT_FIELD(s, field->prev_state);
1192 SEQ_PUT_FIELD(s, field->next_cpu);
1193 SEQ_PUT_FIELD(s, field->next_pid);
1194 SEQ_PUT_FIELD(s, field->next_prio);
1195 SEQ_PUT_FIELD(s, field->next_state);
1197 return trace_handle_return(s);
1200 static struct trace_event_functions trace_ctx_funcs = {
1201 .trace = trace_ctx_print,
1202 .raw = trace_ctx_raw,
1203 .hex = trace_ctx_hex,
1204 .binary = trace_ctxwake_bin,
1207 static struct trace_event trace_ctx_event = {
1209 .funcs = &trace_ctx_funcs,
1212 static struct trace_event_functions trace_wake_funcs = {
1213 .trace = trace_wake_print,
1214 .raw = trace_wake_raw,
1215 .hex = trace_wake_hex,
1216 .binary = trace_ctxwake_bin,
1219 static struct trace_event trace_wake_event = {
1221 .funcs = &trace_wake_funcs,
1226 static enum print_line_t trace_stack_print(struct trace_iterator *iter,
1227 int flags, struct trace_event *event)
1229 struct stack_entry *field;
1230 struct trace_seq *s = &iter->seq;
1234 trace_assign_type(field, iter->ent);
1235 end = (unsigned long *)((long)iter->ent + iter->ent_size);
1237 trace_seq_puts(s, "<stack trace>\n");
1239 for (p = field->caller; p && p < end && *p != ULONG_MAX; p++) {
1241 if (trace_seq_has_overflowed(s))
1244 trace_seq_puts(s, " => ");
1245 seq_print_ip_sym(s, *p, flags);
1246 trace_seq_putc(s, '\n');
1249 return trace_handle_return(s);
1252 static struct trace_event_functions trace_stack_funcs = {
1253 .trace = trace_stack_print,
1256 static struct trace_event trace_stack_event = {
1257 .type = TRACE_STACK,
1258 .funcs = &trace_stack_funcs,
1261 /* TRACE_USER_STACK */
1262 static enum print_line_t trace_user_stack_print(struct trace_iterator *iter,
1263 int flags, struct trace_event *event)
1265 struct trace_array *tr = iter->tr;
1266 struct userstack_entry *field;
1267 struct trace_seq *s = &iter->seq;
1268 struct mm_struct *mm = NULL;
1271 trace_assign_type(field, iter->ent);
1273 trace_seq_puts(s, "<user stack trace>\n");
1275 if (tr->trace_flags & TRACE_ITER_SYM_USEROBJ) {
1276 struct task_struct *task;
1278 * we do the lookup on the thread group leader,
1279 * since individual threads might have already quit!
1282 task = find_task_by_vpid(field->tgid);
1284 mm = get_task_mm(task);
1288 for (i = 0; i < FTRACE_STACK_ENTRIES; i++) {
1289 unsigned long ip = field->caller[i];
1291 if (!ip || trace_seq_has_overflowed(s))
1294 trace_seq_puts(s, " => ");
1295 seq_print_user_ip(s, mm, ip, flags);
1296 trace_seq_putc(s, '\n');
1302 return trace_handle_return(s);
1305 static struct trace_event_functions trace_user_stack_funcs = {
1306 .trace = trace_user_stack_print,
1309 static struct trace_event trace_user_stack_event = {
1310 .type = TRACE_USER_STACK,
1311 .funcs = &trace_user_stack_funcs,
1315 static enum print_line_t
1316 trace_hwlat_print(struct trace_iterator *iter, int flags,
1317 struct trace_event *event)
1319 struct trace_entry *entry = iter->ent;
1320 struct trace_seq *s = &iter->seq;
1321 struct hwlat_entry *field;
1323 trace_assign_type(field, entry);
1325 trace_seq_printf(s, "#%-5u inner/outer(us): %4llu/%-5llu ts:%lld.%09ld count:%d",
1328 field->outer_duration,
1329 (long long)field->timestamp.tv_sec,
1330 field->timestamp.tv_nsec, field->count);
1332 if (field->nmi_count) {
1334 * The generic sched_clock() is not NMI safe, thus
1335 * we only record the count and not the time.
1337 if (!IS_ENABLED(CONFIG_GENERIC_SCHED_CLOCK))
1338 trace_seq_printf(s, " nmi-total:%llu",
1339 field->nmi_total_ts);
1340 trace_seq_printf(s, " nmi-count:%u",
1344 trace_seq_putc(s, '\n');
1346 return trace_handle_return(s);
1349 static enum print_line_t
1350 trace_hwlat_raw(struct trace_iterator *iter, int flags,
1351 struct trace_event *event)
1353 struct hwlat_entry *field;
1354 struct trace_seq *s = &iter->seq;
1356 trace_assign_type(field, iter->ent);
1358 trace_seq_printf(s, "%llu %lld %lld %09ld %u\n",
1360 field->outer_duration,
1361 (long long)field->timestamp.tv_sec,
1362 field->timestamp.tv_nsec,
1365 return trace_handle_return(s);
1368 static struct trace_event_functions trace_hwlat_funcs = {
1369 .trace = trace_hwlat_print,
1370 .raw = trace_hwlat_raw,
1373 static struct trace_event trace_hwlat_event = {
1374 .type = TRACE_HWLAT,
1375 .funcs = &trace_hwlat_funcs,
1379 static enum print_line_t
1380 trace_osnoise_print(struct trace_iterator *iter, int flags,
1381 struct trace_event *event)
1383 struct trace_entry *entry = iter->ent;
1384 struct trace_seq *s = &iter->seq;
1385 struct osnoise_entry *field;
1386 u64 ratio, ratio_dec;
1389 trace_assign_type(field, entry);
1392 * compute the available % of cpu time.
1394 net_runtime = field->runtime - field->noise;
1395 ratio = net_runtime * 10000000;
1396 do_div(ratio, field->runtime);
1397 ratio_dec = do_div(ratio, 100000);
1399 trace_seq_printf(s, "%llu %10llu %3llu.%05llu %7llu",
1405 trace_seq_printf(s, " %6u", field->hw_count);
1406 trace_seq_printf(s, " %6u", field->nmi_count);
1407 trace_seq_printf(s, " %6u", field->irq_count);
1408 trace_seq_printf(s, " %6u", field->softirq_count);
1409 trace_seq_printf(s, " %6u", field->thread_count);
1411 trace_seq_putc(s, '\n');
1413 return trace_handle_return(s);
1416 static enum print_line_t
1417 trace_osnoise_raw(struct trace_iterator *iter, int flags,
1418 struct trace_event *event)
1420 struct osnoise_entry *field;
1421 struct trace_seq *s = &iter->seq;
1423 trace_assign_type(field, iter->ent);
1425 trace_seq_printf(s, "%lld %llu %llu %u %u %u %u %u\n",
1432 field->softirq_count,
1433 field->thread_count);
1435 return trace_handle_return(s);
1438 static struct trace_event_functions trace_osnoise_funcs = {
1439 .trace = trace_osnoise_print,
1440 .raw = trace_osnoise_raw,
1443 static struct trace_event trace_osnoise_event = {
1444 .type = TRACE_OSNOISE,
1445 .funcs = &trace_osnoise_funcs,
1448 /* TRACE_TIMERLAT */
1449 static enum print_line_t
1450 trace_timerlat_print(struct trace_iterator *iter, int flags,
1451 struct trace_event *event)
1453 struct trace_entry *entry = iter->ent;
1454 struct trace_seq *s = &iter->seq;
1455 struct timerlat_entry *field;
1457 trace_assign_type(field, entry);
1459 trace_seq_printf(s, "#%-5u context %6s timer_latency %9llu ns\n",
1461 field->context ? "thread" : "irq",
1462 field->timer_latency);
1464 return trace_handle_return(s);
1467 static enum print_line_t
1468 trace_timerlat_raw(struct trace_iterator *iter, int flags,
1469 struct trace_event *event)
1471 struct timerlat_entry *field;
1472 struct trace_seq *s = &iter->seq;
1474 trace_assign_type(field, iter->ent);
1476 trace_seq_printf(s, "%u %d %llu\n",
1479 field->timer_latency);
1481 return trace_handle_return(s);
1484 static struct trace_event_functions trace_timerlat_funcs = {
1485 .trace = trace_timerlat_print,
1486 .raw = trace_timerlat_raw,
1489 static struct trace_event trace_timerlat_event = {
1490 .type = TRACE_TIMERLAT,
1491 .funcs = &trace_timerlat_funcs,
1495 static enum print_line_t
1496 trace_bputs_print(struct trace_iterator *iter, int flags,
1497 struct trace_event *event)
1499 struct trace_entry *entry = iter->ent;
1500 struct trace_seq *s = &iter->seq;
1501 struct bputs_entry *field;
1503 trace_assign_type(field, entry);
1505 seq_print_ip_sym(s, field->ip, flags);
1506 trace_seq_puts(s, ": ");
1507 trace_seq_puts(s, field->str);
1509 return trace_handle_return(s);
1513 static enum print_line_t
1514 trace_bputs_raw(struct trace_iterator *iter, int flags,
1515 struct trace_event *event)
1517 struct bputs_entry *field;
1518 struct trace_seq *s = &iter->seq;
1520 trace_assign_type(field, iter->ent);
1522 trace_seq_printf(s, ": %lx : ", field->ip);
1523 trace_seq_puts(s, field->str);
1525 return trace_handle_return(s);
1528 static struct trace_event_functions trace_bputs_funcs = {
1529 .trace = trace_bputs_print,
1530 .raw = trace_bputs_raw,
1533 static struct trace_event trace_bputs_event = {
1534 .type = TRACE_BPUTS,
1535 .funcs = &trace_bputs_funcs,
1539 static enum print_line_t
1540 trace_bprint_print(struct trace_iterator *iter, int flags,
1541 struct trace_event *event)
1543 struct trace_entry *entry = iter->ent;
1544 struct trace_seq *s = &iter->seq;
1545 struct bprint_entry *field;
1547 trace_assign_type(field, entry);
1549 seq_print_ip_sym(s, field->ip, flags);
1550 trace_seq_puts(s, ": ");
1551 trace_seq_bprintf(s, field->fmt, field->buf);
1553 return trace_handle_return(s);
1557 static enum print_line_t
1558 trace_bprint_raw(struct trace_iterator *iter, int flags,
1559 struct trace_event *event)
1561 struct bprint_entry *field;
1562 struct trace_seq *s = &iter->seq;
1564 trace_assign_type(field, iter->ent);
1566 trace_seq_printf(s, ": %lx : ", field->ip);
1567 trace_seq_bprintf(s, field->fmt, field->buf);
1569 return trace_handle_return(s);
1572 static struct trace_event_functions trace_bprint_funcs = {
1573 .trace = trace_bprint_print,
1574 .raw = trace_bprint_raw,
1577 static struct trace_event trace_bprint_event = {
1578 .type = TRACE_BPRINT,
1579 .funcs = &trace_bprint_funcs,
1583 static enum print_line_t trace_print_print(struct trace_iterator *iter,
1584 int flags, struct trace_event *event)
1586 struct print_entry *field;
1587 struct trace_seq *s = &iter->seq;
1589 trace_assign_type(field, iter->ent);
1591 seq_print_ip_sym(s, field->ip, flags);
1592 trace_seq_printf(s, ": %s", field->buf);
1594 return trace_handle_return(s);
1597 static enum print_line_t trace_print_raw(struct trace_iterator *iter, int flags,
1598 struct trace_event *event)
1600 struct print_entry *field;
1602 trace_assign_type(field, iter->ent);
1604 trace_seq_printf(&iter->seq, "# %lx %s", field->ip, field->buf);
1606 return trace_handle_return(&iter->seq);
1609 static struct trace_event_functions trace_print_funcs = {
1610 .trace = trace_print_print,
1611 .raw = trace_print_raw,
1614 static struct trace_event trace_print_event = {
1615 .type = TRACE_PRINT,
1616 .funcs = &trace_print_funcs,
1619 static enum print_line_t trace_raw_data(struct trace_iterator *iter, int flags,
1620 struct trace_event *event)
1622 struct raw_data_entry *field;
1625 trace_assign_type(field, iter->ent);
1627 trace_seq_printf(&iter->seq, "# %x buf:", field->id);
1629 for (i = 0; i < iter->ent_size - offsetof(struct raw_data_entry, buf); i++)
1630 trace_seq_printf(&iter->seq, " %02x",
1631 (unsigned char)field->buf[i]);
1633 trace_seq_putc(&iter->seq, '\n');
1635 return trace_handle_return(&iter->seq);
1638 static struct trace_event_functions trace_raw_data_funcs = {
1639 .trace = trace_raw_data,
1640 .raw = trace_raw_data,
1643 static struct trace_event trace_raw_data_event = {
1644 .type = TRACE_RAW_DATA,
1645 .funcs = &trace_raw_data_funcs,
1648 static enum print_line_t
1649 trace_func_repeats_raw(struct trace_iterator *iter, int flags,
1650 struct trace_event *event)
1652 struct func_repeats_entry *field;
1653 struct trace_seq *s = &iter->seq;
1655 trace_assign_type(field, iter->ent);
1657 trace_seq_printf(s, "%lu %lu %u %llu\n",
1661 FUNC_REPEATS_GET_DELTA_TS(field));
1663 return trace_handle_return(s);
1666 static enum print_line_t
1667 trace_func_repeats_print(struct trace_iterator *iter, int flags,
1668 struct trace_event *event)
1670 struct func_repeats_entry *field;
1671 struct trace_seq *s = &iter->seq;
1673 trace_assign_type(field, iter->ent);
1675 print_fn_trace(s, field->ip, field->parent_ip, flags);
1676 trace_seq_printf(s, " (repeats: %u, last_ts:", field->count);
1677 trace_print_time(s, iter,
1678 iter->ts - FUNC_REPEATS_GET_DELTA_TS(field));
1679 trace_seq_puts(s, ")\n");
1681 return trace_handle_return(s);
1684 static struct trace_event_functions trace_func_repeats_funcs = {
1685 .trace = trace_func_repeats_print,
1686 .raw = trace_func_repeats_raw,
1689 static struct trace_event trace_func_repeats_event = {
1690 .type = TRACE_FUNC_REPEATS,
1691 .funcs = &trace_func_repeats_funcs,
1694 static struct trace_event *events[] __initdata = {
1699 &trace_user_stack_event,
1701 &trace_bprint_event,
1704 &trace_osnoise_event,
1705 &trace_timerlat_event,
1706 &trace_raw_data_event,
1707 &trace_func_repeats_event,
1711 __init int init_events(void)
1713 struct trace_event *event;
1716 for (i = 0; events[i]; i++) {
1718 ret = register_trace_event(event);
1719 WARN_ONCE(!ret, "event %d failed to register", event->type);