blob: cb333b7fd11395966a48f847bad71ecb486a70bb [file] [log] [blame]
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +01001/*
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 Weisbecker56010202008-10-02 13:26:05 +020011#include <linux/kallsyms.h>
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010012
13#include "trace.h"
14
15static struct trace_array *boot_trace;
Frederic Weisbecker71566a02008-10-31 12:57:20 +010016static bool pre_initcalls_finished;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010017
Frederic Weisbecker71566a02008-10-31 12:57:20 +010018/* Tells the boot tracer that the pre_smp_initcalls are finished.
19 * So we are ready .
20 * It doesn't enable sched events tracing however.
21 * You have to call enable_boot_trace to do so.
22 */
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010023void start_boot_trace(void)
24{
Frederic Weisbecker71566a02008-10-31 12:57:20 +010025 pre_initcalls_finished = true;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010026}
27
Frederic Weisbecker71566a02008-10-31 12:57:20 +010028void enable_boot_trace(void)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010029{
Frederic Weisbeckerd7ad44b2008-10-31 13:20:08 +010030 if (pre_initcalls_finished)
Steven Rostedte168e052008-11-07 22:36:02 -050031 tracing_start_sched_switch_record();
Frederic Weisbecker71566a02008-10-31 12:57:20 +010032}
33
34void disable_boot_trace(void)
35{
Frederic Weisbeckerd7ad44b2008-10-31 13:20:08 +010036 if (pre_initcalls_finished)
Steven Rostedte168e052008-11-07 22:36:02 -050037 tracing_stop_sched_switch_record();
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010038}
39
Frederic Weisbecker79a9d462008-10-31 13:34:45 +010040static void reset_boot_trace(struct trace_array *tr)
Frederic Weisbecker097d0362008-10-03 15:39:21 +020041{
Steven Rostedt75f5c472008-11-07 22:36:02 -050042 int cpu;
43
44 tr->time_start = ftrace_now(tr->cpu);
45
46 for_each_online_cpu(cpu)
47 tracing_reset(tr, cpu);
Frederic Weisbecker097d0362008-10-03 15:39:21 +020048}
49
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010050static void boot_trace_init(struct trace_array *tr)
51{
52 int cpu;
53 boot_trace = tr;
54
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010055 for_each_cpu_mask(cpu, cpu_possible_map)
Steven Rostedt3928a8a2008-09-29 23:02:41 -040056 tracing_reset(tr, cpu);
Frederic Weisbeckerd7ad44b2008-10-31 13:20:08 +010057
Steven Rostedte168e052008-11-07 22:36:02 -050058 tracing_sched_switch_assign_trace(tr);
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010059}
60
Frederic Weisbecker74239072008-11-11 23:24:42 +010061static enum print_line_t
62initcall_call_print_line(struct trace_iterator *iter)
63{
64 struct trace_entry *entry = iter->ent;
65 struct trace_seq *s = &iter->seq;
66 struct trace_boot_call *field;
67 struct boot_trace_call *call;
68 u64 ts;
69 unsigned long nsec_rem;
70 int ret;
71
72 trace_assign_type(field, entry);
73 call = &field->boot_call;
74 ts = iter->ts;
75 nsec_rem = do_div(ts, 1000000000);
76
77 ret = trace_seq_printf(s, "[%5ld.%09ld] calling %s @ %i\n",
78 (unsigned long)ts, nsec_rem, call->func, call->caller);
79
80 if (!ret)
81 return TRACE_TYPE_PARTIAL_LINE;
82 else
83 return TRACE_TYPE_HANDLED;
84}
85
86static enum print_line_t
87initcall_ret_print_line(struct trace_iterator *iter)
88{
89 struct trace_entry *entry = iter->ent;
90 struct trace_seq *s = &iter->seq;
91 struct trace_boot_ret *field;
92 struct boot_trace_ret *init_ret;
93 u64 ts;
94 unsigned long nsec_rem;
95 int ret;
96
97 trace_assign_type(field, entry);
98 init_ret = &field->boot_ret;
99 ts = iter->ts;
100 nsec_rem = do_div(ts, 1000000000);
101
102 ret = trace_seq_printf(s, "[%5ld.%09ld] initcall %s "
103 "returned %d after %llu msecs\n",
104 (unsigned long) ts,
105 nsec_rem,
106 init_ret->func, init_ret->result, init_ret->duration);
107
108 if (!ret)
109 return TRACE_TYPE_PARTIAL_LINE;
110 else
111 return TRACE_TYPE_HANDLED;
112}
113
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +0200114static enum print_line_t initcall_print_line(struct trace_iterator *iter)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100115{
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100116 struct trace_entry *entry = iter->ent;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100117
Frederic Weisbecker74239072008-11-11 23:24:42 +0100118 switch (entry->type) {
119 case TRACE_BOOT_CALL:
120 return initcall_call_print_line(iter);
121 case TRACE_BOOT_RET:
122 return initcall_ret_print_line(iter);
123 default:
124 return TRACE_TYPE_UNHANDLED;
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +0200125 }
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100126}
127
128struct tracer boot_tracer __read_mostly =
129{
130 .name = "initcall",
131 .init = boot_trace_init,
Frederic Weisbecker097d0362008-10-03 15:39:21 +0200132 .reset = reset_boot_trace,
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100133 .print_line = initcall_print_line,
134};
135
Frederic Weisbecker74239072008-11-11 23:24:42 +0100136void trace_boot_call(struct boot_trace_call *bt, initcall_t fn)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100137{
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400138 struct ring_buffer_event *event;
Frederic Weisbecker74239072008-11-11 23:24:42 +0100139 struct trace_boot_call *entry;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100140 unsigned long irq_flags;
141 struct trace_array *tr = boot_trace;
142
Frederic Weisbecker71566a02008-10-31 12:57:20 +0100143 if (!pre_initcalls_finished)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100144 return;
145
Frederic Weisbecker56010202008-10-02 13:26:05 +0200146 /* Get its name now since this function could
147 * disappear because it is in the .init section.
148 */
Frederic Weisbecker74239072008-11-11 23:24:42 +0100149 sprint_symbol(bt->func, (unsigned long)fn);
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100150 preempt_disable();
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100151
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400152 event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
153 &irq_flags);
154 if (!event)
155 goto out;
156 entry = ring_buffer_event_data(event);
Steven Rostedt38697052008-10-01 13:14:09 -0400157 tracing_generic_entry_update(&entry->ent, 0, 0);
Frederic Weisbecker74239072008-11-11 23:24:42 +0100158 entry->ent.type = TRACE_BOOT_CALL;
159 entry->boot_call = *bt;
160 ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
161
162 trace_wake_up();
163
164 out:
165 preempt_enable();
166}
167
168void trace_boot_ret(struct boot_trace_ret *bt, initcall_t fn)
169{
170 struct ring_buffer_event *event;
171 struct trace_boot_ret *entry;
172 unsigned long irq_flags;
173 struct trace_array *tr = boot_trace;
174
175 if (!pre_initcalls_finished)
176 return;
177
178 sprint_symbol(bt->func, (unsigned long)fn);
179 preempt_disable();
180
181 event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
182 &irq_flags);
183 if (!event)
184 goto out;
185 entry = ring_buffer_event_data(event);
186 tracing_generic_entry_update(&entry->ent, 0, 0);
187 entry->ent.type = TRACE_BOOT_RET;
188 entry->boot_ret = *bt;
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400189 ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100190
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100191 trace_wake_up();
192
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400193 out:
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100194 preempt_enable();
195}