blob: 4b5e24cf2f4a98387c849d8461b85a8a9c79aa55 [file] [log] [blame]
Ingo Molnar43ae34c2007-07-09 18:52:00 +02001/*
2 * kernel/time/sched_debug.c
3 *
4 * Print the CFS rbtree
5 *
6 * Copyright(C) 2007, Red Hat, Inc., Ingo Molnar
7 *
8 * This program is free software; you can redistribute it and/or modify
9 * it under the terms of the GNU General Public License version 2 as
10 * published by the Free Software Foundation.
11 */
12
13#include <linux/proc_fs.h>
14#include <linux/sched.h>
15#include <linux/seq_file.h>
16#include <linux/kallsyms.h>
17#include <linux/utsname.h>
18
19/*
20 * This allows printing both to /proc/sched_debug and
21 * to the console
22 */
23#define SEQ_printf(m, x...) \
24 do { \
25 if (m) \
26 seq_printf(m, x); \
27 else \
28 printk(x); \
29 } while (0)
30
Ingo Molnaref83a572007-10-15 17:00:08 +020031/*
32 * Ease the printing of nsec fields:
33 */
Ingo Molnar90b26282007-12-30 17:24:35 +010034static long long nsec_high(unsigned long long nsec)
Ingo Molnaref83a572007-10-15 17:00:08 +020035{
Ingo Molnar90b26282007-12-30 17:24:35 +010036 if ((long long)nsec < 0) {
Ingo Molnaref83a572007-10-15 17:00:08 +020037 nsec = -nsec;
38 do_div(nsec, 1000000);
39 return -nsec;
40 }
41 do_div(nsec, 1000000);
42
43 return nsec;
44}
45
Ingo Molnar90b26282007-12-30 17:24:35 +010046static unsigned long nsec_low(unsigned long long nsec)
Ingo Molnaref83a572007-10-15 17:00:08 +020047{
Ingo Molnar90b26282007-12-30 17:24:35 +010048 if ((long long)nsec < 0)
Ingo Molnaref83a572007-10-15 17:00:08 +020049 nsec = -nsec;
50
51 return do_div(nsec, 1000000);
52}
53
54#define SPLIT_NS(x) nsec_high(x), nsec_low(x)
55
Ingo Molnar43ae34c2007-07-09 18:52:00 +020056static void
Ingo Molnara48da482007-08-09 11:16:51 +020057print_task(struct seq_file *m, struct rq *rq, struct task_struct *p)
Ingo Molnar43ae34c2007-07-09 18:52:00 +020058{
59 if (rq->curr == p)
60 SEQ_printf(m, "R");
61 else
62 SEQ_printf(m, " ");
63
Ingo Molnaref83a572007-10-15 17:00:08 +020064 SEQ_printf(m, "%15s %5d %9Ld.%06ld %9Ld %5d ",
Ingo Molnar43ae34c2007-07-09 18:52:00 +020065 p->comm, p->pid,
Ingo Molnaref83a572007-10-15 17:00:08 +020066 SPLIT_NS(p->se.vruntime),
Ingo Molnar43ae34c2007-07-09 18:52:00 +020067 (long long)(p->nvcsw + p->nivcsw),
Al Viro6f605d82007-08-06 04:26:59 +010068 p->prio);
Ingo Molnar6cfb0d52007-08-02 17:41:40 +020069#ifdef CONFIG_SCHEDSTATS
Mike Galbraithc86da3a2007-10-15 17:00:08 +020070 SEQ_printf(m, "%9Ld.%06ld %9Ld.%06ld %9Ld.%06ld\n",
Ingo Molnaref83a572007-10-15 17:00:08 +020071 SPLIT_NS(p->se.vruntime),
72 SPLIT_NS(p->se.sum_exec_runtime),
73 SPLIT_NS(p->se.sum_sleep_runtime));
Ingo Molnar6cfb0d52007-08-02 17:41:40 +020074#else
Ingo Molnaref83a572007-10-15 17:00:08 +020075 SEQ_printf(m, "%15Ld %15Ld %15Ld.%06ld %15Ld.%06ld %15Ld.%06ld\n",
76 0LL, 0LL, 0LL, 0L, 0LL, 0L, 0LL, 0L);
Ingo Molnar6cfb0d52007-08-02 17:41:40 +020077#endif
Ingo Molnar43ae34c2007-07-09 18:52:00 +020078}
79
Ingo Molnara48da482007-08-09 11:16:51 +020080static void print_rq(struct seq_file *m, struct rq *rq, int rq_cpu)
Ingo Molnar43ae34c2007-07-09 18:52:00 +020081{
82 struct task_struct *g, *p;
Peter Zijlstraab63a632007-10-25 14:02:45 +020083 unsigned long flags;
Ingo Molnar43ae34c2007-07-09 18:52:00 +020084
85 SEQ_printf(m,
86 "\nrunnable tasks:\n"
Mike Galbraithc86da3a2007-10-15 17:00:08 +020087 " task PID tree-key switches prio"
88 " exec-runtime sum-exec sum-sleep\n"
Ingo Molnar1a75b942007-10-15 17:00:08 +020089 "------------------------------------------------------"
Mike Galbraithc86da3a2007-10-15 17:00:08 +020090 "----------------------------------------------------\n");
Ingo Molnar43ae34c2007-07-09 18:52:00 +020091
Peter Zijlstraab63a632007-10-25 14:02:45 +020092 read_lock_irqsave(&tasklist_lock, flags);
Ingo Molnar43ae34c2007-07-09 18:52:00 +020093
94 do_each_thread(g, p) {
95 if (!p->se.on_rq || task_cpu(p) != rq_cpu)
96 continue;
97
Ingo Molnara48da482007-08-09 11:16:51 +020098 print_task(m, rq, p);
Ingo Molnar43ae34c2007-07-09 18:52:00 +020099 } while_each_thread(g, p);
100
Peter Zijlstraab63a632007-10-25 14:02:45 +0200101 read_unlock_irqrestore(&tasklist_lock, flags);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200102}
103
Ingo Molnar5cef9ec2007-08-09 11:16:47 +0200104void print_cfs_rq(struct seq_file *m, int cpu, struct cfs_rq *cfs_rq)
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200105{
Ingo Molnar86d95602007-10-15 17:00:06 +0200106 s64 MIN_vruntime = -1, min_vruntime, max_vruntime = -1,
107 spread, rq0_min_vruntime, spread0;
Ingo Molnar67e12ea2007-10-15 17:00:05 +0200108 struct rq *rq = &per_cpu(runqueues, cpu);
109 struct sched_entity *last;
110 unsigned long flags;
111
Ingo Molnar5167e752007-08-10 23:05:11 +0200112 SEQ_printf(m, "\ncfs_rq\n");
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200113
Ingo Molnaref83a572007-10-15 17:00:08 +0200114 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "exec_clock",
115 SPLIT_NS(cfs_rq->exec_clock));
Ingo Molnar67e12ea2007-10-15 17:00:05 +0200116
117 spin_lock_irqsave(&rq->lock, flags);
118 if (cfs_rq->rb_leftmost)
119 MIN_vruntime = (__pick_next_entity(cfs_rq))->vruntime;
120 last = __pick_last_entity(cfs_rq);
121 if (last)
122 max_vruntime = last->vruntime;
Ingo Molnar86d95602007-10-15 17:00:06 +0200123 min_vruntime = rq->cfs.min_vruntime;
124 rq0_min_vruntime = per_cpu(runqueues, 0).cfs.min_vruntime;
Ingo Molnar67e12ea2007-10-15 17:00:05 +0200125 spin_unlock_irqrestore(&rq->lock, flags);
Ingo Molnaref83a572007-10-15 17:00:08 +0200126 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "MIN_vruntime",
127 SPLIT_NS(MIN_vruntime));
128 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "min_vruntime",
129 SPLIT_NS(min_vruntime));
130 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "max_vruntime",
131 SPLIT_NS(max_vruntime));
Ingo Molnar67e12ea2007-10-15 17:00:05 +0200132 spread = max_vruntime - MIN_vruntime;
Ingo Molnaref83a572007-10-15 17:00:08 +0200133 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "spread",
134 SPLIT_NS(spread));
Ingo Molnar86d95602007-10-15 17:00:06 +0200135 spread0 = min_vruntime - rq0_min_vruntime;
Ingo Molnaref83a572007-10-15 17:00:08 +0200136 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "spread0",
137 SPLIT_NS(spread0));
Srivatsa Vaddagiri545f3b12007-10-15 17:00:09 +0200138 SEQ_printf(m, " .%-30s: %ld\n", "nr_running", cfs_rq->nr_running);
139 SEQ_printf(m, " .%-30s: %ld\n", "load", cfs_rq->load.weight);
S.Caglar Onurfdd71d12007-10-15 17:00:10 +0200140#ifdef CONFIG_SCHEDSTATS
Ken Chen480b9432007-10-18 21:32:56 +0200141 SEQ_printf(m, " .%-30s: %d\n", "bkl_count",
Ingo Molnar2d723762007-10-15 17:00:12 +0200142 rq->bkl_count);
S.Caglar Onurfdd71d12007-10-15 17:00:10 +0200143#endif
Peter Zijlstraddc97292007-10-15 17:00:10 +0200144 SEQ_printf(m, " .%-30s: %ld\n", "nr_spread_over",
145 cfs_rq->nr_spread_over);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200146}
147
Ingo Molnara48da482007-08-09 11:16:51 +0200148static void print_cpu(struct seq_file *m, int cpu)
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200149{
150 struct rq *rq = &per_cpu(runqueues, cpu);
151
152#ifdef CONFIG_X86
153 {
154 unsigned int freq = cpu_khz ? : 1;
155
156 SEQ_printf(m, "\ncpu#%d, %u.%03u MHz\n",
157 cpu, freq / 1000, (freq % 1000));
158 }
159#else
160 SEQ_printf(m, "\ncpu#%d\n", cpu);
161#endif
162
163#define P(x) \
164 SEQ_printf(m, " .%-30s: %Ld\n", #x, (long long)(rq->x))
Ingo Molnaref83a572007-10-15 17:00:08 +0200165#define PN(x) \
166 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", #x, SPLIT_NS(rq->x))
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200167
168 P(nr_running);
169 SEQ_printf(m, " .%-30s: %lu\n", "load",
Dmitry Adamushko495eca42007-10-15 17:00:06 +0200170 rq->load.weight);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200171 P(nr_switches);
172 P(nr_load_updates);
173 P(nr_uninterruptible);
174 SEQ_printf(m, " .%-30s: %lu\n", "jiffies", jiffies);
Ingo Molnaref83a572007-10-15 17:00:08 +0200175 PN(next_balance);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200176 P(curr->pid);
Ingo Molnaref83a572007-10-15 17:00:08 +0200177 PN(clock);
178 PN(idle_clock);
179 PN(prev_clock_raw);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200180 P(clock_warps);
181 P(clock_overflows);
Guillaume Chazaraincc203d22008-01-25 21:08:34 +0100182 P(clock_underflows);
Ingo Molnar2aa44d02007-08-23 15:18:02 +0200183 P(clock_deep_idle_events);
Ingo Molnaref83a572007-10-15 17:00:08 +0200184 PN(clock_max_delta);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200185 P(cpu_load[0]);
186 P(cpu_load[1]);
187 P(cpu_load[2]);
188 P(cpu_load[3]);
189 P(cpu_load[4]);
190#undef P
Ingo Molnaref83a572007-10-15 17:00:08 +0200191#undef PN
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200192
Ingo Molnar5cef9ec2007-08-09 11:16:47 +0200193 print_cfs_stats(m, cpu);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200194
Ingo Molnara48da482007-08-09 11:16:51 +0200195 print_rq(m, rq, cpu);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200196}
197
198static int sched_debug_show(struct seq_file *m, void *v)
199{
200 u64 now = ktime_to_ns(ktime_get());
201 int cpu;
202
Ingo Molnarf7b93292007-11-26 21:21:49 +0100203 SEQ_printf(m, "Sched Debug Version: v0.07, %s %.*s\n",
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200204 init_utsname()->release,
205 (int)strcspn(init_utsname()->version, " "),
206 init_utsname()->version);
207
Ingo Molnaref83a572007-10-15 17:00:08 +0200208 SEQ_printf(m, "now at %Lu.%06ld msecs\n", SPLIT_NS(now));
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200209
Ingo Molnar1aa47312007-10-15 17:00:10 +0200210#define P(x) \
Ingo Molnard822cec2007-10-15 17:00:10 +0200211 SEQ_printf(m, " .%-40s: %Ld\n", #x, (long long)(x))
Ingo Molnar1aa47312007-10-15 17:00:10 +0200212#define PN(x) \
Ingo Molnard822cec2007-10-15 17:00:10 +0200213 SEQ_printf(m, " .%-40s: %Ld.%06ld\n", #x, SPLIT_NS(x))
Ingo Molnar1aa47312007-10-15 17:00:10 +0200214 PN(sysctl_sched_latency);
Peter Zijlstrab2be5e92007-11-09 22:39:37 +0100215 PN(sysctl_sched_min_granularity);
Ingo Molnar1aa47312007-10-15 17:00:10 +0200216 PN(sysctl_sched_wakeup_granularity);
217 PN(sysctl_sched_batch_wakeup_granularity);
218 PN(sysctl_sched_child_runs_first);
219 P(sysctl_sched_features);
220#undef PN
221#undef P
222
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200223 for_each_online_cpu(cpu)
Ingo Molnara48da482007-08-09 11:16:51 +0200224 print_cpu(m, cpu);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200225
226 SEQ_printf(m, "\n");
227
228 return 0;
229}
230
Josh Triplettf33734612007-07-26 13:40:43 +0200231static void sysrq_sched_debug_show(void)
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200232{
233 sched_debug_show(NULL, NULL);
234}
235
236static int sched_debug_open(struct inode *inode, struct file *filp)
237{
238 return single_open(filp, sched_debug_show, NULL);
239}
240
Arjan van de Ven0dbee3a2007-10-15 17:00:19 +0200241static const struct file_operations sched_debug_fops = {
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200242 .open = sched_debug_open,
243 .read = seq_read,
244 .llseek = seq_lseek,
Alexey Dobriyan5ea473a2007-07-31 00:38:50 -0700245 .release = single_release,
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200246};
247
248static int __init init_sched_debug_procfs(void)
249{
250 struct proc_dir_entry *pe;
251
252 pe = create_proc_entry("sched_debug", 0644, NULL);
253 if (!pe)
254 return -ENOMEM;
255
256 pe->proc_fops = &sched_debug_fops;
257
258 return 0;
259}
260
261__initcall(init_sched_debug_procfs);
262
263void proc_sched_show_task(struct task_struct *p, struct seq_file *m)
264{
Ingo Molnarcc367732007-10-15 17:00:18 +0200265 unsigned long nr_switches;
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200266 unsigned long flags;
267 int num_threads = 1;
268
269 rcu_read_lock();
270 if (lock_task_sighand(p, &flags)) {
271 num_threads = atomic_read(&p->signal->count);
272 unlock_task_sighand(p, &flags);
273 }
274 rcu_read_unlock();
275
276 SEQ_printf(m, "%s (%d, #threads: %d)\n", p->comm, p->pid, num_threads);
Ingo Molnar2d92f222007-10-15 17:00:18 +0200277 SEQ_printf(m,
278 "---------------------------------------------------------\n");
Ingo Molnarcc367732007-10-15 17:00:18 +0200279#define __P(F) \
280 SEQ_printf(m, "%-35s:%21Ld\n", #F, (long long)F)
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200281#define P(F) \
Ingo Molnar2d92f222007-10-15 17:00:18 +0200282 SEQ_printf(m, "%-35s:%21Ld\n", #F, (long long)p->F)
Ingo Molnarcc367732007-10-15 17:00:18 +0200283#define __PN(F) \
284 SEQ_printf(m, "%-35s:%14Ld.%06ld\n", #F, SPLIT_NS((long long)F))
Ingo Molnaref83a572007-10-15 17:00:08 +0200285#define PN(F) \
Ingo Molnar2d92f222007-10-15 17:00:18 +0200286 SEQ_printf(m, "%-35s:%14Ld.%06ld\n", #F, SPLIT_NS((long long)p->F))
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200287
Ingo Molnaref83a572007-10-15 17:00:08 +0200288 PN(se.exec_start);
289 PN(se.vruntime);
290 PN(se.sum_exec_runtime);
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200291
Ingo Molnarcc367732007-10-15 17:00:18 +0200292 nr_switches = p->nvcsw + p->nivcsw;
293
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200294#ifdef CONFIG_SCHEDSTATS
Ingo Molnaref83a572007-10-15 17:00:08 +0200295 PN(se.wait_start);
296 PN(se.sleep_start);
297 PN(se.block_start);
298 PN(se.sleep_max);
299 PN(se.block_max);
300 PN(se.exec_max);
301 PN(se.slice_max);
302 PN(se.wait_max);
Arjan van de Ven6d082592008-01-25 21:08:35 +0100303 PN(se.wait_sum);
304 P(se.wait_count);
Ingo Molnar2d723762007-10-15 17:00:12 +0200305 P(sched_info.bkl_count);
Ingo Molnarcc367732007-10-15 17:00:18 +0200306 P(se.nr_migrations);
307 P(se.nr_migrations_cold);
308 P(se.nr_failed_migrations_affine);
309 P(se.nr_failed_migrations_running);
310 P(se.nr_failed_migrations_hot);
311 P(se.nr_forced_migrations);
312 P(se.nr_forced2_migrations);
313 P(se.nr_wakeups);
314 P(se.nr_wakeups_sync);
315 P(se.nr_wakeups_migrate);
316 P(se.nr_wakeups_local);
317 P(se.nr_wakeups_remote);
318 P(se.nr_wakeups_affine);
319 P(se.nr_wakeups_affine_attempts);
320 P(se.nr_wakeups_passive);
321 P(se.nr_wakeups_idle);
322
323 {
324 u64 avg_atom, avg_per_cpu;
325
326 avg_atom = p->se.sum_exec_runtime;
327 if (nr_switches)
328 do_div(avg_atom, nr_switches);
329 else
330 avg_atom = -1LL;
331
332 avg_per_cpu = p->se.sum_exec_runtime;
Ingo Molnarc1a89742007-11-28 15:52:56 +0100333 if (p->se.nr_migrations) {
334 avg_per_cpu = div64_64(avg_per_cpu,
335 p->se.nr_migrations);
336 } else {
Ingo Molnarcc367732007-10-15 17:00:18 +0200337 avg_per_cpu = -1LL;
Ingo Molnarc1a89742007-11-28 15:52:56 +0100338 }
Ingo Molnarcc367732007-10-15 17:00:18 +0200339
340 __PN(avg_atom);
341 __PN(avg_per_cpu);
342 }
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200343#endif
Ingo Molnarcc367732007-10-15 17:00:18 +0200344 __P(nr_switches);
Ingo Molnar2d92f222007-10-15 17:00:18 +0200345 SEQ_printf(m, "%-35s:%21Ld\n",
Ingo Molnarcc367732007-10-15 17:00:18 +0200346 "nr_voluntary_switches", (long long)p->nvcsw);
347 SEQ_printf(m, "%-35s:%21Ld\n",
348 "nr_involuntary_switches", (long long)p->nivcsw);
349
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200350 P(se.load.weight);
351 P(policy);
352 P(prio);
Ingo Molnaref83a572007-10-15 17:00:08 +0200353#undef PN
Ingo Molnarcc367732007-10-15 17:00:18 +0200354#undef __PN
355#undef P
356#undef __P
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200357
358 {
359 u64 t0, t1;
360
361 t0 = sched_clock();
362 t1 = sched_clock();
Ingo Molnar2d92f222007-10-15 17:00:18 +0200363 SEQ_printf(m, "%-35s:%21Ld\n",
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200364 "clock-delta", (long long)(t1-t0));
365 }
366}
367
368void proc_sched_set_task(struct task_struct *p)
369{
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200370#ifdef CONFIG_SCHEDSTATS
Ingo Molnarcc367732007-10-15 17:00:18 +0200371 p->se.wait_max = 0;
Arjan van de Ven6d082592008-01-25 21:08:35 +0100372 p->se.wait_sum = 0;
373 p->se.wait_count = 0;
Ingo Molnarcc367732007-10-15 17:00:18 +0200374 p->se.sleep_max = 0;
375 p->se.sum_sleep_runtime = 0;
376 p->se.block_max = 0;
377 p->se.exec_max = 0;
378 p->se.slice_max = 0;
379 p->se.nr_migrations = 0;
380 p->se.nr_migrations_cold = 0;
381 p->se.nr_failed_migrations_affine = 0;
382 p->se.nr_failed_migrations_running = 0;
383 p->se.nr_failed_migrations_hot = 0;
384 p->se.nr_forced_migrations = 0;
385 p->se.nr_forced2_migrations = 0;
386 p->se.nr_wakeups = 0;
387 p->se.nr_wakeups_sync = 0;
388 p->se.nr_wakeups_migrate = 0;
389 p->se.nr_wakeups_local = 0;
390 p->se.nr_wakeups_remote = 0;
391 p->se.nr_wakeups_affine = 0;
392 p->se.nr_wakeups_affine_attempts = 0;
393 p->se.nr_wakeups_passive = 0;
394 p->se.nr_wakeups_idle = 0;
395 p->sched_info.bkl_count = 0;
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200396#endif
Ingo Molnarcc367732007-10-15 17:00:18 +0200397 p->se.sum_exec_runtime = 0;
398 p->se.prev_sum_exec_runtime = 0;
399 p->nvcsw = 0;
400 p->nivcsw = 0;
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200401}