blob: a5e517ec07c3dfa5e7b688b40355a9e4a67f13bc [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 */
34static long long nsec_high(long long nsec)
35{
36 if (nsec < 0) {
37 nsec = -nsec;
38 do_div(nsec, 1000000);
39 return -nsec;
40 }
41 do_div(nsec, 1000000);
42
43 return nsec;
44}
45
46static unsigned long nsec_low(long long nsec)
47{
48 if (nsec < 0)
49 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;
83
84 SEQ_printf(m,
85 "\nrunnable tasks:\n"
Mike Galbraithc86da3a2007-10-15 17:00:08 +020086 " task PID tree-key switches prio"
87 " exec-runtime sum-exec sum-sleep\n"
Ingo Molnar1a75b942007-10-15 17:00:08 +020088 "------------------------------------------------------"
Mike Galbraithc86da3a2007-10-15 17:00:08 +020089 "----------------------------------------------------\n");
Ingo Molnar43ae34c2007-07-09 18:52:00 +020090
91 read_lock_irq(&tasklist_lock);
92
93 do_each_thread(g, p) {
94 if (!p->se.on_rq || task_cpu(p) != rq_cpu)
95 continue;
96
Ingo Molnara48da482007-08-09 11:16:51 +020097 print_task(m, rq, p);
Ingo Molnar43ae34c2007-07-09 18:52:00 +020098 } while_each_thread(g, p);
99
100 read_unlock_irq(&tasklist_lock);
101}
102
Ingo Molnar5cef9ec2007-08-09 11:16:47 +0200103void print_cfs_rq(struct seq_file *m, int cpu, struct cfs_rq *cfs_rq)
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200104{
Ingo Molnar86d95602007-10-15 17:00:06 +0200105 s64 MIN_vruntime = -1, min_vruntime, max_vruntime = -1,
106 spread, rq0_min_vruntime, spread0;
Ingo Molnar67e12ea2007-10-15 17:00:05 +0200107 struct rq *rq = &per_cpu(runqueues, cpu);
108 struct sched_entity *last;
109 unsigned long flags;
110
Ingo Molnar5167e752007-08-10 23:05:11 +0200111 SEQ_printf(m, "\ncfs_rq\n");
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200112
Ingo Molnaref83a572007-10-15 17:00:08 +0200113 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "exec_clock",
114 SPLIT_NS(cfs_rq->exec_clock));
Ingo Molnar67e12ea2007-10-15 17:00:05 +0200115
116 spin_lock_irqsave(&rq->lock, flags);
117 if (cfs_rq->rb_leftmost)
118 MIN_vruntime = (__pick_next_entity(cfs_rq))->vruntime;
119 last = __pick_last_entity(cfs_rq);
120 if (last)
121 max_vruntime = last->vruntime;
Ingo Molnar86d95602007-10-15 17:00:06 +0200122 min_vruntime = rq->cfs.min_vruntime;
123 rq0_min_vruntime = per_cpu(runqueues, 0).cfs.min_vruntime;
Ingo Molnar67e12ea2007-10-15 17:00:05 +0200124 spin_unlock_irqrestore(&rq->lock, flags);
Ingo Molnaref83a572007-10-15 17:00:08 +0200125 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "MIN_vruntime",
126 SPLIT_NS(MIN_vruntime));
127 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "min_vruntime",
128 SPLIT_NS(min_vruntime));
129 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "max_vruntime",
130 SPLIT_NS(max_vruntime));
Ingo Molnar67e12ea2007-10-15 17:00:05 +0200131 spread = max_vruntime - MIN_vruntime;
Ingo Molnaref83a572007-10-15 17:00:08 +0200132 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "spread",
133 SPLIT_NS(spread));
Ingo Molnar86d95602007-10-15 17:00:06 +0200134 spread0 = min_vruntime - rq0_min_vruntime;
Ingo Molnaref83a572007-10-15 17:00:08 +0200135 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", "spread0",
136 SPLIT_NS(spread0));
Srivatsa Vaddagiri545f3b12007-10-15 17:00:09 +0200137 SEQ_printf(m, " .%-30s: %ld\n", "nr_running", cfs_rq->nr_running);
138 SEQ_printf(m, " .%-30s: %ld\n", "load", cfs_rq->load.weight);
S.Caglar Onurfdd71d12007-10-15 17:00:10 +0200139#ifdef CONFIG_SCHEDSTATS
Ingo Molnar2d723762007-10-15 17:00:12 +0200140 SEQ_printf(m, " .%-30s: %ld\n", "bkl_count",
141 rq->bkl_count);
S.Caglar Onurfdd71d12007-10-15 17:00:10 +0200142#endif
Peter Zijlstraddc97292007-10-15 17:00:10 +0200143 SEQ_printf(m, " .%-30s: %ld\n", "nr_spread_over",
144 cfs_rq->nr_spread_over);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200145}
146
Ingo Molnara48da482007-08-09 11:16:51 +0200147static void print_cpu(struct seq_file *m, int cpu)
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200148{
149 struct rq *rq = &per_cpu(runqueues, cpu);
150
151#ifdef CONFIG_X86
152 {
153 unsigned int freq = cpu_khz ? : 1;
154
155 SEQ_printf(m, "\ncpu#%d, %u.%03u MHz\n",
156 cpu, freq / 1000, (freq % 1000));
157 }
158#else
159 SEQ_printf(m, "\ncpu#%d\n", cpu);
160#endif
161
162#define P(x) \
163 SEQ_printf(m, " .%-30s: %Ld\n", #x, (long long)(rq->x))
Ingo Molnaref83a572007-10-15 17:00:08 +0200164#define PN(x) \
165 SEQ_printf(m, " .%-30s: %Ld.%06ld\n", #x, SPLIT_NS(rq->x))
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200166
167 P(nr_running);
168 SEQ_printf(m, " .%-30s: %lu\n", "load",
Dmitry Adamushko495eca42007-10-15 17:00:06 +0200169 rq->load.weight);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200170 P(nr_switches);
171 P(nr_load_updates);
172 P(nr_uninterruptible);
173 SEQ_printf(m, " .%-30s: %lu\n", "jiffies", jiffies);
Ingo Molnaref83a572007-10-15 17:00:08 +0200174 PN(next_balance);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200175 P(curr->pid);
Ingo Molnaref83a572007-10-15 17:00:08 +0200176 PN(clock);
177 PN(idle_clock);
178 PN(prev_clock_raw);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200179 P(clock_warps);
180 P(clock_overflows);
Ingo Molnar2aa44d02007-08-23 15:18:02 +0200181 P(clock_deep_idle_events);
Ingo Molnaref83a572007-10-15 17:00:08 +0200182 PN(clock_max_delta);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200183 P(cpu_load[0]);
184 P(cpu_load[1]);
185 P(cpu_load[2]);
186 P(cpu_load[3]);
187 P(cpu_load[4]);
188#undef P
Ingo Molnaref83a572007-10-15 17:00:08 +0200189#undef PN
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200190
Ingo Molnar5cef9ec2007-08-09 11:16:47 +0200191 print_cfs_stats(m, cpu);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200192
Ingo Molnara48da482007-08-09 11:16:51 +0200193 print_rq(m, rq, cpu);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200194}
195
196static int sched_debug_show(struct seq_file *m, void *v)
197{
198 u64 now = ktime_to_ns(ktime_get());
199 int cpu;
200
Ingo Molnar2d92f222007-10-15 17:00:18 +0200201 SEQ_printf(m, "Sched Debug Version: v0.06-v22, %s %.*s\n",
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200202 init_utsname()->release,
203 (int)strcspn(init_utsname()->version, " "),
204 init_utsname()->version);
205
Ingo Molnaref83a572007-10-15 17:00:08 +0200206 SEQ_printf(m, "now at %Lu.%06ld msecs\n", SPLIT_NS(now));
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200207
Ingo Molnar1aa47312007-10-15 17:00:10 +0200208#define P(x) \
Ingo Molnard822cec2007-10-15 17:00:10 +0200209 SEQ_printf(m, " .%-40s: %Ld\n", #x, (long long)(x))
Ingo Molnar1aa47312007-10-15 17:00:10 +0200210#define PN(x) \
Ingo Molnard822cec2007-10-15 17:00:10 +0200211 SEQ_printf(m, " .%-40s: %Ld.%06ld\n", #x, SPLIT_NS(x))
Ingo Molnar1aa47312007-10-15 17:00:10 +0200212 PN(sysctl_sched_latency);
Peter Zijlstra5f6d858e2007-10-15 17:00:12 +0200213 PN(sysctl_sched_nr_latency);
Ingo Molnar1aa47312007-10-15 17:00:10 +0200214 PN(sysctl_sched_wakeup_granularity);
215 PN(sysctl_sched_batch_wakeup_granularity);
216 PN(sysctl_sched_child_runs_first);
217 P(sysctl_sched_features);
218#undef PN
219#undef P
220
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200221 for_each_online_cpu(cpu)
Ingo Molnara48da482007-08-09 11:16:51 +0200222 print_cpu(m, cpu);
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200223
224 SEQ_printf(m, "\n");
225
226 return 0;
227}
228
Josh Triplettf33734612007-07-26 13:40:43 +0200229static void sysrq_sched_debug_show(void)
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200230{
231 sched_debug_show(NULL, NULL);
232}
233
234static int sched_debug_open(struct inode *inode, struct file *filp)
235{
236 return single_open(filp, sched_debug_show, NULL);
237}
238
Arjan van de Ven0dbee3a2007-10-15 17:00:19 +0200239static const struct file_operations sched_debug_fops = {
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200240 .open = sched_debug_open,
241 .read = seq_read,
242 .llseek = seq_lseek,
Alexey Dobriyan5ea473a2007-07-31 00:38:50 -0700243 .release = single_release,
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200244};
245
246static int __init init_sched_debug_procfs(void)
247{
248 struct proc_dir_entry *pe;
249
250 pe = create_proc_entry("sched_debug", 0644, NULL);
251 if (!pe)
252 return -ENOMEM;
253
254 pe->proc_fops = &sched_debug_fops;
255
256 return 0;
257}
258
259__initcall(init_sched_debug_procfs);
260
261void proc_sched_show_task(struct task_struct *p, struct seq_file *m)
262{
Ingo Molnarcc367732007-10-15 17:00:18 +0200263 unsigned long nr_switches;
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200264 unsigned long flags;
265 int num_threads = 1;
266
267 rcu_read_lock();
268 if (lock_task_sighand(p, &flags)) {
269 num_threads = atomic_read(&p->signal->count);
270 unlock_task_sighand(p, &flags);
271 }
272 rcu_read_unlock();
273
274 SEQ_printf(m, "%s (%d, #threads: %d)\n", p->comm, p->pid, num_threads);
Ingo Molnar2d92f222007-10-15 17:00:18 +0200275 SEQ_printf(m,
276 "---------------------------------------------------------\n");
Ingo Molnarcc367732007-10-15 17:00:18 +0200277#define __P(F) \
278 SEQ_printf(m, "%-35s:%21Ld\n", #F, (long long)F)
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200279#define P(F) \
Ingo Molnar2d92f222007-10-15 17:00:18 +0200280 SEQ_printf(m, "%-35s:%21Ld\n", #F, (long long)p->F)
Ingo Molnarcc367732007-10-15 17:00:18 +0200281#define __PN(F) \
282 SEQ_printf(m, "%-35s:%14Ld.%06ld\n", #F, SPLIT_NS((long long)F))
Ingo Molnaref83a572007-10-15 17:00:08 +0200283#define PN(F) \
Ingo Molnar2d92f222007-10-15 17:00:18 +0200284 SEQ_printf(m, "%-35s:%14Ld.%06ld\n", #F, SPLIT_NS((long long)p->F))
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200285
Ingo Molnaref83a572007-10-15 17:00:08 +0200286 PN(se.exec_start);
287 PN(se.vruntime);
288 PN(se.sum_exec_runtime);
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200289
Ingo Molnarcc367732007-10-15 17:00:18 +0200290 nr_switches = p->nvcsw + p->nivcsw;
291
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200292#ifdef CONFIG_SCHEDSTATS
Ingo Molnaref83a572007-10-15 17:00:08 +0200293 PN(se.wait_start);
294 PN(se.sleep_start);
295 PN(se.block_start);
296 PN(se.sleep_max);
297 PN(se.block_max);
298 PN(se.exec_max);
299 PN(se.slice_max);
300 PN(se.wait_max);
Ingo Molnar2d723762007-10-15 17:00:12 +0200301 P(sched_info.bkl_count);
Ingo Molnarcc367732007-10-15 17:00:18 +0200302 P(se.nr_migrations);
303 P(se.nr_migrations_cold);
304 P(se.nr_failed_migrations_affine);
305 P(se.nr_failed_migrations_running);
306 P(se.nr_failed_migrations_hot);
307 P(se.nr_forced_migrations);
308 P(se.nr_forced2_migrations);
309 P(se.nr_wakeups);
310 P(se.nr_wakeups_sync);
311 P(se.nr_wakeups_migrate);
312 P(se.nr_wakeups_local);
313 P(se.nr_wakeups_remote);
314 P(se.nr_wakeups_affine);
315 P(se.nr_wakeups_affine_attempts);
316 P(se.nr_wakeups_passive);
317 P(se.nr_wakeups_idle);
318
319 {
320 u64 avg_atom, avg_per_cpu;
321
322 avg_atom = p->se.sum_exec_runtime;
323 if (nr_switches)
324 do_div(avg_atom, nr_switches);
325 else
326 avg_atom = -1LL;
327
328 avg_per_cpu = p->se.sum_exec_runtime;
329 if (p->se.nr_migrations)
330 avg_per_cpu = div64_64(avg_per_cpu, p->se.nr_migrations);
331 else
332 avg_per_cpu = -1LL;
333
334 __PN(avg_atom);
335 __PN(avg_per_cpu);
336 }
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200337#endif
Ingo Molnarcc367732007-10-15 17:00:18 +0200338 __P(nr_switches);
Ingo Molnar2d92f222007-10-15 17:00:18 +0200339 SEQ_printf(m, "%-35s:%21Ld\n",
Ingo Molnarcc367732007-10-15 17:00:18 +0200340 "nr_voluntary_switches", (long long)p->nvcsw);
341 SEQ_printf(m, "%-35s:%21Ld\n",
342 "nr_involuntary_switches", (long long)p->nivcsw);
343
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200344 P(se.load.weight);
345 P(policy);
346 P(prio);
Ingo Molnaref83a572007-10-15 17:00:08 +0200347#undef PN
Ingo Molnarcc367732007-10-15 17:00:18 +0200348#undef __PN
349#undef P
350#undef __P
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200351
352 {
353 u64 t0, t1;
354
355 t0 = sched_clock();
356 t1 = sched_clock();
Ingo Molnar2d92f222007-10-15 17:00:18 +0200357 SEQ_printf(m, "%-35s:%21Ld\n",
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200358 "clock-delta", (long long)(t1-t0));
359 }
360}
361
362void proc_sched_set_task(struct task_struct *p)
363{
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200364#ifdef CONFIG_SCHEDSTATS
Ingo Molnarcc367732007-10-15 17:00:18 +0200365 p->se.wait_max = 0;
366 p->se.sleep_max = 0;
367 p->se.sum_sleep_runtime = 0;
368 p->se.block_max = 0;
369 p->se.exec_max = 0;
370 p->se.slice_max = 0;
371 p->se.nr_migrations = 0;
372 p->se.nr_migrations_cold = 0;
373 p->se.nr_failed_migrations_affine = 0;
374 p->se.nr_failed_migrations_running = 0;
375 p->se.nr_failed_migrations_hot = 0;
376 p->se.nr_forced_migrations = 0;
377 p->se.nr_forced2_migrations = 0;
378 p->se.nr_wakeups = 0;
379 p->se.nr_wakeups_sync = 0;
380 p->se.nr_wakeups_migrate = 0;
381 p->se.nr_wakeups_local = 0;
382 p->se.nr_wakeups_remote = 0;
383 p->se.nr_wakeups_affine = 0;
384 p->se.nr_wakeups_affine_attempts = 0;
385 p->se.nr_wakeups_passive = 0;
386 p->se.nr_wakeups_idle = 0;
387 p->sched_info.bkl_count = 0;
Ingo Molnar6cfb0d52007-08-02 17:41:40 +0200388#endif
Ingo Molnarcc367732007-10-15 17:00:18 +0200389 p->se.sum_exec_runtime = 0;
390 p->se.prev_sum_exec_runtime = 0;
391 p->nvcsw = 0;
392 p->nivcsw = 0;
Ingo Molnar43ae34c2007-07-09 18:52:00 +0200393}