# tracer: wakeup
#
wakeup latency trace v1.1.5 on 2.6.27-rc6skw-dirty
--------------------------------------------------------------------
 latency: 91 us, #152/152, CPU#0 | (M:preempt VP:0, KP:0, SP:0 HP:0)
    -----------------
    | task: speaker-test-5719 (uid:1000 nice:0 policy:2 rt_prio:5)
    -----------------

#                _------=> CPU#            
#               / _-----=> irqs-off        
#              | / _----=> need-resched    
#              || / _---=> hardirq/softirq 
#              ||| / _--=> preempt-depth   
#              |||| /                      
#              |||||     delay             
#  cmd     pid ||||| time  |   caller      
#     \   /    |||||   \   |   /           
  <idle>-0     0d.h6    0us : try_to_wake_up (default_wake_function)
  <idle>-0     0.Nh2    2us+: kill_fasync (snd_pcm_period_elapsed)
  <idle>-0     0.Nh2    3us+: i915_driver_irq_handler (handle_IRQ_event)
  <idle>-0     0.Nh2    7us : drm_vbl_send_signals (i915_driver_irq_handler)
  <idle>-0     0dNh2    7us : note_interrupt (handle_fasteoi_irq)
  <idle>-0     0dNh3    8us : ack_ioapic_quirk_irq (handle_fasteoi_irq)
  <idle>-0     0dNh2    9us : irq_exit (do_IRQ)
  <idle>-0     0dN.2    9us : do_IRQ (common_interrupt)
  <idle>-0     0dN.2   10us : irq_enter (do_IRQ)
  <idle>-0     0dN.2   10us : tick_nohz_stop_idle (irq_enter)
  <idle>-0     0dNh2   10us : tick_nohz_update_jiffies (irq_enter)
  <idle>-0     0dNh2   11us : ktime_get (tick_nohz_update_jiffies)
  <idle>-0     0dNh2   11us : ktime_get_ts (ktime_get)
  <idle>-0     0dNh2   12us : getnstimeofday (ktime_get_ts)
  <idle>-0     0dNh2   12us : read_hpet (getnstimeofday)
  <idle>-0     0dNh2   12us : hpet_readl (read_hpet)
  <idle>-0     0dNh2   13us : set_normalized_timespec (ktime_get_ts)
  <idle>-0     0dNh2   14us : tick_do_update_jiffies64 (tick_nohz_update_jiffies)
  <idle>-0     0dNh2   14us : handle_edge_irq (do_IRQ)
  <idle>-0     0dNh3   14us : ack_ioapic_irq (handle_edge_irq)
  <idle>-0     0dNh2   15us : handle_IRQ_event (handle_edge_irq)
  <idle>-0     0.Nh2   15us+: i8042_interrupt (handle_IRQ_event)
  <idle>-0     0.Nh2   19us : serio_interrupt (i8042_interrupt)
  <idle>-0     0dNh3   20us : psmouse_interrupt (serio_interrupt)
  <idle>-0     0dNh3   20us : psmouse_handle_byte (psmouse_interrupt)
  <idle>-0     0dNh3   20us : psmouse_process_byte (psmouse_handle_byte)
  <idle>-0     0dNh3   21us : input_event (psmouse_process_byte)
  <idle>-0     0dNh4   22us : add_input_randomness (input_event)
  <idle>-0     0dNh4   22us : input_handle_event (input_event)
  <idle>-0     0dNh3   23us : input_event (psmouse_process_byte)
  <idle>-0     0dNh4   24us : add_input_randomness (input_event)
  <idle>-0     0dNh4   24us : input_handle_event (input_event)
  <idle>-0     0dNh3   25us : input_event (psmouse_process_byte)
  <idle>-0     0dNh4   25us : add_input_randomness (input_event)
  <idle>-0     0dNh4   25us : input_handle_event (input_event)
  <idle>-0     0dNh3   26us : input_event (psmouse_process_byte)
  <idle>-0     0dNh4   26us : add_input_randomness (input_event)
  <idle>-0     0dNh4   26us : input_handle_event (input_event)
  <idle>-0     0dNh3   27us : input_event (psmouse_process_byte)
  <idle>-0     0dNh4   27us : add_input_randomness (input_event)
  <idle>-0     0dNh4   28us : add_timer_randomness (add_input_randomness)
  <idle>-0     0dNh5   28us : mix_pool_bytes (add_timer_randomness)
  <idle>-0     0dNh5   29us+: mix_pool_bytes_extract (mix_pool_bytes)
  <idle>-0     0dNh5   31us : credit_entropy_bits (add_timer_randomness)
  <idle>-0     0dNh6   31us : kill_fasync (credit_entropy_bits)
  <idle>-0     0dNh4   32us : input_handle_event (input_event)
  <idle>-0     0dNh4   32us : input_pass_event (input_handle_event)
  <idle>-0     0dNh5   34us : mousedev_event (input_pass_event)
  <idle>-0     0dNh3   35us : input_event (psmouse_process_byte)
  <idle>-0     0dNh4   35us : add_input_randomness (input_event)
  <idle>-0     0dNh4   35us : add_timer_randomness (add_input_randomness)
  <idle>-0     0dNh5   36us : mix_pool_bytes (add_timer_randomness)
  <idle>-0     0dNh5   36us : mix_pool_bytes_extract (mix_pool_bytes)
  <idle>-0     0dNh5   37us : credit_entropy_bits (add_timer_randomness)
  <idle>-0     0dNh4   38us : input_handle_event (input_event)
  <idle>-0     0dNh4   38us : input_pass_event (input_handle_event)
  <idle>-0     0dNh5   38us : mousedev_event (input_pass_event)
  <idle>-0     0dNh3   39us : input_event (psmouse_process_byte)
  <idle>-0     0dNh4   39us : add_input_randomness (input_event)
  <idle>-0     0dNh4   40us : add_timer_randomness (add_input_randomness)
  <idle>-0     0dNh5   40us : mix_pool_bytes (add_timer_randomness)
  <idle>-0     0dNh5   41us : mix_pool_bytes_extract (mix_pool_bytes)
  <idle>-0     0dNh5   42us : credit_entropy_bits (add_timer_randomness)
  <idle>-0     0dNh4   42us : input_handle_event (input_event)
  <idle>-0     0dNh4   43us : input_pass_event (input_handle_event)
  <idle>-0     0dNh5   43us : mousedev_event (input_pass_event)
  <idle>-0     0dNh5   44us : mousedev_notify_readers (mousedev_event)
  <idle>-0     0dNh5   44us : mousedev_notify_readers (mousedev_event)
  <idle>-0     0dNh6   46us : kill_fasync (mousedev_notify_readers)
  <idle>-0     0dNh7   46us : __kill_fasync (kill_fasync)
  <idle>-0     0dNh7   47us : send_sigio (__kill_fasync)
  <idle>-0     0dNh9   48us : group_send_sig_info (send_sigio)
  <idle>-0     0dNh9   48us : check_kill_permission (group_send_sig_info)
  <idle>-0     0dNh9   49us : lock_task_sighand (group_send_sig_info)
  <idle>-0     0dNha   49us : __group_send_sig_info (group_send_sig_info)
  <idle>-0     0dNha   50us : send_signal (__group_send_sig_info)
  <idle>-0     0dNha   50us : prepare_signal (send_signal)
  <idle>-0     0dNha   51us : sig_handler (prepare_signal)
  <idle>-0     0dNha   52us : sig_handler_ignored (prepare_signal)
  <idle>-0     0dNha   52us : __sigqueue_alloc (send_signal)
  <idle>-0     0dNha   53us : kmem_cache_alloc (__sigqueue_alloc)
  <idle>-0     0dNha   54us : complete_signal (send_signal)
  <idle>-0     0dNha   55us+: signal_wake_up (complete_signal)
  <idle>-0     0dNhb   57us : account_scheduler_latency (enqueue_task_fair)
  <idle>-0     0dNhb   58us+: marker_probe_cb (try_to_wake_up)
  <idle>-0     0dNh2   60us : note_interrupt (handle_edge_irq)
  <idle>-0     0dNh2   61us : irq_exit (do_IRQ)
  <idle>-0     0.N.2   61us : acpi_state_timer_broadcast (acpi_idle_enter_bm)
  <idle>-0     0.N.2   62us : clockevents_notify (acpi_state_timer_broadcast)
  <idle>-0     0.N.3   62us : clockevents_do_notify (clockevents_notify)
  <idle>-0     0.N.3   63us : raw_notifier_call_chain (clockevents_do_notify)
  <idle>-0     0.N.3   63us : __raw_notifier_call_chain (raw_notifier_call_chain)
  <idle>-0     0.N.3   63us : notifier_call_chain (__raw_notifier_call_chain)
  <idle>-0     0.N.3   64us : tick_notify (notifier_call_chain)
  <idle>-0     0.N.3   64us : tick_broadcast_oneshot_control (tick_notify)
  <idle>-0     0dN.4   65us : clockevents_set_mode (tick_broadcast_oneshot_control)
  <idle>-0     0dN.4   65us : lapic_timer_setup (clockevents_set_mode)
  <idle>-0     0dN.4   65us : __setup_APIC_LVTT (lapic_timer_setup)
  <idle>-0     0dN.4   66us : tick_program_event (tick_broadcast_oneshot_control)
  <idle>-0     0dN.4   66us : tick_dev_program_event (tick_program_event)
  <idle>-0     0dN.4   66us : ktime_get (tick_dev_program_event)
  <idle>-0     0dN.4   67us : ktime_get_ts (ktime_get)
  <idle>-0     0dN.4   67us : getnstimeofday (ktime_get_ts)
  <idle>-0     0dN.4   68us : read_hpet (getnstimeofday)
  <idle>-0     0dN.4   68us : hpet_readl (read_hpet)
  <idle>-0     0dN.4   69us : set_normalized_timespec (ktime_get_ts)
  <idle>-0     0dN.4   69us : clockevents_program_event (tick_dev_program_event)
  <idle>-0     0dN.4   70us : lapic_next_event (clockevents_program_event)
  <idle>-0     0.N.2   70us : ticks_elapsed_in_us (acpi_idle_enter_bm)
  <idle>-0     0.N.2   71us : menu_reflect (cpuidle_idle_call)
  <idle>-0     0.N.2   72us : tick_nohz_restart_sched_tick (cpu_idle)
  <idle>-0     0dN.2   72us : tick_nohz_stop_idle (tick_nohz_restart_sched_tick)
  <idle>-0     0dN.2   72us : ktime_get (tick_nohz_restart_sched_tick)
  <idle>-0     0dN.2   73us : ktime_get_ts (ktime_get)
  <idle>-0     0dN.2   73us : getnstimeofday (ktime_get_ts)
  <idle>-0     0dN.2   73us : read_hpet (getnstimeofday)
  <idle>-0     0dN.2   74us : hpet_readl (read_hpet)
  <idle>-0     0dN.2   75us : set_normalized_timespec (ktime_get_ts)
  <idle>-0     0dN.2   75us : tick_do_update_jiffies64 (tick_nohz_restart_sched_tick)
  <idle>-0     0dN.2   76us : hrtimer_cancel (tick_nohz_restart_sched_tick)
  <idle>-0     0dN.2   76us : hrtimer_try_to_cancel (hrtimer_cancel)
  <idle>-0     0dN.3   77us : __remove_hrtimer (hrtimer_try_to_cancel)
  <idle>-0     0dN.3   77us : hrtimer_force_reprogram (__remove_hrtimer)
  <idle>-0     0dN.3   78us : tick_program_event (hrtimer_force_reprogram)
  <idle>-0     0dN.3   78us : tick_dev_program_event (tick_program_event)
  <idle>-0     0dN.3   78us : ktime_get (tick_dev_program_event)
  <idle>-0     0dN.3   79us : ktime_get_ts (ktime_get)
  <idle>-0     0dN.3   79us : getnstimeofday (ktime_get_ts)
  <idle>-0     0dN.3   80us : read_hpet (getnstimeofday)
  <idle>-0     0dN.3   80us : hpet_readl (read_hpet)
  <idle>-0     0dN.3   81us : set_normalized_timespec (ktime_get_ts)
  <idle>-0     0dN.3   81us : clockevents_program_event (tick_dev_program_event)
  <idle>-0     0dN.3   82us : lapic_next_event (clockevents_program_event)
  <idle>-0     0dN.2   82us : hrtimer_forward (tick_nohz_restart_sched_tick)
  <idle>-0     0dN.2   83us : ktime_divns (hrtimer_forward)
  <idle>-0     0dN.2   83us : ktime_add_safe (hrtimer_forward)
  <idle>-0     0dN.2   83us : hrtimer_start (tick_nohz_restart_sched_tick)
  <idle>-0     0dN.3   84us : __timer_stats_hrtimer_set_start_info (hrtimer_start)
  <idle>-0     0dN.3   84us : enqueue_hrtimer (hrtimer_start)
  <idle>-0     0dN.3   85us : hrtimer_reprogram (enqueue_hrtimer)
  <idle>-0     0dN.3   85us : tick_program_event (hrtimer_reprogram)
  <idle>-0     0dN.3   85us : tick_dev_program_event (tick_program_event)
  <idle>-0     0dN.3   86us : ktime_get (tick_dev_program_event)
  <idle>-0     0dN.3   86us : ktime_get_ts (ktime_get)
  <idle>-0     0dN.3   86us : getnstimeofday (ktime_get_ts)
  <idle>-0     0dN.3   87us : read_hpet (getnstimeofday)
  <idle>-0     0dN.3   87us : hpet_readl (read_hpet)
  <idle>-0     0dN.3   88us : set_normalized_timespec (ktime_get_ts)
  <idle>-0     0dN.3   88us : clockevents_program_event (tick_dev_program_event)
  <idle>-0     0dN.3   89us+: lapic_next_event (clockevents_program_event)
  <idle>-0     0d..3   90us : marker_probe_cb (schedule)
  <idle>-0     0d..3   91us : schedule (cpu_idle)