But no cigar... 

Latency at 4491us, trace attached

I've supposedly got SMI disabled, MTRRs are disabled, ACPI processor disabled, 
CPU frequency scaling disabled, MSI and MSI-X disabled. I can't disable USB 
legacy in the BIOS because the option is grayed out (and no other options seem 
to make it work. I'm running through the troubleshooting file to see if there's 
anything else I can try but I can't see anything. 

The BIOS has a ridiculous number of options, I have gone through and disabled 
most of them even though in many cases I'm really not sure what it is that they 
do - I just hope they don't cause anything to melt:

CRID, disabled memory thermal management, 
turned off lots of ACPI and power options - 
C2, C3, S4 wakeup from RTC, Trusted Execution Technology, P-States, Thermal 
Mode, C-States, C-State Pop Up Mode, C-State Pop Down Mode, DeepC4, Hard C4E, 
C6 Enhanced Multi Threaded Thermal Monitoring (EMTTM), Bi-directional PROCHOT, 
Dynamic FSB Switching, Turbo Mode, ACPI 3.0 T-States, CPU Digital Thermal 
Sensor, PCI Clock Run, Storage Break Event, PCIE Break Event, PCI Break Event, 
EHCI Break Event, UHCI Break Event, HDA Break Event, ACPI S3, wake on PME and 
set "ACPI Selection" from Acpi3.0 to Acpi1.0B in the hope it will be better 
supported.

I'm at a bit of a loss. Next I will try to figure out how to read the traces. 
The latency consistently jumps from <20us (normally around 14/15) to just under 
4500us each time I run the test, so I am wondering if it is some specific thing 
that takes this long. I will also try to read the LTP output to see what it's 
doing when it fails, and see if this is consistent.

Gilles, I really appreciate all the help, thank you.

Anyone got any ideas?

On Saturday, 23 October, 2010 5:26pm, [email protected] 
said:

> Oh, and I got the SMI-enabled chipset found and SMI workaround enabled 
> messages
> this time
> 
> On Saturday, 23 October, 2010 5:21pm, [email protected]
> said:
> 
>>>> So I guess I should add
>>>>
>>>> #define PCI_DEVICE_ID_INTEL_ICH9_9        0x2917
>>>
>>> The define exists in include/linux/pci_ids.h as PCI_DEVICE_ID_INTEL_ICH9_1
>>>
>>> Adding it to xenoami/pci_ids.s is only useful if you are using an older
>>> kernel which has not got this define. 2.6.33 here has it.
>>>
>>
>> Okay, I'm using 2.6.32, but it exists here too, don't know how I missed it.
>>
>> Just finished installing kernel.. booting now, ready to dohell ;)
>>
>> Edward
>>
>>
>> _______________________________________________
>> Xenomai-help mailing list
>> [email protected]
>> https://mail.gna.org/listinfo/xenomai-help
>>
> 
> 
> 
> _______________________________________________
> Xenomai-help mailing list
> [email protected]
> https://mail.gna.org/listinfo/xenomai-help
> 
I-pipe frozen back-tracing service on 2.6.32.15-xenomai-2.5.4/ipipe-2.7-01
------------------------------------------------------------
CPU: 0, Freeze: 2866098126420 cycles, Trace Points: 100 (+10)
Calibrated minimum trace-point overhead: 0.131 us

 +----- Hard IRQs ('|': locked)
 |+---- <unused>
 ||+--- <unused>
 |||+-- Xenomai
 ||||+- Linux ('*': domain stalled, '+': current, '#': current+stalled)
 |||||                        +---------- Delay flag ('+': > 1 us, '!': > 10 us)
 |||||                        |        +- NMI noise ('N')
 |||||                        |        |
      Type    User Val.   Time    Delay  Function (Parent)
