From: edward.robbins@domain.hid
To: edward.robbins@domain.hid
Cc: xenomai@xenomai.org
Subject: Re: [Xenomai-help] Very high latencies under stress testing
Date: Sat, 23 Oct 2010 16:16:05 +0100 (BST) [thread overview]
Message-ID: <1287846965.283824838@domain.hid> (raw)
In-Reply-To: <1287844373.032420306@domain.hid>
[-- Attachment #1: Type: text/plain, Size: 1601 bytes --]
Well, tests with SMI handler disabled in BIOS did not work. Trace attached in case it's of interest. Compiling new kernel now...
On Saturday, 23 October, 2010 3:32pm, edward.robbins@domain.hid said:
> Assuming you mean /var/log/messages and dmesg, they say nothing about SMIs except
> what I previously wrote.
>
> I have managed to boot with SMI disabled in BIOS. The only trouble is I have to
> manually go into the BIOS bootloader and select to boot from USB every time or it
> reports there is no bootable device. It warns in the BIOS that disabling SMI will
> cause legacy USB boot to not work, so I presume this is the cause since my root fs
> is on a USB attached compact flash.
>
> I will try now running tests with SMI disabled in the BIOS.
>
>
> On Saturday, 23 October, 2010 2:58pm, "Gilles Chanteperdrix"
> <gilles.chanteperdrix@xenomai.orgi.org> said:
>
>> edward.robbins@domain.hid wrote:
>>> Oh no...
>>>
>>> dmesg | grep SMI
>>>
>>> CPU0: Thermal monitoring handled by SMI
>>> CPU1: Thermal monitoring handled by SMI
>>>
>>> So I guess that didn't work? I have used the 'Globally disable SMIs option' at
>>> kernel config time.... there is an option in the BIOS to disable SMI but I was
>>> having problems with it... will investigate. Any other options?
>>
>> What do the boot logs say?
>>
>> --
>> Gilles.
>>
>
>
>
> _______________________________________________
> Xenomai-help mailing list
> Xenomai-help@domain.hid> https://mail.gna.org/listinfo/xenomai-help
>
[-- Attachment #2: ipipe_trace.txt --]
[-- Type: text/plain, Size: 11767 bytes --]
I-pipe frozen back-tracing service on 2.6.32.15-xenomai-2.5.4/ipipe-2.7-01
------------------------------------------------------------
CPU: 0, Freeze: 766453929411 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 -314138717 0.195 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138717 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138717 0.202 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138717 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138717 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138716 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138716 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138716 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138716 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138716 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138715 0.195 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138715 0.202 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138715 0.195 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138715 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138715 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138714 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138714 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138714 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138714 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138714 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138713 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138713 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138713 0.202 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138713 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138713 0.214 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138712 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138712 0.210 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138712 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138712 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138712 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138711 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138711 0.202 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138711 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138711 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138711 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138710 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138710 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138710 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138710 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138710 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138709 0.202 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138709 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138709 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138709 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138709 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138708 0.202 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138708 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138708 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138708 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138708 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138707 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138707 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138707 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138707 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138707 0.195 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138706 0.251 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138706 0.217 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138706 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138706 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138706 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138705 0.210 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138705 0.210 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138705 0.202 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138705 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138705 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138704 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138704 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138704 0.217 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138704 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138703 0.206 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138703 0.199 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138703 0.198 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
: +func -314138703 0.202 find_symbol_in_section+0x11 (each_symbol_in_section+0x3a)
-<invalid>-
:| # func -8 0.206 xntimer_next_local_shot+0x9 (xntimer_tick_aperiodic+0x191)
:| # event tick@23 -8 0.202 xntimer_next_local_shot+0xb0 (xntimer_tick_aperiodic+0x191)
:| # func -8 0.251 native_apic_mem_write+0x4 (xntimer_next_local_shot+0xe5)
:| # func -8 0.266 __xnpod_schedule+0x11 (xnintr_clock_handler+0x130)
:| # [25391] -<?>- -1 -7 0.225 __xnpod_schedule+0x189 (xnintr_clock_handler+0x130)
:| # func -7 0.420 xnsched_pick_next+0x4 (__xnpod_schedule+0x1e3)
:| # func -7 0.487 __phys_addr+0x4 (__xnpod_schedule+0x562)
:| # [ 3299] -<?>- 99 -6 0.356 __xnpod_schedule+0x834 (xnpod_suspend_thread+0x281)
:| # func -6 0.251 xntimer_get_overruns+0x8 (xnpod_wait_thread_period+0x14c)
:| # func -6 0.214 __ipipe_restore_pipeline_head+0x7 (xnpod_wait_thread_period+0x1cb)
:| + end 0x80000000 -5 0.926 __ipipe_restore_pipeline_head+0x137 (xnpod_wait_thread_period+0x1cb)
:| + end 0x80000001 -5 0.229 __ipipe_dispatch_event+0x3f0 (__ipipe_syscall_root+0xcd)
:| + begin 0x80000001 -4 0.866 __ipipe_syscall_root+0xec (__ipipe_syscall_root_thunk+0x35)
: + func -3 0.217 __ipipe_syscall_root+0x11 (__ipipe_syscall_root_thunk+0x35)
: + func -3 0.225 __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.540 hisyscall_event+0x11 (__ipipe_dispatch_event+0x1b7)
: + func -2 0.397 xnshadow_sys_trace+0x7 (hisyscall_event+0x151)
: + func -2 0.337 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.191 __ipipe_spin_lock_irqsave+0xb (__ipipe_global_path_lock+0x15)
:| + begin 0x80000001 -1 0.877 __ipipe_spin_lock_irqsave+0x2a (__ipipe_global_path_lock+0x15)
:| # func 0 0.270 __ipipe_spin_unlock_irqcomplete+0xb (__ipipe_global_path_unlock+0x7d)
:| + end 0x80000001 0 0.221 __ipipe_spin_unlock_irqcomplete+0xcf (__ipipe_global_path_unlock+0x7d)
< + freeze 0x004439ec 0 0.232 xnshadow_sys_trace+0x73 (hisyscall_event+0x151)
| + begin 0x80000001 0 0.262 __ipipe_dispatch_event+0x1d9 (__ipipe_syscall_root+0xcd)
| + end 0x80000001 0 0.214 __ipipe_dispatch_event+0x3f0 (__ipipe_syscall_root+0xcd)
| + begin 0x80000001 0 0.367 __ipipe_syscall_root+0xec (__ipipe_syscall_root_thunk+0x35)
+ func 1 0.213 __ipipe_syscall_root+0x11 (__ipipe_syscall_root_thunk+0x35)
+ func 1 0.195 __ipipe_dispatch_event+0x11 (__ipipe_syscall_root+0xcd)
| + begin 0x80000001 1 0.270 __ipipe_dispatch_event+0x34 (__ipipe_syscall_root+0xcd)
| + end 0x80000001 1 0.214 __ipipe_dispatch_event+0x1a6 (__ipipe_syscall_root+0xcd)
+ func 1 0.225 hisyscall_event+0x11 (__ipipe_dispatch_event+0x1b7)
+ func 2 0.191 __rt_task_wait_period+0xb (hisyscall_event+0x151)
+ func 2 0.000 rt_task_wait_period+0x4 (__rt_task_wait_period+0x1c)
next prev parent reply other threads:[~2010-10-23 15:16 UTC|newest]
Thread overview: 38+ messages / expand[flat|nested] mbox.gz Atom feed top
2010-08-13 14:17 [Xenomai-help] Very high latencies under stress testing edward.robbins
2010-08-13 14:35 ` Gilles Chanteperdrix
2010-08-16 12:13 ` edward.robbins
2010-08-16 12:32 ` Gilles Chanteperdrix
2010-09-03 16:30 ` edward.robbins
2010-09-04 8:51 ` Philippe Gerum
2010-10-15 9:21 ` edward.robbins
2010-10-15 11:54 ` edward.robbins
2010-10-15 13:51 ` Gilles Chanteperdrix
2010-10-15 14:13 ` edward.robbins
2010-10-15 14:25 ` Gilles Chanteperdrix
2010-10-15 14:33 ` Philippe Gerum
2010-10-19 13:52 ` edward.robbins
2010-10-19 20:01 ` Gilles Chanteperdrix
2010-10-23 11:08 ` edward.robbins
2010-10-23 11:13 ` Gilles Chanteperdrix
2010-10-23 11:22 ` edward.robbins
2010-10-23 11:36 ` Gilles Chanteperdrix
2010-10-23 13:45 ` edward.robbins
2010-10-23 13:51 ` Gilles Chanteperdrix
2010-10-23 13:56 ` edward.robbins
2010-10-23 13:58 ` Gilles Chanteperdrix
2010-10-23 14:32 ` edward.robbins
2010-10-23 14:37 ` Gilles Chanteperdrix
2010-10-23 14:48 ` edward.robbins
2010-10-23 15:16 ` edward.robbins [this message]
2010-10-23 14:10 ` Gilles Chanteperdrix
2010-08-13 14:40 ` Philippe Gerum
2010-08-13 16:15 ` Philippe Gerum
-- strict thread matches above, loose matches on Subject: below --
2010-10-23 14:54 edward.robbins
2010-10-23 15:37 ` Gilles Chanteperdrix
2010-10-23 16:21 ` edward.robbins
2010-10-23 16:26 ` edward.robbins
2010-10-23 18:46 ` edward.robbins
2010-10-23 21:52 ` Gilles Chanteperdrix
2010-10-24 15:55 ` edward.robbins
2010-10-23 16:13 ` Gilles Chanteperdrix
2010-10-23 16:22 ` Gilles Chanteperdrix
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=1287846965.283824838@domain.hid \
--to=edward.robbins@domain.hid \
--cc=xenomai@xenomai.org \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.