Loading...
1#undef TRACE_SYSTEM
2#define TRACE_SYSTEM timer
3
4#if !defined(_TRACE_TIMER_H) || defined(TRACE_HEADER_MULTI_READ)
5#define _TRACE_TIMER_H
6
7#include <linux/tracepoint.h>
8#include <linux/hrtimer.h>
9#include <linux/timer.h>
10
11DECLARE_EVENT_CLASS(timer_class,
12
13 TP_PROTO(struct timer_list *timer),
14
15 TP_ARGS(timer),
16
17 TP_STRUCT__entry(
18 __field( void *, timer )
19 ),
20
21 TP_fast_assign(
22 __entry->timer = timer;
23 ),
24
25 TP_printk("timer=%p", __entry->timer)
26);
27
28/**
29 * timer_init - called when the timer is initialized
30 * @timer: pointer to struct timer_list
31 */
32DEFINE_EVENT(timer_class, timer_init,
33
34 TP_PROTO(struct timer_list *timer),
35
36 TP_ARGS(timer)
37);
38
39/**
40 * timer_start - called when the timer is started
41 * @timer: pointer to struct timer_list
42 * @expires: the timers expiry time
43 */
44TRACE_EVENT(timer_start,
45
46 TP_PROTO(struct timer_list *timer, unsigned long expires),
47
48 TP_ARGS(timer, expires),
49
50 TP_STRUCT__entry(
51 __field( void *, timer )
52 __field( void *, function )
53 __field( unsigned long, expires )
54 __field( unsigned long, now )
55 ),
56
57 TP_fast_assign(
58 __entry->timer = timer;
59 __entry->function = timer->function;
60 __entry->expires = expires;
61 __entry->now = jiffies;
62 ),
63
64 TP_printk("timer=%p function=%pf expires=%lu [timeout=%ld]",
65 __entry->timer, __entry->function, __entry->expires,
66 (long)__entry->expires - __entry->now)
67);
68
69/**
70 * timer_expire_entry - called immediately before the timer callback
71 * @timer: pointer to struct timer_list
72 *
73 * Allows to determine the timer latency.
74 */
75TRACE_EVENT(timer_expire_entry,
76
77 TP_PROTO(struct timer_list *timer),
78
79 TP_ARGS(timer),
80
81 TP_STRUCT__entry(
82 __field( void *, timer )
83 __field( unsigned long, now )
84 __field( void *, function)
85 ),
86
87 TP_fast_assign(
88 __entry->timer = timer;
89 __entry->now = jiffies;
90 __entry->function = timer->function;
91 ),
92
93 TP_printk("timer=%p function=%pf now=%lu", __entry->timer, __entry->function,__entry->now)
94);
95
96/**
97 * timer_expire_exit - called immediately after the timer callback returns
98 * @timer: pointer to struct timer_list
99 *
100 * When used in combination with the timer_expire_entry tracepoint we can
101 * determine the runtime of the timer callback function.
102 *
103 * NOTE: Do NOT derefernce timer in TP_fast_assign. The pointer might
104 * be invalid. We solely track the pointer.
105 */
106DEFINE_EVENT(timer_class, timer_expire_exit,
107
108 TP_PROTO(struct timer_list *timer),
109
110 TP_ARGS(timer)
111);
112
113/**
114 * timer_cancel - called when the timer is canceled
115 * @timer: pointer to struct timer_list
116 */
117DEFINE_EVENT(timer_class, timer_cancel,
118
119 TP_PROTO(struct timer_list *timer),
120
121 TP_ARGS(timer)
122);
123
124/**
125 * hrtimer_init - called when the hrtimer is initialized
126 * @timer: pointer to struct hrtimer
127 * @clockid: the hrtimers clock
128 * @mode: the hrtimers mode
129 */
130TRACE_EVENT(hrtimer_init,
131
132 TP_PROTO(struct hrtimer *hrtimer, clockid_t clockid,
133 enum hrtimer_mode mode),
134
135 TP_ARGS(hrtimer, clockid, mode),
136
137 TP_STRUCT__entry(
138 __field( void *, hrtimer )
139 __field( clockid_t, clockid )
140 __field( enum hrtimer_mode, mode )
141 ),
142
143 TP_fast_assign(
144 __entry->hrtimer = hrtimer;
145 __entry->clockid = clockid;
146 __entry->mode = mode;
147 ),
148
149 TP_printk("hrtimer=%p clockid=%s mode=%s", __entry->hrtimer,
150 __entry->clockid == CLOCK_REALTIME ?
151 "CLOCK_REALTIME" : "CLOCK_MONOTONIC",
152 __entry->mode == HRTIMER_MODE_ABS ?
153 "HRTIMER_MODE_ABS" : "HRTIMER_MODE_REL")
154);
155
156/**
157 * hrtimer_start - called when the hrtimer is started
158 * @timer: pointer to struct hrtimer
159 */
160TRACE_EVENT(hrtimer_start,
161
162 TP_PROTO(struct hrtimer *hrtimer),
163
164 TP_ARGS(hrtimer),
165
166 TP_STRUCT__entry(
167 __field( void *, hrtimer )
168 __field( void *, function )
169 __field( s64, expires )
170 __field( s64, softexpires )
171 ),
172
173 TP_fast_assign(
174 __entry->hrtimer = hrtimer;
175 __entry->function = hrtimer->function;
176 __entry->expires = hrtimer_get_expires(hrtimer).tv64;
177 __entry->softexpires = hrtimer_get_softexpires(hrtimer).tv64;
178 ),
179
180 TP_printk("hrtimer=%p function=%pf expires=%llu softexpires=%llu",
181 __entry->hrtimer, __entry->function,
182 (unsigned long long)ktime_to_ns((ktime_t) {
183 .tv64 = __entry->expires }),
184 (unsigned long long)ktime_to_ns((ktime_t) {
185 .tv64 = __entry->softexpires }))
186);
187
188/**
189 * htimmer_expire_entry - called immediately before the hrtimer callback
190 * @timer: pointer to struct hrtimer
191 * @now: pointer to variable which contains current time of the
192 * timers base.
193 *
194 * Allows to determine the timer latency.
195 */
196TRACE_EVENT(hrtimer_expire_entry,
197
198 TP_PROTO(struct hrtimer *hrtimer, ktime_t *now),
199
200 TP_ARGS(hrtimer, now),
201
202 TP_STRUCT__entry(
203 __field( void *, hrtimer )
204 __field( s64, now )
205 __field( void *, function)
206 ),
207
208 TP_fast_assign(
209 __entry->hrtimer = hrtimer;
210 __entry->now = now->tv64;
211 __entry->function = hrtimer->function;
212 ),
213
214 TP_printk("hrtimer=%p function=%pf now=%llu", __entry->hrtimer, __entry->function,
215 (unsigned long long)ktime_to_ns((ktime_t) { .tv64 = __entry->now }))
216 );
217
218DECLARE_EVENT_CLASS(hrtimer_class,
219
220 TP_PROTO(struct hrtimer *hrtimer),
221
222 TP_ARGS(hrtimer),
223
224 TP_STRUCT__entry(
225 __field( void *, hrtimer )
226 ),
227
228 TP_fast_assign(
229 __entry->hrtimer = hrtimer;
230 ),
231
232 TP_printk("hrtimer=%p", __entry->hrtimer)
233);
234
235/**
236 * hrtimer_expire_exit - called immediately after the hrtimer callback returns
237 * @timer: pointer to struct hrtimer
238 *
239 * When used in combination with the hrtimer_expire_entry tracepoint we can
240 * determine the runtime of the callback function.
241 */
242DEFINE_EVENT(hrtimer_class, hrtimer_expire_exit,
243
244 TP_PROTO(struct hrtimer *hrtimer),
245
246 TP_ARGS(hrtimer)
247);
248
249/**
250 * hrtimer_cancel - called when the hrtimer is canceled
251 * @hrtimer: pointer to struct hrtimer
252 */
253DEFINE_EVENT(hrtimer_class, hrtimer_cancel,
254
255 TP_PROTO(struct hrtimer *hrtimer),
256
257 TP_ARGS(hrtimer)
258);
259
260/**
261 * itimer_state - called when itimer is started or canceled
262 * @which: name of the interval timer
263 * @value: the itimers value, itimer is canceled if value->it_value is
264 * zero, otherwise it is started
265 * @expires: the itimers expiry time
266 */
267TRACE_EVENT(itimer_state,
268
269 TP_PROTO(int which, const struct itimerval *const value,
270 cputime_t expires),
271
272 TP_ARGS(which, value, expires),
273
274 TP_STRUCT__entry(
275 __field( int, which )
276 __field( cputime_t, expires )
277 __field( long, value_sec )
278 __field( long, value_usec )
279 __field( long, interval_sec )
280 __field( long, interval_usec )
281 ),
282
283 TP_fast_assign(
284 __entry->which = which;
285 __entry->expires = expires;
286 __entry->value_sec = value->it_value.tv_sec;
287 __entry->value_usec = value->it_value.tv_usec;
288 __entry->interval_sec = value->it_interval.tv_sec;
289 __entry->interval_usec = value->it_interval.tv_usec;
290 ),
291
292 TP_printk("which=%d expires=%llu it_value=%ld.%ld it_interval=%ld.%ld",
293 __entry->which, (unsigned long long)__entry->expires,
294 __entry->value_sec, __entry->value_usec,
295 __entry->interval_sec, __entry->interval_usec)
296);
297
298/**
299 * itimer_expire - called when itimer expires
300 * @which: type of the interval timer
301 * @pid: pid of the process which owns the timer
302 * @now: current time, used to calculate the latency of itimer
303 */
304TRACE_EVENT(itimer_expire,
305
306 TP_PROTO(int which, struct pid *pid, cputime_t now),
307
308 TP_ARGS(which, pid, now),
309
310 TP_STRUCT__entry(
311 __field( int , which )
312 __field( pid_t, pid )
313 __field( cputime_t, now )
314 ),
315
316 TP_fast_assign(
317 __entry->which = which;
318 __entry->now = now;
319 __entry->pid = pid_nr(pid);
320 ),
321
322 TP_printk("which=%d pid=%d now=%llu", __entry->which,
323 (int) __entry->pid, (unsigned long long)__entry->now)
324);
325
326#endif /* _TRACE_TIMER_H */
327
328/* This part must be outside protection */
329#include <trace/define_trace.h>
1/* SPDX-License-Identifier: GPL-2.0 */
2#undef TRACE_SYSTEM
3#define TRACE_SYSTEM timer
4
5#if !defined(_TRACE_TIMER_H) || defined(TRACE_HEADER_MULTI_READ)
6#define _TRACE_TIMER_H
7
8#include <linux/tracepoint.h>
9#include <linux/hrtimer.h>
10#include <linux/timer.h>
11
12DECLARE_EVENT_CLASS(timer_class,
13
14 TP_PROTO(struct timer_list *timer),
15
16 TP_ARGS(timer),
17
18 TP_STRUCT__entry(
19 __field( void *, timer )
20 ),
21
22 TP_fast_assign(
23 __entry->timer = timer;
24 ),
25
26 TP_printk("timer=%p", __entry->timer)
27);
28
29/**
30 * timer_init - called when the timer is initialized
31 * @timer: pointer to struct timer_list
32 */
33DEFINE_EVENT(timer_class, timer_init,
34
35 TP_PROTO(struct timer_list *timer),
36
37 TP_ARGS(timer)
38);
39
40#define decode_timer_flags(flags) \
41 __print_flags(flags, "|", \
42 { TIMER_MIGRATING, "M" }, \
43 { TIMER_DEFERRABLE, "D" }, \
44 { TIMER_PINNED, "P" }, \
45 { TIMER_IRQSAFE, "I" })
46
47/**
48 * timer_start - called when the timer is started
49 * @timer: pointer to struct timer_list
50 * @expires: the timers expiry time
51 */
52TRACE_EVENT(timer_start,
53
54 TP_PROTO(struct timer_list *timer,
55 unsigned long expires,
56 unsigned int flags),
57
58 TP_ARGS(timer, expires, flags),
59
60 TP_STRUCT__entry(
61 __field( void *, timer )
62 __field( void *, function )
63 __field( unsigned long, expires )
64 __field( unsigned long, now )
65 __field( unsigned int, flags )
66 ),
67
68 TP_fast_assign(
69 __entry->timer = timer;
70 __entry->function = timer->function;
71 __entry->expires = expires;
72 __entry->now = jiffies;
73 __entry->flags = flags;
74 ),
75
76 TP_printk("timer=%p function=%pf expires=%lu [timeout=%ld] cpu=%u idx=%u flags=%s",
77 __entry->timer, __entry->function, __entry->expires,
78 (long)__entry->expires - __entry->now,
79 __entry->flags & TIMER_CPUMASK,
80 __entry->flags >> TIMER_ARRAYSHIFT,
81 decode_timer_flags(__entry->flags & TIMER_TRACE_FLAGMASK))
82);
83
84/**
85 * timer_expire_entry - called immediately before the timer callback
86 * @timer: pointer to struct timer_list
87 *
88 * Allows to determine the timer latency.
89 */
90TRACE_EVENT(timer_expire_entry,
91
92 TP_PROTO(struct timer_list *timer),
93
94 TP_ARGS(timer),
95
96 TP_STRUCT__entry(
97 __field( void *, timer )
98 __field( unsigned long, now )
99 __field( void *, function)
100 ),
101
102 TP_fast_assign(
103 __entry->timer = timer;
104 __entry->now = jiffies;
105 __entry->function = timer->function;
106 ),
107
108 TP_printk("timer=%p function=%pf now=%lu", __entry->timer, __entry->function,__entry->now)
109);
110
111/**
112 * timer_expire_exit - called immediately after the timer callback returns
113 * @timer: pointer to struct timer_list
114 *
115 * When used in combination with the timer_expire_entry tracepoint we can
116 * determine the runtime of the timer callback function.
117 *
118 * NOTE: Do NOT derefernce timer in TP_fast_assign. The pointer might
119 * be invalid. We solely track the pointer.
120 */
121DEFINE_EVENT(timer_class, timer_expire_exit,
122
123 TP_PROTO(struct timer_list *timer),
124
125 TP_ARGS(timer)
126);
127
128/**
129 * timer_cancel - called when the timer is canceled
130 * @timer: pointer to struct timer_list
131 */
132DEFINE_EVENT(timer_class, timer_cancel,
133
134 TP_PROTO(struct timer_list *timer),
135
136 TP_ARGS(timer)
137);
138
139#define decode_clockid(type) \
140 __print_symbolic(type, \
141 { CLOCK_REALTIME, "CLOCK_REALTIME" }, \
142 { CLOCK_MONOTONIC, "CLOCK_MONOTONIC" }, \
143 { CLOCK_BOOTTIME, "CLOCK_BOOTTIME" }, \
144 { CLOCK_TAI, "CLOCK_TAI" })
145
146#define decode_hrtimer_mode(mode) \
147 __print_symbolic(mode, \
148 { HRTIMER_MODE_ABS, "ABS" }, \
149 { HRTIMER_MODE_REL, "REL" }, \
150 { HRTIMER_MODE_ABS_PINNED, "ABS|PINNED" }, \
151 { HRTIMER_MODE_REL_PINNED, "REL|PINNED" }, \
152 { HRTIMER_MODE_ABS_SOFT, "ABS|SOFT" }, \
153 { HRTIMER_MODE_REL_SOFT, "REL|SOFT" }, \
154 { HRTIMER_MODE_ABS_PINNED_SOFT, "ABS|PINNED|SOFT" }, \
155 { HRTIMER_MODE_REL_PINNED_SOFT, "REL|PINNED|SOFT" })
156
157/**
158 * hrtimer_init - called when the hrtimer is initialized
159 * @hrtimer: pointer to struct hrtimer
160 * @clockid: the hrtimers clock
161 * @mode: the hrtimers mode
162 */
163TRACE_EVENT(hrtimer_init,
164
165 TP_PROTO(struct hrtimer *hrtimer, clockid_t clockid,
166 enum hrtimer_mode mode),
167
168 TP_ARGS(hrtimer, clockid, mode),
169
170 TP_STRUCT__entry(
171 __field( void *, hrtimer )
172 __field( clockid_t, clockid )
173 __field( enum hrtimer_mode, mode )
174 ),
175
176 TP_fast_assign(
177 __entry->hrtimer = hrtimer;
178 __entry->clockid = clockid;
179 __entry->mode = mode;
180 ),
181
182 TP_printk("hrtimer=%p clockid=%s mode=%s", __entry->hrtimer,
183 decode_clockid(__entry->clockid),
184 decode_hrtimer_mode(__entry->mode))
185);
186
187/**
188 * hrtimer_start - called when the hrtimer is started
189 * @hrtimer: pointer to struct hrtimer
190 */
191TRACE_EVENT(hrtimer_start,
192
193 TP_PROTO(struct hrtimer *hrtimer, enum hrtimer_mode mode),
194
195 TP_ARGS(hrtimer, mode),
196
197 TP_STRUCT__entry(
198 __field( void *, hrtimer )
199 __field( void *, function )
200 __field( s64, expires )
201 __field( s64, softexpires )
202 __field( enum hrtimer_mode, mode )
203 ),
204
205 TP_fast_assign(
206 __entry->hrtimer = hrtimer;
207 __entry->function = hrtimer->function;
208 __entry->expires = hrtimer_get_expires(hrtimer);
209 __entry->softexpires = hrtimer_get_softexpires(hrtimer);
210 __entry->mode = mode;
211 ),
212
213 TP_printk("hrtimer=%p function=%pf expires=%llu softexpires=%llu "
214 "mode=%s", __entry->hrtimer, __entry->function,
215 (unsigned long long) __entry->expires,
216 (unsigned long long) __entry->softexpires,
217 decode_hrtimer_mode(__entry->mode))
218);
219
220/**
221 * hrtimer_expire_entry - called immediately before the hrtimer callback
222 * @hrtimer: pointer to struct hrtimer
223 * @now: pointer to variable which contains current time of the
224 * timers base.
225 *
226 * Allows to determine the timer latency.
227 */
228TRACE_EVENT(hrtimer_expire_entry,
229
230 TP_PROTO(struct hrtimer *hrtimer, ktime_t *now),
231
232 TP_ARGS(hrtimer, now),
233
234 TP_STRUCT__entry(
235 __field( void *, hrtimer )
236 __field( s64, now )
237 __field( void *, function)
238 ),
239
240 TP_fast_assign(
241 __entry->hrtimer = hrtimer;
242 __entry->now = *now;
243 __entry->function = hrtimer->function;
244 ),
245
246 TP_printk("hrtimer=%p function=%pf now=%llu", __entry->hrtimer, __entry->function,
247 (unsigned long long) __entry->now)
248);
249
250DECLARE_EVENT_CLASS(hrtimer_class,
251
252 TP_PROTO(struct hrtimer *hrtimer),
253
254 TP_ARGS(hrtimer),
255
256 TP_STRUCT__entry(
257 __field( void *, hrtimer )
258 ),
259
260 TP_fast_assign(
261 __entry->hrtimer = hrtimer;
262 ),
263
264 TP_printk("hrtimer=%p", __entry->hrtimer)
265);
266
267/**
268 * hrtimer_expire_exit - called immediately after the hrtimer callback returns
269 * @hrtimer: pointer to struct hrtimer
270 *
271 * When used in combination with the hrtimer_expire_entry tracepoint we can
272 * determine the runtime of the callback function.
273 */
274DEFINE_EVENT(hrtimer_class, hrtimer_expire_exit,
275
276 TP_PROTO(struct hrtimer *hrtimer),
277
278 TP_ARGS(hrtimer)
279);
280
281/**
282 * hrtimer_cancel - called when the hrtimer is canceled
283 * @hrtimer: pointer to struct hrtimer
284 */
285DEFINE_EVENT(hrtimer_class, hrtimer_cancel,
286
287 TP_PROTO(struct hrtimer *hrtimer),
288
289 TP_ARGS(hrtimer)
290);
291
292/**
293 * itimer_state - called when itimer is started or canceled
294 * @which: name of the interval timer
295 * @value: the itimers value, itimer is canceled if value->it_value is
296 * zero, otherwise it is started
297 * @expires: the itimers expiry time
298 */
299TRACE_EVENT(itimer_state,
300
301 TP_PROTO(int which, const struct itimerval *const value,
302 unsigned long long expires),
303
304 TP_ARGS(which, value, expires),
305
306 TP_STRUCT__entry(
307 __field( int, which )
308 __field( unsigned long long, expires )
309 __field( long, value_sec )
310 __field( long, value_usec )
311 __field( long, interval_sec )
312 __field( long, interval_usec )
313 ),
314
315 TP_fast_assign(
316 __entry->which = which;
317 __entry->expires = expires;
318 __entry->value_sec = value->it_value.tv_sec;
319 __entry->value_usec = value->it_value.tv_usec;
320 __entry->interval_sec = value->it_interval.tv_sec;
321 __entry->interval_usec = value->it_interval.tv_usec;
322 ),
323
324 TP_printk("which=%d expires=%llu it_value=%ld.%ld it_interval=%ld.%ld",
325 __entry->which, __entry->expires,
326 __entry->value_sec, __entry->value_usec,
327 __entry->interval_sec, __entry->interval_usec)
328);
329
330/**
331 * itimer_expire - called when itimer expires
332 * @which: type of the interval timer
333 * @pid: pid of the process which owns the timer
334 * @now: current time, used to calculate the latency of itimer
335 */
336TRACE_EVENT(itimer_expire,
337
338 TP_PROTO(int which, struct pid *pid, unsigned long long now),
339
340 TP_ARGS(which, pid, now),
341
342 TP_STRUCT__entry(
343 __field( int , which )
344 __field( pid_t, pid )
345 __field( unsigned long long, now )
346 ),
347
348 TP_fast_assign(
349 __entry->which = which;
350 __entry->now = now;
351 __entry->pid = pid_nr(pid);
352 ),
353
354 TP_printk("which=%d pid=%d now=%llu", __entry->which,
355 (int) __entry->pid, __entry->now)
356);
357
358#ifdef CONFIG_NO_HZ_COMMON
359
360#define TICK_DEP_NAMES \
361 tick_dep_mask_name(NONE) \
362 tick_dep_name(POSIX_TIMER) \
363 tick_dep_name(PERF_EVENTS) \
364 tick_dep_name(SCHED) \
365 tick_dep_name_end(CLOCK_UNSTABLE)
366
367#undef tick_dep_name
368#undef tick_dep_mask_name
369#undef tick_dep_name_end
370
371/* The MASK will convert to their bits and they need to be processed too */
372#define tick_dep_name(sdep) TRACE_DEFINE_ENUM(TICK_DEP_BIT_##sdep); \
373 TRACE_DEFINE_ENUM(TICK_DEP_MASK_##sdep);
374#define tick_dep_name_end(sdep) TRACE_DEFINE_ENUM(TICK_DEP_BIT_##sdep); \
375 TRACE_DEFINE_ENUM(TICK_DEP_MASK_##sdep);
376/* NONE only has a mask defined for it */
377#define tick_dep_mask_name(sdep) TRACE_DEFINE_ENUM(TICK_DEP_MASK_##sdep);
378
379TICK_DEP_NAMES
380
381#undef tick_dep_name
382#undef tick_dep_mask_name
383#undef tick_dep_name_end
384
385#define tick_dep_name(sdep) { TICK_DEP_MASK_##sdep, #sdep },
386#define tick_dep_mask_name(sdep) { TICK_DEP_MASK_##sdep, #sdep },
387#define tick_dep_name_end(sdep) { TICK_DEP_MASK_##sdep, #sdep }
388
389#define show_tick_dep_name(val) \
390 __print_symbolic(val, TICK_DEP_NAMES)
391
392TRACE_EVENT(tick_stop,
393
394 TP_PROTO(int success, int dependency),
395
396 TP_ARGS(success, dependency),
397
398 TP_STRUCT__entry(
399 __field( int , success )
400 __field( int , dependency )
401 ),
402
403 TP_fast_assign(
404 __entry->success = success;
405 __entry->dependency = dependency;
406 ),
407
408 TP_printk("success=%d dependency=%s", __entry->success, \
409 show_tick_dep_name(__entry->dependency))
410);
411#endif
412
413#endif /* _TRACE_TIMER_H */
414
415/* This part must be outside protection */
416#include <trace/define_trace.h>