:    #func               -4498    0.202  __ipipe_unstall_root+0x9 
(__ipipe_restore_root+0xb1)
:|   #begin   0x80000000 -4498    0.247  __ipipe_unstall_root+0x20 
(__ipipe_restore_root+0xb1)
:|   +end     0x80000000 -4498    0.255  __ipipe_unstall_root+0xce 
(__ipipe_restore_root+0xb1)
:    +func               -4497    0.228  security_msg_msg_alloc+0x4 
(load_msg+0xf9)
:    +func               -4497    0.232  cap_msg_msg_alloc_security+0x4 
(security_msg_msg_alloc+0x16)
:    +func               -4497    0.206  ipc_lock_check+0x9 (do_msgsnd+0xa0)
:    +func               -4497    0.195  ipc_lock+0xb (ipc_lock_check+0x15)
:    +func               -4497    0.202  add_preempt_count+0x9 (ipc_lock+0x20)
:    +func               -4496    0.195  ipipe_check_context+0x11 
(add_preempt_count+0x1c)
:|   +begin   0x80000001 -4496    0.266  ipipe_check_context+0x33 
(add_preempt_count+0x1c)
:|   +end     0x80000001 -4496    0.251  ipipe_check_context+0xda 
(add_preempt_count+0x1c)
:    +func               -4496    0.195  _spin_lock+0x9 (ipc_lock+0x49)
:    +func               -4495    0.198  add_preempt_count+0x9 (_spin_lock+0x1b)
:    +func               -4495    0.195  ipipe_check_context+0x11 
(add_preempt_count+0x1c)
:|   +begin   0x80000001 -4495    0.266  ipipe_check_context+0x33 
(add_preempt_count+0x1c)
:|   +end     0x80000001 -4495    0.258  ipipe_check_context+0xda 
(add_preempt_count+0x1c)
:    +func               -4495    0.195  ipcperms+0xb (do_msgsnd+0xe9)
:    +func               -4494    0.191  security_ipc_permission+0x4 
(ipcperms+0xab)
:    +func               -4494    0.195  cap_ipc_permission+0x4 
(security_ipc_permission+0x19)
:    +func               -4494    0.210  security_msg_queue_msgsnd+0x4 
(do_msgsnd+0xff)
:    +func               -4494    0.225  cap_msg_queue_msgsnd+0x4 
(security_msg_queue_msgsnd+0x16)
:    +func               -4494    0.191  ipc_rcu_getref+0x4 (do_msgsnd+0x175)
:    +func               -4493    0.195  _spin_unlock+0x4 (do_msgsnd+0x17d)
:    +func               -4493    0.195  sub_preempt_count+0x9 
(_spin_unlock+0x15)
:    +func               -4493    0.191  ipipe_check_context+0x11 
(sub_preempt_count+0x1c)
:|   +begin   0x80000001 -4493    0.258  ipipe_check_context+0x33 
(sub_preempt_count+0x1c)
:|   +end     0x80000001 -4492    0.214  ipipe_check_context+0xda 
(sub_preempt_count+0x1c)
:    +func               -4492    0.191  sub_preempt_count+0x9 (do_msgsnd+0x187)
:    +func               -4492    0.187  ipipe_check_context+0x11 
(sub_preempt_count+0x1c)
:|   +begin   0x80000001 -4492    0.251  ipipe_check_context+0x33 
(sub_preempt_count+0x1c)
:|   +end     0x80000001 -4492    0.217  ipipe_check_context+0xda 
(sub_preempt_count+0x1c)
:    +func               -4491    0.195  schedule+0x14 (do_msgsnd+0x1a1)
:    +func               -4491    0.191  add_preempt_count+0x9 (schedule+0x64)
:    +func               -4491    0.202  ipipe_check_context+0x11 
(add_preempt_count+0x1c)
:|   +begin   0x80000001 -4491    0.255  ipipe_check_context+0x33 
(add_preempt_count+0x1c)
:|   +end     0x80000001 -4491    0.217  ipipe_check_context+0xda 
(add_preempt_count+0x1c)
:|   +begin   0x80000001 -4490    0.232  debug_smp_processor_id+0x44 
(schedule+0x69)
:|   +end     0x80000001 -4490    0.210  debug_smp_processor_id+0x94 
(schedule+0x69)
:    +func               -4490    0.232  rcu_sched_qs+0x4 (schedule+0x8b)
:    +func               -4490    0.195  ipipe_check_context+0x11 
(schedule+0x124)
:|   +begin   0x80000001 -4490    0.255  ipipe_check_context+0x33 
(schedule+0x124)
:|   +end     0x80000001 -4489    0.210  ipipe_check_context+0xda 
(schedule+0x124)
:    +func               -4489    0.191  _spin_lock_irq+0x9 (schedule+0x195)
:    +func               -4489    0.187  ipipe_check_context+0x11 
(_spin_lock_irq+0x1d)
:|   +begin   0x80000001 -4489    0.251  ipipe_check_context+0x33 
(_spin_lock_irq+0x1d)
:|   +end     0x80000001 -4488    0.236  ipipe_check_context+0xda 
(_spin_lock_irq+0x1d)
:    #func               -4488    0.206  add_preempt_count+0x9 
(_spin_lock_irq+0x3f)
:    #func               -4488    0.199  ipipe_check_context+0x11 
(add_preempt_count+0x1c)
:|   #begin   0x80000001 -4488    0.243  ipipe_check_context+0x33 
(add_preempt_count+0x1c)
:|   #end     0x80000001 -4488! 4468.801  ipipe_check_context+0xda 
(add_preempt_count+0x1c)
:|   #begin   0x000000f6   -19    0.229  common_interrupt+0x20 
(sched_clock_cpu+0x37)
:|   #func                 -18    0.247  __ipipe_handle_irq+0x11 
(common_interrupt+0x27)
:|   #func                 -18    0.206  irq_to_desc+0x4 
(__ipipe_handle_irq+0x134)
:|   #func                 -18    0.202  __ipipe_ack_apic+0x4 
(__ipipe_handle_irq+0x13c)
:|   #func                 -18    0.229  native_apic_mem_write+0x4 
(__ipipe_ack_apic+0x1d)
:|   #func                 -18    0.217  __ipipe_dispatch_wired+0xd 
(__ipipe_handle_irq+0x147)
:|   #func                 -17    0.277  __ipipe_dispatch_wired_nocheck+0x11 
(__ipipe_dispatch_wired+0xba)
:|  #*func                 -17    0.247  xnintr_clock_handler+0xb 
(__ipipe_dispatch_wired_nocheck+0x12b)
:|  #*func                 -17    0.442  xntimer_tick_aperiodic+0xb 
(xnintr_clock_handler+0x81)
:|  #*func                 -16    0.202  xnthread_periodic_handler+0x4 
(xntimer_tick_aperiodic+0x8d)
:|  #*func                 -16    0.217  xnpod_resume_thread+0x11 
(xnthread_periodic_handler+0x2d)
:|  #*[ 3286] samplin 99   -16    0.420  xnpod_resume_thread+0xfa 
(xnthread_periodic_handler+0x2d)
:|  #*func                 -16    0.198  xntimer_next_local_shot+0x9 
(xntimer_tick_aperiodic+0x191)
:|  #*event   t...@32      -15    0.202  xntimer_next_local_shot+0xb0 
(xntimer_tick_aperiodic+0x191)
:|  #*func                 -15    0.251  native_apic_mem_write+0x4 
(xntimer_next_local_shot+0xe5)
:|  #*func                 -15    0.277  __xnpod_schedule+0x11 
(xnintr_clock_handler+0x130)
:|  #*[25914] -<?>-   -1   -15    0.221  __xnpod_schedule+0x189 
(xnintr_clock_handler+0x130)
:|  #*func                 -14    0.416  xnsched_pick_next+0x4 
(__xnpod_schedule+0x1e3)
:|  #*func                 -14    0.521  __phys_addr+0x4 
(__xnpod_schedule+0x562)
:|  #*[ 3286] samplin 99   -13    0.375  __xnpod_schedule+0x834 
(xnpod_suspend_thread+0x281)
:|  #*func                 -13    0.251  xntimer_get_overruns+0x8 
(xnpod_wait_thread_period+0x14c)
:|  #*func                 -13    0.225  __ipipe_restore_pipeline_head+0x7 
(xnpod_wait_thread_period+0x1cb)
:|  +*end     0x80000000   -13    0.517  __ipipe_restore_pipeline_head+0x137 
(xnpod_wait_thread_period+0x1cb)
:|  +*begin   0x00000039   -12    0.243  common_interrupt+0x20 
(__ipipe_restore_pipeline_head+0x139)
:|  +*func                 -12    0.664  __ipipe_handle_irq+0x11 
(common_interrupt+0x27)
:|  +*func                 -11    0.333  __ipipe_set_irq_pending+0xd 
(__ipipe_handle_irq+0x173)
:|  +*func                 -11    0.206  irq_to_desc+0x4 
(__ipipe_handle_irq+0x18b)
:|  +*func                 -11    0.322  __ipipe_ack_fasteoi_irq+0x4 
(__ipipe_handle_irq+0x194)
:|  +*func                 -10    0.285  ack_apic_level+0xd 
(__ipipe_ack_fasteoi_irq+0x10)
:|  +*func                 -10    0.225  native_apic_mem_read+0x4 
(ack_apic_level+0x4d)
:|  +*func                 -10+   2.051  io_apic_modify_irq+0xb 
(ack_apic_level+0xb6)
:|  +*func                  -8+   1.432  io_apic_sync+0x4 
(io_apic_modify_irq+0x9e)
:|  +*func                  -6    0.292  native_apic_mem_write+0x4 
(ack_apic_level+0xd0)
:|  +*end     0x00000039    -6    0.469  common_interrupt+0x39 
(__ipipe_restore_pipeline_head+0x139)
:|  +*begin   0x80000001    -6    0.311  __ipipe_dispatch_event+0x1d9 
(__ipipe_syscall_root+0xcd)
:|  +*end     0x80000001    -5    0.236  __ipipe_dispatch_event+0x3f0 
(__ipipe_syscall_root+0xcd)
:|  +*begin   0x80000001    -5+   1.593  __ipipe_syscall_root+0xec 
(__ipipe_syscall_root_thunk+0x35)
:   +*func                  -3    0.225  __ipipe_syscall_root+0x11 
(__ipipe_syscall_root_thunk+0x35)
:   +*func                  -3    0.191  __ipipe_dispatch_event+0x11 
(__ipipe_syscall_root+0xcd)
:|  +*begin   0x80000001    -3    0.270  __ipipe_dispatch_event+0x34 
(__ipipe_syscall_root+0xcd)
:|  +*end     0x80000001    -3    0.217  __ipipe_dispatch_event+0x1a6 
(__ipipe_syscall_root+0xcd)
:   +*func                  -3    0.562  hisyscall_event+0x11 
(__ipipe_dispatch_event+0x1b7)
:   +*func                  -2    0.453  xnshadow_sys_trace+0x7 
(hisyscall_event+0x151)
:   +*func                  -2    0.334  ipipe_trace_frozen_reset+0xb 
(xnshadow_sys_trace+0x69)
:   +*func                  -1    0.202  __ipipe_global_path_lock+0x4 
(ipipe_trace_frozen_reset+0x1c)
:   +*func                  -1    0.198  __ipipe_spin_lock_irqsave+0xb 
(__ipipe_global_path_lock+0x15)
:|  +*begin   0x80000001    -1    0.784  __ipipe_spin_lock_irqsave+0x2a 
(__ipipe_global_path_lock+0x15)
:|  #*func                   0    0.262  __ipipe_spin_unlock_irqcomplete+0xb 
(__ipipe_global_path_unlock+0x7d)
:|  +*end     0x80000001     0    0.251  __ipipe_spin_unlock_irqcomplete+0xcf 
(__ipipe_global_path_unlock+0x7d)
<   +*freeze  0x004412b3     0    0.225  xnshadow_sys_trace+0x73 
(hisyscall_event+0x151)
 |  +*begin   0x80000001     0    0.262  __ipipe_dispatch_event+0x1d9 
