Re: rcu_sched self-detected stall on CPU

[NTU]

Sorry!!

Alec Ari

On Thu, Sep 15, 2016 at 1:22 AM, Mike Galbraith
<umgwanakikbuti@xxxxxxxxx> wrote:
> On Wed, 2016-09-14 at 23:02 -0500, NTU wrote:
>> [   26.542980] Call Trace:
>> [   26.542983]  [<ffffffffa7fbd7c1>] ? 0xffffffffa7fbd7c1
>> [   26.542985]  [<ffffffffa7f17d35>] ? 0xffffffffa7f17d35
>> [   26.542986]  [<ffffffffa796c115>] ? 0xffffffffa796c115
>> [   26.542988]  [<ffffffffa7633d86>] ? 0xffffffffa7633d86
>> [   26.542989]  [<ffffffffa796c0a6>] ? 0xffffffffa796c0a6
> ...
>
> The stack trace is useless without symbols.
[    5.094204] debug: unmapping init [mem 0xffffffffb2717000-0xffffffffb284dfff]
[    5.098544] Write protecting the kernel read-only data: 32768k
[    5.103870] Testing CPA: undo ffffffffb0400000-ffffffffb2400000
[    5.109293] Testing CPA: again
[    5.114695] debug: unmapping init [mem 0xffff880262881000-0xffff8802629fffff]
[    5.119041] debug: unmapping init [mem 0xffff880262f30000-0xffff880262ffffff]
[   26.098243] INFO: rcu_sched self-detected stall on CPU
[   26.102209] 	0-...: (20984 ticks this GP) idle=e5d/140000000000001/0 softirq=196/196 fqs=5248 
[   26.106247] 	 (t=21000 jiffies g=-219 c=-220 q=12)
[   26.110323] Task dump for CPU 0:
[   26.114397] swapper/0       R  running task        0     1      0 0x00000008
[   26.118502]  ffffffffb2463020 0000000074ef7c0c ffff8803ace07c98 ffffffffb050d416
[   26.122620]  0000000000000006 0000000000000010 0000000041b58ab3 ffffffffb22d8e95
[   26.126749]  ffffffffb050d1f0 ffff8803ace07d30 ffffffffb0d59b59 000000000000000f
[   26.130922] Call Trace:
[   26.135064]  <IRQ>  [<ffffffffb050d416>] sched_show_task+0x226/0x380
[   26.139255]  [<ffffffffb050d1f0>] ? SyS_sched_rr_get_interval+0x250/0x250
[   26.143423]  [<ffffffffb0d59b59>] ? _find_next_bit+0xe9/0x120
[   26.147605]  [<ffffffffb0514f41>] dump_cpu_task+0x71/0x90
[   26.151766]  [<ffffffffb1c60a15>] rcu_dump_cpu_stacks+0x180/0x1a6
[   26.155944]  [<ffffffffb0594576>] rcu_check_callbacks+0x1706/0x17f0
[   26.160166]  [<ffffffffb062662f>] ? __acct_update_integrals+0x21f/0x2a0
[   26.164410]  [<ffffffffb059e6c0>] update_process_times+0x30/0x60
[   26.168622]  [<ffffffffb05c8533>] tick_sched_timer+0xb3/0x420
[   26.172808]  [<ffffffffb05c8480>] ? tick_init_highres+0x20/0x20
[   26.177013]  [<ffffffffb059f52e>] __hrtimer_run_queues+0x25e/0x4e0
[   26.181207]  [<ffffffffb05a11dc>] hrtimer_interrupt+0x17c/0x450
[   26.185436]  [<ffffffffb1c7d8ef>] smp_trace_apic_timer_interrupt+0xdf/0x140
[   26.189679]  [<ffffffffb1c7d959>] smp_apic_timer_interrupt+0x9/0xb
[   26.193895]  [<ffffffffb1c7d19c>] apic_timer_interrupt+0x7c/0x90
[   26.198079]  <EOI>  [<ffffffffb0493640>] ? ptdump_walk_pgd_level_core+0x4b0/0x710
[   26.202346]  [<ffffffffb0493190>] ? note_page+0x1790/0x1790
[   26.206594]  [<ffffffffb0485a64>] ? set_memory_np+0x34/0x40
[   26.210890]  [<ffffffffb04938e7>] ptdump_walk_pgd_level_checkwx+0x17/0x20
[   26.215212]  [<ffffffffb04788ef>] mark_rodata_ro+0x1cf/0x230
[   26.219534]  [<ffffffffb1c6b114>] kernel_init+0x34/0x180
[   26.223866]  [<ffffffffb1c7c00f>] ret_from_fork+0x1f/0x40
[   26.228146]  [<ffffffffb1c6b0e0>] ? rest_init+0xa0/0xa0
[   32.053216] CPA self-test:
[   32.258851]  4k 4187648 large 0 gb 0 x 1837[ffff880000099000-ffff880100000000] miss 268800
[   32.467012]  4k 4187648 large 0 gb 0 x 1837[ffff880000099000-ffff880100000000] miss 268800
[   32.673716]  4k 4187648 large 0 gb 0 x 1837[ffff880000099000-ffff880100000000] miss 268800
[   32.678052] ok.