Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 1 | /* |
| 2 | * ring buffer based initcalls tracer |
| 3 | * |
| 4 | * Copyright (C) 2008 Frederic Weisbecker <fweisbec@gmail.com> |
| 5 | * |
| 6 | */ |
| 7 | |
| 8 | #include <linux/init.h> |
| 9 | #include <linux/debugfs.h> |
| 10 | #include <linux/ftrace.h> |
Frederic Weisbecker | 5601020 | 2008-10-02 13:26:05 +0200 | [diff] [blame] | 11 | #include <linux/kallsyms.h> |
Li Zefan | a5dec55 | 2009-03-27 14:55:44 +0800 | [diff] [blame] | 12 | #include <linux/time.h> |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 13 | |
| 14 | #include "trace.h" |
Steven Rostedt | f0868d1 | 2008-12-23 23:24:12 -0500 | [diff] [blame] | 15 | #include "trace_output.h" |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 16 | |
| 17 | static struct trace_array *boot_trace; |
Frederic Weisbecker | 71566a0 | 2008-10-31 12:57:20 +0100 | [diff] [blame] | 18 | static bool pre_initcalls_finished; |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 19 | |
Frederic Weisbecker | 71566a0 | 2008-10-31 12:57:20 +0100 | [diff] [blame] | 20 | /* Tells the boot tracer that the pre_smp_initcalls are finished. |
| 21 | * So we are ready . |
| 22 | * It doesn't enable sched events tracing however. |
| 23 | * You have to call enable_boot_trace to do so. |
| 24 | */ |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 25 | void start_boot_trace(void) |
| 26 | { |
Frederic Weisbecker | 71566a0 | 2008-10-31 12:57:20 +0100 | [diff] [blame] | 27 | pre_initcalls_finished = true; |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 28 | } |
| 29 | |
Frederic Weisbecker | 71566a0 | 2008-10-31 12:57:20 +0100 | [diff] [blame] | 30 | void enable_boot_trace(void) |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 31 | { |
Steven Rostedt | 79fb076 | 2009-02-02 21:38:33 -0500 | [diff] [blame] | 32 | if (boot_trace && pre_initcalls_finished) |
Steven Rostedt | e168e05 | 2008-11-07 22:36:02 -0500 | [diff] [blame] | 33 | tracing_start_sched_switch_record(); |
Frederic Weisbecker | 71566a0 | 2008-10-31 12:57:20 +0100 | [diff] [blame] | 34 | } |
| 35 | |
| 36 | void disable_boot_trace(void) |
| 37 | { |
Steven Rostedt | 79fb076 | 2009-02-02 21:38:33 -0500 | [diff] [blame] | 38 | if (boot_trace && pre_initcalls_finished) |
Steven Rostedt | e168e05 | 2008-11-07 22:36:02 -0500 | [diff] [blame] | 39 | tracing_stop_sched_switch_record(); |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 40 | } |
| 41 | |
Frederic Weisbecker | 1c80025 | 2008-11-16 05:57:26 +0100 | [diff] [blame] | 42 | static int boot_trace_init(struct trace_array *tr) |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 43 | { |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 44 | boot_trace = tr; |
| 45 | |
Steven Rostedt | 79fb076 | 2009-02-02 21:38:33 -0500 | [diff] [blame] | 46 | if (!tr) |
| 47 | return 0; |
| 48 | |
Steven Rostedt | 76f0d07 | 2009-09-04 12:12:39 -0400 | [diff] [blame] | 49 | tracing_reset_online_cpus(tr); |
Frederic Weisbecker | d7ad44b | 2008-10-31 13:20:08 +0100 | [diff] [blame] | 50 | |
Steven Rostedt | e168e05 | 2008-11-07 22:36:02 -0500 | [diff] [blame] | 51 | tracing_sched_switch_assign_trace(tr); |
Frederic Weisbecker | 1c80025 | 2008-11-16 05:57:26 +0100 | [diff] [blame] | 52 | return 0; |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 53 | } |
| 54 | |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 55 | static enum print_line_t |
| 56 | initcall_call_print_line(struct trace_iterator *iter) |
| 57 | { |
| 58 | struct trace_entry *entry = iter->ent; |
| 59 | struct trace_seq *s = &iter->seq; |
| 60 | struct trace_boot_call *field; |
| 61 | struct boot_trace_call *call; |
| 62 | u64 ts; |
| 63 | unsigned long nsec_rem; |
| 64 | int ret; |
| 65 | |
| 66 | trace_assign_type(field, entry); |
| 67 | call = &field->boot_call; |
| 68 | ts = iter->ts; |
Li Zefan | a5dec55 | 2009-03-27 14:55:44 +0800 | [diff] [blame] | 69 | nsec_rem = do_div(ts, NSEC_PER_SEC); |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 70 | |
| 71 | ret = trace_seq_printf(s, "[%5ld.%09ld] calling %s @ %i\n", |
| 72 | (unsigned long)ts, nsec_rem, call->func, call->caller); |
| 73 | |
| 74 | if (!ret) |
| 75 | return TRACE_TYPE_PARTIAL_LINE; |
| 76 | else |
| 77 | return TRACE_TYPE_HANDLED; |
| 78 | } |
| 79 | |
| 80 | static enum print_line_t |
| 81 | initcall_ret_print_line(struct trace_iterator *iter) |
| 82 | { |
| 83 | struct trace_entry *entry = iter->ent; |
| 84 | struct trace_seq *s = &iter->seq; |
| 85 | struct trace_boot_ret *field; |
| 86 | struct boot_trace_ret *init_ret; |
| 87 | u64 ts; |
| 88 | unsigned long nsec_rem; |
| 89 | int ret; |
| 90 | |
| 91 | trace_assign_type(field, entry); |
| 92 | init_ret = &field->boot_ret; |
| 93 | ts = iter->ts; |
Li Zefan | a5dec55 | 2009-03-27 14:55:44 +0800 | [diff] [blame] | 94 | nsec_rem = do_div(ts, NSEC_PER_SEC); |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 95 | |
| 96 | ret = trace_seq_printf(s, "[%5ld.%09ld] initcall %s " |
| 97 | "returned %d after %llu msecs\n", |
| 98 | (unsigned long) ts, |
| 99 | nsec_rem, |
| 100 | init_ret->func, init_ret->result, init_ret->duration); |
| 101 | |
| 102 | if (!ret) |
| 103 | return TRACE_TYPE_PARTIAL_LINE; |
| 104 | else |
| 105 | return TRACE_TYPE_HANDLED; |
| 106 | } |
| 107 | |
Frederic Weisbecker | 9e9efff | 2008-09-29 20:31:58 +0200 | [diff] [blame] | 108 | static enum print_line_t initcall_print_line(struct trace_iterator *iter) |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 109 | { |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 110 | struct trace_entry *entry = iter->ent; |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 111 | |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 112 | switch (entry->type) { |
| 113 | case TRACE_BOOT_CALL: |
| 114 | return initcall_call_print_line(iter); |
| 115 | case TRACE_BOOT_RET: |
| 116 | return initcall_ret_print_line(iter); |
| 117 | default: |
| 118 | return TRACE_TYPE_UNHANDLED; |
Frederic Weisbecker | 9e9efff | 2008-09-29 20:31:58 +0200 | [diff] [blame] | 119 | } |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 120 | } |
| 121 | |
| 122 | struct tracer boot_tracer __read_mostly = |
| 123 | { |
| 124 | .name = "initcall", |
| 125 | .init = boot_trace_init, |
Pekka J Enberg | 213cc06 | 2008-12-19 12:08:39 +0200 | [diff] [blame] | 126 | .reset = tracing_reset_online_cpus, |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 127 | .print_line = initcall_print_line, |
| 128 | }; |
| 129 | |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 130 | void trace_boot_call(struct boot_trace_call *bt, initcall_t fn) |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 131 | { |
Steven Rostedt | 60ba770 | 2009-09-12 23:34:04 -0400 | [diff] [blame] | 132 | struct ftrace_event_call *call = &event_boot_call; |
Steven Rostedt | 3928a8a | 2008-09-29 23:02:41 -0400 | [diff] [blame] | 133 | struct ring_buffer_event *event; |
Steven Rostedt | e77405a | 2009-09-02 14:17:06 -0400 | [diff] [blame] | 134 | struct ring_buffer *buffer; |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 135 | struct trace_boot_call *entry; |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 136 | struct trace_array *tr = boot_trace; |
| 137 | |
Steven Rostedt | 79fb076 | 2009-02-02 21:38:33 -0500 | [diff] [blame] | 138 | if (!tr || !pre_initcalls_finished) |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 139 | return; |
| 140 | |
Frederic Weisbecker | 5601020 | 2008-10-02 13:26:05 +0200 | [diff] [blame] | 141 | /* Get its name now since this function could |
| 142 | * disappear because it is in the .init section. |
| 143 | */ |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 144 | sprint_symbol(bt->func, (unsigned long)fn); |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 145 | preempt_disable(); |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 146 | |
Steven Rostedt | e77405a | 2009-09-02 14:17:06 -0400 | [diff] [blame] | 147 | buffer = tr->buffer; |
| 148 | event = trace_buffer_lock_reserve(buffer, TRACE_BOOT_CALL, |
Arnaldo Carvalho de Melo | 51a763d | 2009-02-05 16:14:13 -0200 | [diff] [blame] | 149 | sizeof(*entry), 0, 0); |
Steven Rostedt | 3928a8a | 2008-09-29 23:02:41 -0400 | [diff] [blame] | 150 | if (!event) |
| 151 | goto out; |
| 152 | entry = ring_buffer_event_data(event); |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 153 | entry->boot_call = *bt; |
Steven Rostedt | 60ba770 | 2009-09-12 23:34:04 -0400 | [diff] [blame] | 154 | if (!filter_check_discard(call, entry, buffer, event)) |
| 155 | trace_buffer_unlock_commit(buffer, event, 0, 0); |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 156 | out: |
| 157 | preempt_enable(); |
| 158 | } |
| 159 | |
| 160 | void trace_boot_ret(struct boot_trace_ret *bt, initcall_t fn) |
| 161 | { |
Steven Rostedt | 60ba770 | 2009-09-12 23:34:04 -0400 | [diff] [blame] | 162 | struct ftrace_event_call *call = &event_boot_ret; |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 163 | struct ring_buffer_event *event; |
Steven Rostedt | e77405a | 2009-09-02 14:17:06 -0400 | [diff] [blame] | 164 | struct ring_buffer *buffer; |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 165 | struct trace_boot_ret *entry; |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 166 | struct trace_array *tr = boot_trace; |
| 167 | |
Steven Rostedt | 79fb076 | 2009-02-02 21:38:33 -0500 | [diff] [blame] | 168 | if (!tr || !pre_initcalls_finished) |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 169 | return; |
| 170 | |
| 171 | sprint_symbol(bt->func, (unsigned long)fn); |
| 172 | preempt_disable(); |
| 173 | |
Steven Rostedt | e77405a | 2009-09-02 14:17:06 -0400 | [diff] [blame] | 174 | buffer = tr->buffer; |
| 175 | event = trace_buffer_lock_reserve(buffer, TRACE_BOOT_RET, |
Arnaldo Carvalho de Melo | 51a763d | 2009-02-05 16:14:13 -0200 | [diff] [blame] | 176 | sizeof(*entry), 0, 0); |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 177 | if (!event) |
| 178 | goto out; |
| 179 | entry = ring_buffer_event_data(event); |
Frederic Weisbecker | 7423907 | 2008-11-11 23:24:42 +0100 | [diff] [blame] | 180 | entry->boot_ret = *bt; |
Steven Rostedt | 60ba770 | 2009-09-12 23:34:04 -0400 | [diff] [blame] | 181 | if (!filter_check_discard(call, entry, buffer, event)) |
| 182 | trace_buffer_unlock_commit(buffer, event, 0, 0); |
Steven Rostedt | 3928a8a | 2008-09-29 23:02:41 -0400 | [diff] [blame] | 183 | out: |
Frédéric Weisbecker | d13744c | 2008-09-23 11:32:08 +0100 | [diff] [blame] | 184 | preempt_enable(); |
| 185 | } |