(__ipipe_syscall_root+0xcd)
 |  +*end     0x80000001     0    0.225  __ipipe_dispatch_event+0x3f0 
(__ipipe_syscall_root+0xcd)
 |  +*begin   0x80000001     0    0.390  __ipipe_syscall_root+0xec 
(__ipipe_syscall_root_thunk+0x35)
    +*func                   1    0.225  __ipipe_syscall_root+0x11 
(__ipipe_syscall_root_thunk+0x35)
    +*func                   1    0.199  __ipipe_dispatch_event+0x11 
(__ipipe_syscall_root+0xcd)
 |  +*begin   0x80000001     1    0.277  __ipipe_dispatch_event+0x34 
(__ipipe_syscall_root+0xcd)
 |  +*end     0x80000001     1    0.206  __ipipe_dispatch_event+0x1a6 
(__ipipe_syscall_root+0xcd)
    +*func                   2    0.225  hisyscall_event+0x11 
(__ipipe_dispatch_event+0x1b7)
    +*func                   2    0.195  __rt_task_wait_period+0xb 
(hisyscall_event+0x151)
    +*func                   2    0.000  rt_task_wait_period+0x4 
(__rt_task_wait_period+0x1c)
I-pipe frozen back-tracing service on 2.6.32.15-xenomai-2.5.4/ipipe-2.7-01
------------------------------------------------------------
CPU: 0, Freeze: 3030879662150 cycles, Trace Points: 100 (+10)
Calibrated minimum trace-point overhead: 0.131 us

 +----- Hard IRQs ('|': locked)
 |+---- <unused>
 ||+--- <unused>
 |||+-- Xenomai
 ||||+- Linux ('*': domain stalled, '+': current, '#': current+stalled)
 |||||                        +---------- Delay flag ('+': > 1 us, '!': > 10 us)
 |||||                        |        +- NMI noise ('N')
 |||||                        |        |
      Type    User Val.   Time    Delay  Function (Parent)
