| 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 | } |