blob: 7a30fc4c36423fc29f7e4bb97985ccd9e5ca9540 [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"
Steven Rostedtf0868d12008-12-23 23:24:12 -050014#include "trace_output.h"
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010015
16static struct trace_array *boot_trace;
Frederic Weisbecker71566a02008-10-31 12:57:20 +010017static bool pre_initcalls_finished;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010018
Frederic Weisbecker71566a02008-10-31 12:57:20 +010019/* Tells the boot tracer that the pre_smp_initcalls are finished.
20 * So we are ready .
21 * It doesn't enable sched events tracing however.
22 * You have to call enable_boot_trace to do so.
23 */
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010024void start_boot_trace(void)
25{
Frederic Weisbecker71566a02008-10-31 12:57:20 +010026 pre_initcalls_finished = true;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010027}
28
Frederic Weisbecker71566a02008-10-31 12:57:20 +010029void enable_boot_trace(void)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010030{
Steven Rostedt79fb0762009-02-02 21:38:33 -050031 if (boot_trace && pre_initcalls_finished)
Steven Rostedte168e052008-11-07 22:36:02 -050032 tracing_start_sched_switch_record();
Frederic Weisbecker71566a02008-10-31 12:57:20 +010033}
34
35void disable_boot_trace(void)
36{
Steven Rostedt79fb0762009-02-02 21:38:33 -050037 if (boot_trace && pre_initcalls_finished)
Steven Rostedte168e052008-11-07 22:36:02 -050038 tracing_stop_sched_switch_record();
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010039}
40
Frederic Weisbecker1c800252008-11-16 05:57:26 +010041static int boot_trace_init(struct trace_array *tr)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010042{
43 int cpu;
44 boot_trace = tr;
45
Steven Rostedt79fb0762009-02-02 21:38:33 -050046 if (!tr)
47 return 0;
48
Rusty Russell44623442009-01-01 10:12:23 +103049 for_each_cpu(cpu, cpu_possible_mask)
Steven Rostedt3928a8a2008-09-29 23:02:41 -040050 tracing_reset(tr, cpu);
Frederic Weisbeckerd7ad44b2008-10-31 13:20:08 +010051
Steven Rostedte168e052008-11-07 22:36:02 -050052 tracing_sched_switch_assign_trace(tr);
Frederic Weisbecker1c800252008-11-16 05:57:26 +010053 return 0;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010054}
55
Frederic Weisbecker74239072008-11-11 23:24:42 +010056static enum print_line_t
57initcall_call_print_line(struct trace_iterator *iter)
58{
59 struct trace_entry *entry = iter->ent;
60 struct trace_seq *s = &iter->seq;
61 struct trace_boot_call *field;
62 struct boot_trace_call *call;
63 u64 ts;
64 unsigned long nsec_rem;
65 int ret;
66
67 trace_assign_type(field, entry);
68 call = &field->boot_call;
69 ts = iter->ts;
70 nsec_rem = do_div(ts, 1000000000);
71
72 ret = trace_seq_printf(s, "[%5ld.%09ld] calling %s @ %i\n",
73 (unsigned long)ts, nsec_rem, call->func, call->caller);
74
75 if (!ret)
76 return TRACE_TYPE_PARTIAL_LINE;
77 else
78 return TRACE_TYPE_HANDLED;
79}
80
81static enum print_line_t
82initcall_ret_print_line(struct trace_iterator *iter)
83{
84 struct trace_entry *entry = iter->ent;
85 struct trace_seq *s = &iter->seq;
86 struct trace_boot_ret *field;
87 struct boot_trace_ret *init_ret;
88 u64 ts;
89 unsigned long nsec_rem;
90 int ret;
91
92 trace_assign_type(field, entry);
93 init_ret = &field->boot_ret;
94 ts = iter->ts;
95 nsec_rem = do_div(ts, 1000000000);
96
97 ret = trace_seq_printf(s, "[%5ld.%09ld] initcall %s "
98 "returned %d after %llu msecs\n",
99 (unsigned long) ts,
100 nsec_rem,
101 init_ret->func, init_ret->result, init_ret->duration);
102
103 if (!ret)
104 return TRACE_TYPE_PARTIAL_LINE;
105 else
106 return TRACE_TYPE_HANDLED;
107}
108
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +0200109static enum print_line_t initcall_print_line(struct trace_iterator *iter)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100110{
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100111 struct trace_entry *entry = iter->ent;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100112
Frederic Weisbecker74239072008-11-11 23:24:42 +0100113 switch (entry->type) {
114 case TRACE_BOOT_CALL:
115 return initcall_call_print_line(iter);
116 case TRACE_BOOT_RET:
117 return initcall_ret_print_line(iter);
118 default:
119 return TRACE_TYPE_UNHANDLED;
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +0200120 }
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100121}
122
123struct tracer boot_tracer __read_mostly =
124{
125 .name = "initcall",
126 .init = boot_trace_init,
Pekka J Enberg213cc062008-12-19 12:08:39 +0200127 .reset = tracing_reset_online_cpus,
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100128 .print_line = initcall_print_line,
129};
130
Frederic Weisbecker74239072008-11-11 23:24:42 +0100131void trace_boot_call(struct boot_trace_call *bt, initcall_t fn)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100132{
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400133 struct ring_buffer_event *event;
Frederic Weisbecker74239072008-11-11 23:24:42 +0100134 struct trace_boot_call *entry;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100135 struct trace_array *tr = boot_trace;
136
Steven Rostedt79fb0762009-02-02 21:38:33 -0500137 if (!tr || !pre_initcalls_finished)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100138 return;
139
Frederic Weisbecker56010202008-10-02 13:26:05 +0200140 /* Get its name now since this function could
141 * disappear because it is in the .init section.
142 */
Frederic Weisbecker74239072008-11-11 23:24:42 +0100143 sprint_symbol(bt->func, (unsigned long)fn);
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100144 preempt_disable();
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100145
Arnaldo Carvalho de Melo51a763d2009-02-05 16:14:13 -0200146 event = trace_buffer_lock_reserve(tr, TRACE_BOOT_CALL,
147 sizeof(*entry), 0, 0);
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400148 if (!event)
149 goto out;
150 entry = ring_buffer_event_data(event);
Frederic Weisbecker74239072008-11-11 23:24:42 +0100151 entry->boot_call = *bt;
Arnaldo Carvalho de Melo51a763d2009-02-05 16:14:13 -0200152 trace_buffer_unlock_commit(tr, event, 0, 0);
Frederic Weisbecker74239072008-11-11 23:24:42 +0100153 out:
154 preempt_enable();
155}
156
157void trace_boot_ret(struct boot_trace_ret *bt, initcall_t fn)
158{
159 struct ring_buffer_event *event;
160 struct trace_boot_ret *entry;
Frederic Weisbecker74239072008-11-11 23:24:42 +0100161 struct trace_array *tr = boot_trace;
162
Steven Rostedt79fb0762009-02-02 21:38:33 -0500163 if (!tr || !pre_initcalls_finished)
Frederic Weisbecker74239072008-11-11 23:24:42 +0100164 return;
165
166 sprint_symbol(bt->func, (unsigned long)fn);
167 preempt_disable();
168
Arnaldo Carvalho de Melo51a763d2009-02-05 16:14:13 -0200169 event = trace_buffer_lock_reserve(tr, TRACE_BOOT_RET,
170 sizeof(*entry), 0, 0);
Frederic Weisbecker74239072008-11-11 23:24:42 +0100171 if (!event)
172 goto out;
173 entry = ring_buffer_event_data(event);
Frederic Weisbecker74239072008-11-11 23:24:42 +0100174 entry->boot_ret = *bt;
Arnaldo Carvalho de Melo51a763d2009-02-05 16:14:13 -0200175 trace_buffer_unlock_commit(tr, event, 0, 0);
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400176 out:
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100177 preempt_enable();
178}