:|   +end     0x80000001 -4519    0.206  debug_smp_processor_id+0x94 
(try_to_wake_up+0x3d)
:    +func               -4519    0.202  task_rq_lock+0xb (try_to_wake_up+0x49)
:    +func               -4518    0.199  ipipe_check_context+0x11 
(task_rq_lock+0x29)
:|   +begin   0x80000001 -4518    0.247  ipipe_check_context+0x33 
(task_rq_lock+0x29)
:|   +end     0x80000001 -4518    0.240  ipipe_check_context+0xda 
(task_rq_lock+0x29)
:    #func               -4518    0.206  _spin_lock+0x9 (task_rq_lock+0x6c)
:    #func               -4518    0.199  add_preempt_count+0x9 (_spin_lock+0x1b)
:    #func               -4517    0.198  ipipe_check_context+0x11 
(add_preempt_count+0x1c)
:|   #begin   0x80000001 -4517    0.251  ipipe_check_context+0x33 
(add_preempt_count+0x1c)
:|   #end     0x80000001 -4517    0.258  ipipe_check_context+0xda 
(add_preempt_count+0x1c)
:|   #begin   0x80000001 -4517    0.225  debug_smp_processor_id+0x44 
(sched_clock_cpu+0x92)
:|   #end     0x80000001 -4516    0.225  debug_smp_processor_id+0x94 
(sched_clock_cpu+0x92)
:|   #begin   0x80000001 -4516    0.225  debug_smp_processor_id+0x44 
(native_sched_clock+0x37)
:|   #end     0x80000001 -4516    0.236  debug_smp_processor_id+0x94 
(native_sched_clock+0x37)
:    #func               -4516    0.206  _spin_unlock_irqrestore+0x4 
(try_to_wake_up+0xc3)
:    #func               -4516    0.195  __ipipe_restore_root+0xb 
(_spin_unlock_irqrestore+0x21)
:|   #begin   0x80000001 -4515    0.225  __ipipe_restore_root+0x2d 
(_spin_unlock_irqrestore+0x21)
:|   #end     0x80000001 -4515    0.232  __ipipe_restore_root+0x7d 
(_spin_unlock_irqrestore+0x21)
:    #func               -4515    0.199  __ipipe_unstall_root+0x9 
(__ipipe_restore_root+0xb1)
:|   #begin   0x80000000 -4515    0.255  __ipipe_unstall_root+0x20 
(__ipipe_restore_root+0xb1)
:|   +end     0x80000000 -4514    0.202  __ipipe_unstall_root+0xce 
(__ipipe_restore_root+0xb1)
:    +func               -4514    0.210  sub_preempt_count+0x9 
(_spin_unlock_irqrestore+0x2b)
:    +func               -4514    0.198  ipipe_check_context+0x11 
(sub_preempt_count+0x1c)
:|   +begin   0x80000001 -4514    0.255  ipipe_check_context+0x33 
(sub_preempt_count+0x1c)
:|   +end     0x80000001 -4514    0.217  ipipe_check_context+0xda 
(sub_preempt_count+0x1c)
:    +func               -4513    0.232  select_task_rq_fair+0x14 
(try_to_wake_up+0xd5)
:|   +begin   0x80000001 -4513    0.229  debug_smp_processor_id+0x44 
(select_task_rq_fair+0x31)
:|   +end     0x80000001 -4513    0.236  debug_smp_processor_id+0x94 
(select_task_rq_fair+0x31)
:    +func               -4513    0.191  add_preempt_count+0x9 
(select_task_rq_fair+0xba)
:    +func               -4512    0.206  ipipe_check_context+0x11 
(add_preempt_count+0x1c)
:|   +begin   0x80000001 -4512    0.251  ipipe_check_context+0x33 
(add_preempt_count+0x1c)
:|   +end     0x80000001 -4512    0.315  ipipe_check_context+0xda 
(add_preempt_count+0x1c)
:    +func               -4512    0.206  update_shares+0x9 
(select_task_rq_fair+0x34d)
:|   +begin   0x80000001 -4512    0.232  debug_smp_processor_id+0x44 
(select_task_rq_fair+0x39c)
:|   +end     0x80000001 -4511    0.225  debug_smp_processor_id+0x94 
(select_task_rq_fair+0x39c)
:    +func               -4511    0.202  effective_load+0x4 
(select_task_rq_fair+0x528)
:    +func               -4511    0.236  effective_load+0x4 
(select_task_rq_fair+0x53c)
:    +func               -4511    0.198  sub_preempt_count+0x9 
(select_task_rq_fair+0x8bf)
:    +func               -4510    0.191  ipipe_check_context+0x11 
(sub_preempt_count+0x1c)
:|   +begin   0x80000001 -4510    0.255  ipipe_check_context+0x33 
(sub_preempt_count+0x1c)
:|   +end     0x80000001 -4510    0.225  ipipe_check_context+0xda 
(sub_preempt_count+0x1c)
:    +func               -4510    0.191  task_rq_lock+0xb (try_to_wake_up+0xef)
:    +func               -4510    0.187  ipipe_check_context+0x11 
(task_rq_lock+0x29)
:|   +begin   0x80000001 -4509    0.251  ipipe_check_context+0x33 
(task_rq_lock+0x29)
:|   +end     0x80000001 -4509    0.232  ipipe_check_context+0xda 
(task_rq_lock+0x29)
:    #func               -4509    0.206  _spin_lock+0x9 (task_rq_lock+0x6c)
:    #func               -4509    0.199  add_preempt_count+0x9 (_spin_lock+0x1b)
:    #func               -4508    0.202  ipipe_check_context+0x11 
(add_preempt_count+0x1c)
:|   #begin   0x80000001 -4508    0.251  ipipe_check_context+0x33 
(add_preempt_count+0x1c)
:|   #end     0x80000001 -4508! 4488.026  ipipe_check_context+0xda 
(add_preempt_count+0x1c)
:|   #begin   0x000000f6   -20    0.236  common_interrupt+0x20 
(task_rq_lock+0x73)
:|   #func                 -20    0.247  __ipipe_handle_irq+0x11 
(common_interrupt+0x27)
:|   #func                 -20    0.214  irq_to_desc+0x4 
(__ipipe_handle_irq+0x134)
:|   #func                 -19    0.187  __ipipe_ack_apic+0x4 
(__ipipe_handle_irq+0x13c)
:|   #func                 -19    0.225  native_apic_mem_write+0x4 
(__ipipe_ack_apic+0x1d)
:|   #func                 -19    0.221  __ipipe_dispatch_wired+0xd 
(__ipipe_handle_irq+0x147)
:|   #func                 -19    0.274  __ipipe_dispatch_wired_nocheck+0x11 
(__ipipe_dispatch_wired+0xba)
:|  #*func                 -18    0.251  xnintr_clock_handler+0xb 
(__ipipe_dispatch_wired_nocheck+0x12b)
:|  #*func                 -18    0.574  xntimer_tick_aperiodic+0xb 
(xnintr_clock_handler+0x81)
:|  #*func                 -18    0.191  xnthread_periodic_handler+0x4 
(xntimer_tick_aperiodic+0x8d)
:|  #*func                 -17    0.217  xnpod_resume_thread+0x11 
(xnthread_periodic_handler+0x2d)
:|  #*[ 3274] -<?>-   99   -17    0.457  xnpod_resume_thread+0xfa 
(xnthread_periodic_handler+0x2d)
:|  #*func                 -17    0.199  xntimer_next_local_shot+0x9 
(xntimer_tick_aperiodic+0x191)
:|  #*event   t...@2       -16    0.202  xntimer_next_local_shot+0xb0 
(xntimer_tick_aperiodic+0x191)
:|  #*func                 -16    0.247  native_apic_mem_write+0x4 
(xntimer_next_local_shot+0xe5)
:|  #*func                 -16    0.270  __xnpod_schedule+0x11 
(xnintr_clock_handler+0x130)
:|  #*[25498] -<?>-   -1   -16    0.221  __xnpod_schedule+0x189 
(xnintr_clock_handler+0x130)
:|  #*func                 -16    0.412  xnsched_pick_next+0x4 
(__xnpod_schedule+0x1e3)
:|  #*func                 -15    0.514  __phys_addr+0x4 
(__xnpod_schedule+0x562)
:|  #*[ 3274] -<?>-   99   -15    0.367  __xnpod_schedule+0x834 
(xnpod_suspend_thread+0x281)
:|  #*func                 -14    0.247  xntimer_get_overruns+0x8 
(xnpod_wait_thread_period+0x14c)
:|  #*func                 -14    0.225  __ipipe_restore_pipeline_head+0x7 
(xnpod_wait_thread_period+0x1cb)
:|  +*end     0x80000000   -14    0.585  __ipipe_restore_pipeline_head+0x137 
(xnpod_wait_thread_period+0x1cb)
:|  +*begin   0x00000039   -13    0.247  common_interrupt+0x20 
(__ipipe_restore_pipeline_head+0x139)
:|  +*func                 -13    0.686  __ipipe_handle_irq+0x11 
(common_interrupt+0x27)
:|  +*func                 -12    0.337  __ipipe_set_irq_pending+0xd 
(__ipipe_handle_irq+0x173)
:|  +*func                 -12    0.450  irq_to_desc+0x4 
(__ipipe_handle_irq+0x18b)
:|  +*func                 -11    0.517  __ipipe_ack_fasteoi_irq+0x4 
(__ipipe_handle_irq+0x194)
:|  +*func                 -11    0.364  ack_apic_level+0xd 
(__ipipe_ack_fasteoi_irq+0x10)
:|  +*func                 -11    0.412  native_apic_mem_read+0x4 
(ack_apic_level+0x4d)
:|  +*func                 -10+   2.198  io_apic_modify_irq+0xb 
(ack_apic_level+0xb6)
:|  +*func                  -8+   1.440  io_apic_sync+0x4 
(io_apic_modify_irq+0x9e)
:|  +*func                  -7    0.288  native_apic_mem_write+0x4 
(ack_apic_level+0xd0)
:|  +*end     0x00000039    -6    0.465  common_interrupt+0x39 
(__ipipe_restore_pipeline_head+0x139)
:|  +*begin   0x80000001    -6    0.277  __ipipe_dispatch_event+0x1d9 
(__ipipe_syscall_root+0xcd)
:|  +*end     0x80000001    -6    0.210  __ipipe_dispatch_event+0x3f0 
(__ipipe_syscall_root+0xcd)
:|  +*begin   0x80000001    -5+   1.774  __ipipe_syscall_root+0xec 
(__ipipe_syscall_root_thunk+0x35)
:   +*func                  -4    0.217  __ipipe_syscall_root+0x11 
(__ipipe_syscall_root_thunk+0x35)
:   +*func                  -3    0.195  __ipipe_dispatch_event+0x11 
(__ipipe_syscall_root+0xcd)
:|  +*begin   0x80000001    -3    0.270  __ipipe_dispatch_event+0x34 
(__ipipe_syscall_root+0xcd)
:|  +*end     0x80000001    -3    0.213  __ipipe_dispatch_event+0x1a6 
(__ipipe_syscall_root+0xcd)
:   +*func                  -3    0.544  hisyscall_event+0x11 
(__ipipe_dispatch_event+0x1b7)
:   +*func                  -2    0.442  xnshadow_sys_trace+0x7 
(hisyscall_event+0x151)
:   +*func                  -2    0.318  ipipe_trace_frozen_reset+0xb 
(xnshadow_sys_trace+0x69)
:   +*func                  -1    0.199  __ipipe_global_path_lock+0x4 
(ipipe_trace_frozen_reset+0x1c)
:   +*func                  -1    0.206  __ipipe_spin_lock_irqsave+0xb 
(__ipipe_global_path_lock+0x15)
:|  +*begin   0x80000001    -1    0.889  __ipipe_spin_lock_irqsave+0x2a 
(__ipipe_global_path_lock+0x15)
:|  #*func                   0    0.281  __ipipe_spin_unlock_irqcomplete+0xb 
(__ipipe_global_path_unlock+0x7d)
:|  +*end     0x80000001     0    0.251  __ipipe_spin_unlock_irqcomplete+0xcf 
(__ipipe_global_path_unlock+0x7d)
<   +*freeze  0x004488c6     0    0.236  xnshadow_sys_trace+0x73 
(hisyscall_event+0x151)
 |  +*begin   0x80000001     0    0.266  __ipipe_dispatch_event+0x1d9 
