preemption latency trace v1.1.4 on 2.6.12-RT-V0.7.50-11-up-debug -------------------------------------------------------------------- latency: 231 us, #32/32, CPU#0 | (M:rt VP:0, KP:1, SP:1 HP:1 #P:1) ----------------- | task: softirq-timer/0-3 (uid:0 nice:-10 policy:0 rt_prio:0) ----------------- _------=> CPU# / _-----=> irqs-off | / _----=> need-resched || / _---=> hardirq/softirq ||| / _--=> preempt-depth |||| / ||||| delay cmd pid ||||| time | caller \ / ||||| \ | / tee-10092 0Dnh3 0us!: <00656574> (<6f000000>) tee-10092 0Dnh3 222us : __trace_start_sched_wakeup (try_to_wake_up) tee-10092 0Dnh3 222us : __trace_start_sched_wakeup <<...>-3> (69 0) tee-10092 0Dnh2 222us : try_to_wake_up <<...>-3> (69 73) tee-10092 0Dnh1 222us : preempt_schedule (try_to_wake_up) tee-10092 0Dnh1 222us : wake_up_process (trigger_softirqs) tee-10092 0Dnh. 223us : preempt_schedule_irq (need_resched) tee-10092 0Dnh. 223us : __schedule (preempt_schedule_irq) tee-10092 0Dnh. 223us : profile_hit (__schedule) tee-10092 0Dnh1 224us : sched_clock (__schedule) tee-10092 0Dnh2 224us : dequeue_task (__schedule) tee-10092 0Dnh2 224us : recalc_task_prio (__schedule) tee-10092 0Dnh2 224us : effective_prio (recalc_task_prio) tee-10092 0Dnh2 224us : enqueue_task (__schedule) tee-10092 0Dnh2 224us : trace_array (__schedule) tee-10092 0Dnh2 226us : trace_array <<...>-3> (69 6e) tee-10092 0Dnh2 226us : trace_array (73 78) tee-10092 0Dnh2 226us : trace_array <<...>-4794> (73 78) tee-10092 0Dnh2 226us : trace_array <<...>-8283> (73 78) tee-10092 0Dnh2 227us : trace_array <<...>-4659> (74 78) tee-10092 0Dnh2 227us : trace_array <<...>-10089> (7b 78) tee-10092 0Dnh2 227us : trace_array <<...>-3592> (7d 82) tee-10092 0Dnh2 227us : trace_array <<...>-3588> (7d 82) tee-10092 0Dnh2 228us : trace_array <<...>-3586> (7d 82) tee-10092 0Dnh2 228us : trace_array <<...>-3587> (7d 82) tee-10092 0Dnh2 228us : trace_array (__schedule) <...>-3 0Dnh2 230us : __switch_to (__schedule) <...>-3 0Dnh2 230us : __schedule (73 69) <...>-3 0Dnh1 230us : trace_stop_sched_switched (__schedule) <...>-3 0Dnh2 231us : trace_stop_sched_switched <<...>-3> (69 0) <...>-3 0Dnh1 231us : trace_stop_sched_switched (__schedule) vim:ft=help