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