(__ipipe_syscall_root+0xcd)
 |  +*end     0x80000001     0    0.225  __ipipe_dispatch_event+0x3f0 
(__ipipe_syscall_root+0xcd)
 |  +*begin   0x80000001     0    0.386  __ipipe_syscall_root+0xec 
(__ipipe_syscall_root_thunk+0x35)
    +*func                   1    0.251  __ipipe_syscall_root+0x11 
(__ipipe_syscall_root_thunk+0x35)
    +*func                   1    0.213  __ipipe_dispatch_event+0x11 
(__ipipe_syscall_root+0xcd)
 |  +*begin   0x80000001     1    0.281  __ipipe_dispatch_event+0x34 
(__ipipe_syscall_root+0xcd)
 |  +*end     0x80000001     1    0.213  __ipipe_dispatch_event+0x1a6 
(__ipipe_syscall_root+0xcd)
    +*func                   2    0.232  hisyscall_event+0x11 
(__ipipe_dispatch_event+0x1b7)
    +*func                   2    0.206  __rt_task_wait_period+0xb 
(hisyscall_event+0x151)
    +*func                   2    0.000  rt_task_wait_period+0x4 
(__rt_task_wait_period+0x1c)
_______________________________________________
Xenomai-help mailing list
[email protected]
https://mail.gna.org/listinfo/xenomai-help

Reply via email to