[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <20141210232049.GC24163@wfg-t540p.sh.intel.com>
Date: Wed, 10 Dec 2014 15:20:49 -0800
From: Fengguang Wu <fengguang.wu@...el.com>
To: Dietmar Eggemann <dietmar.eggemann@....com>
Cc: Michael Turquette <mturquette@...erred.io>, LKP <lkp@...org>,
linux-kernel@...r.kernel.org
Subject: [sched] BUG: unable to handle kernel
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.linaro.org/people/mturquette/linux.git eas-next
commit 1fadb581b0be9420b143e43ff2f4a07ea7e45f6c
Author: Dietmar Eggemann <dietmar.eggemann@....com>
AuthorDate: Tue Dec 2 14:06:24 2014 +0000
Commit: Michael Turquette <mturquette@...erred.io>
CommitDate: Tue Dec 9 20:33:17 2014 -0800
sched: Make usage and load tracking cpu scale-invariant
Besides the existing frequency scale-invariance correction factor, apply
cpu scale-invariance correction factor to usage and load tracking.
Cpu scale-invariance takes cpu performance deviations due to
micro-architectural differences (i.e. instructions per seconds) between
cpus in HMP systems (e.g. big.LITTLE) and differences in the frequency
value of the highest OPP between cpus in SMP systems into consideration.
Each segment of the sched_avg::{running_avg_sum, runnable_avg_sum}
geometric series is now scaled by the cpu performance factor too so the
sched_avg::{utilization_avg_contrib, load_avg_contrib} of each entity will
be invariant from the particular cpu of the HMP/SMP system it is gathered
on. As a result, cfs_rq::runnable_load_avg which is the sum of
sched_avg::load_avg_contrib, becomes cpu scale-invariant too.
So the {usage, load} level that is returned by {get_cpu_usage,
weighted_cpuload} stays relative to the max cpu performance of the system.
Cc: Ingo Molnar <mingo@...hat.com>
Cc: Peter Zijlstra <peterz@...radead.org>
Signed-off-by: Dietmar Eggemann <dietmar.eggemann@....com>
===================================================
PARENT COMMIT NOT CLEAN. LOOK OUT FOR WRONG BISECT!
===================================================
Attached dmesg for the parent commit, too, to help confirm whether it is a noise error.
+-------------------------------------------------------+------------+------------+------------+
| | e754569101 | 1fadb581b0 | 41ae5f4aae |
+-------------------------------------------------------+------------+------------+------------+
| boot_successes | 0 | 0 | 0 |
| boot_failures | 175 | 35 | 16 |
| INFO:suspicious_RCU_usage | 175 | | |
| RCU_used_illegally_from_idle_CPU | 42 | | |
| RCU_used_illegally_from_extended_quiescent_state | 42 | | |
| backtrace:do_fork | 175 | | |
| BUG:kernel_boot_crashed | 0 | 4 | |
| BUG:unable_to_handle_kernel | 0 | 31 | 16 |
| Oops | 0 | 31 | 16 |
| RIP:default_scale_cpu_capacity | 0 | 31 | 16 |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 0 | 31 | 16 |
| backtrace:acpi_load_tables | 0 | 30 | 15 |
| backtrace:acpi_early_init | 0 | 31 | 15 |
| backtrace:acpi_initialize_subsystem | 0 | 1 | |
| backtrace:acpi_ds_auto_serialize_method | 0 | 6 | |
| backtrace:acpi_ds_init_one_object | 0 | 6 | |
| backtrace:kmem_cache_create | 0 | 0 | 1 |
| backtrace:pidmap_init | 0 | 0 | 1 |
| backtrace:acpi_ns_lookup | 0 | 0 | 1 |
| backtrace:acpi_ds_init_field_objects | 0 | 0 | 1 |
+-------------------------------------------------------+------------+------------+------------+
[ 0.020000] pid_max: default: 32768 minimum: 301
[ 0.020000] ACPI: Core revision 20140926
[ 0.020000] ACPI: Core revision 20140926
[ 0.020018] BUG: unable to handle kernel
[ 0.020018] BUG: unable to handle kernel NULL pointer dereferenceNULL pointer dereference at 0000000000000050
at 0000000000000050
[ 0.021436] IP:
[ 0.021436] IP: [<ffffffff810d68a2>] default_scale_cpu_capacity+0xc/0x41
[<ffffffff810d68a2>] default_scale_cpu_capacity+0xc/0x41
[ 0.022741] PGD 0
[ 0.022741] PGD 0
[ 0.023123] Oops: 0000 [#1]
[ 0.023123] Oops: 0000 [#1] PREEMPT PREEMPT SMP SMP
[ 0.023853] Modules linked in:
[ 0.023853] Modules linked in:
[ 0.024476] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 3.18.0-rc2-00089-g1fadb58 #3
[ 0.024476] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 3.18.0-rc2-00089-g1fadb58 #3
[ 0.026198] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014
[ 0.026198] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014
[ 0.027982] task: ffffffff81c0f500 ti: ffffffff81c00000 task.ti: ffffffff81c00000
[ 0.027982] task: ffffffff81c0f500 ti: ffffffff81c00000 task.ti: ffffffff81c00000
[ 0.029308] RIP: 0010:[<ffffffff810d68a2>]
[ 0.029308] RIP: 0010:[<ffffffff810d68a2>] [<ffffffff810d68a2>] default_scale_cpu_capacity+0xc/0x41
[<ffffffff810d68a2>] default_scale_cpu_capacity+0xc/0x41
[ 0.030000] RSP: 0000:ffff880012603d10 EFLAGS: 00010002
[ 0.030000] RSP: 0000:ffff880012603d10 EFLAGS: 00010002
[ 0.030000] RAX: 0000000000000400 RBX: 0000000000000400 RCX: 0000000000000000
[ 0.030000] RAX: 0000000000000400 RBX: 0000000000000400 RCX: 0000000000000000
[ 0.030000] RDX: 0000000000004c4c RSI: 0000000000000000 RDI: 0000000000000000
[ 0.030000] RDX: 0000000000004c4c RSI: 0000000000000000 RDI: 0000000000000000
[ 0.030000] RBP: ffff880012603d18 R08: 0000000000000001 R09: 0000000000000017
[ 0.030000] RBP: ffff880012603d18 R08: 0000000000000001 R09: 0000000000000017
[ 0.030000] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[ 0.030000] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[ 0.030000] R13: ffffffff81c0f568 R14: ffffffff81c03b98 R15: 0000000000000000
[ 0.030000] R13: ffffffff81c0f568 R14: ffffffff81c03b98 R15: 0000000000000000
[ 0.030000] FS: 0000000000000000(0000) GS:ffff880012600000(0000) knlGS:0000000000000000
[ 0.030000] FS: 0000000000000000(0000) GS:ffff880012600000(0000) knlGS:0000000000000000
[ 0.030000] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 0.030000] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 0.030000] CR2: 0000000000000050 CR3: 0000000001c08000 CR4: 00000000000006b0
[ 0.030000] CR2: 0000000000000050 CR3: 0000000001c08000 CR4: 00000000000006b0
[ 0.030000] Stack:
[ 0.030000] Stack:
[ 0.030000] ffffffff810d88d4
[ 0.030000] ffffffff810d88d4 ffff880012603d88 ffff880012603d88 ffffffff810d8986 ffffffff810d8986 ffffffff810cd13f ffffffff810cd13f
[ 0.030000] 0000000000000000
[ 0.030000] 0000000000000000 ffff880000000001 ffff880000000001 00ffffff00000000 00ffffff00000000 0000000000004c4c 0000000000004c4c
[ 0.030000] ffff880012612d70
[ 0.030000] ffff880012612d70 ffff880012603d88 ffff880012603d88 ffff880012612d70 ffff880012612d70 ffffffff81c0f500 ffffffff81c0f500
[ 0.030000] Call Trace:
[ 0.030000] Call Trace:
[ 0.030000] <IRQ>
[ 0.030000] <IRQ>
[ 0.030000]
[ 0.030000] [<ffffffff810d88d4>] ? arch_scale_cpu_capacity+0x15/0x1e
[<ffffffff810d88d4>] ? arch_scale_cpu_capacity+0x15/0x1e
[ 0.030000] [<ffffffff810d8986>] update_entity_load_avg+0xa9/0x5e2
[ 0.030000] [<ffffffff810d8986>] update_entity_load_avg+0xa9/0x5e2
[ 0.030000] [<ffffffff810cd13f>] ? scheduler_tick+0x51/0xe4
[ 0.030000] [<ffffffff810cd13f>] ? scheduler_tick+0x51/0xe4
[ 0.030000] [<ffffffff810d8f1e>] task_tick_fair+0x5f/0x156
[ 0.030000] [<ffffffff810d8f1e>] task_tick_fair+0x5f/0x156
[ 0.030000] [<ffffffff810cd167>] scheduler_tick+0x79/0xe4
[ 0.030000] [<ffffffff810cd167>] scheduler_tick+0x79/0xe4
[ 0.030000] [<ffffffff8111c3d2>] update_process_times+0x88/0xa6
[ 0.030000] [<ffffffff8111c3d2>] update_process_times+0x88/0xa6
[ 0.030000] [<ffffffff8112d559>] ? tick_handle_periodic+0x34/0xa2
[ 0.030000] [<ffffffff8112d559>] ? tick_handle_periodic+0x34/0xa2
[ 0.030000] [<ffffffff8112d2a2>] tick_periodic+0x141/0x14a
[ 0.030000] [<ffffffff8112d2a2>] tick_periodic+0x141/0x14a
[ 0.030000] [<ffffffff8112d559>] tick_handle_periodic+0x34/0xa2
[ 0.030000] [<ffffffff8112d559>] tick_handle_periodic+0x34/0xa2
[ 0.030000] [<ffffffff81007e46>] timer_interrupt+0x1c/0x2a
[ 0.030000] [<ffffffff81007e46>] timer_interrupt+0x1c/0x2a
[ 0.030000] [<ffffffff81101e2b>] handle_irq_event_percpu+0xfe/0x592
[ 0.030000] [<ffffffff81101e2b>] handle_irq_event_percpu+0xfe/0x592
[ 0.030000] [<ffffffff8110230e>] handle_irq_event+0x4f/0x7d
[ 0.030000] [<ffffffff8110230e>] handle_irq_event+0x4f/0x7d
[ 0.030000] [<ffffffff8130010a>] ? __this_cpu_preempt_check+0x1a/0x23
[ 0.030000] [<ffffffff8130010a>] ? __this_cpu_preempt_check+0x1a/0x23
[ 0.030000] [<ffffffff81107190>] handle_level_irq+0xce/0x139
[ 0.030000] [<ffffffff81107190>] handle_level_irq+0xce/0x139
[ 0.030000] [<ffffffff81007330>] handle_irq+0x6d/0x85
[ 0.030000] [<ffffffff81007330>] handle_irq+0x6d/0x85
[ 0.030000] [<ffffffff8156f1d6>] do_IRQ+0x76/0x141
[ 0.030000] [<ffffffff8156f1d6>] do_IRQ+0x76/0x141
[ 0.030000] [<ffffffff8156dcaf>] common_interrupt+0x6f/0x6f
[ 0.030000] [<ffffffff8156dcaf>] common_interrupt+0x6f/0x6f
[ 0.030000] <EOI>
[ 0.030000] <EOI>
[ 0.030000]
[ 0.030000] [<ffffffff8104c846>] ? native_restore_fl+0xd/0x16
[<ffffffff8104c846>] ? native_restore_fl+0xd/0x16
[ 0.030000] [<ffffffff810f4228>] arch_local_irq_restore+0x12/0x1b
[ 0.030000] [<ffffffff810f4228>] arch_local_irq_restore+0x12/0x1b
[ 0.030000] [<ffffffff8156bc13>] _raw_spin_unlock_irqrestore+0x8c/0x10f
[ 0.030000] [<ffffffff8156bc13>] _raw_spin_unlock_irqrestore+0x8c/0x10f
[ 0.030000] [<ffffffff8121adc2>] slob_free+0x410/0x426
[ 0.030000] [<ffffffff8121adc2>] slob_free+0x410/0x426
[ 0.030000] [<ffffffff8121adfa>] __kmem_cache_free+0x22/0x56
[ 0.030000] [<ffffffff8121adfa>] __kmem_cache_free+0x22/0x56
[ 0.030000] [<ffffffff8121aeac>] kmem_cache_free+0x7e/0x20f
[ 0.030000] [<ffffffff8121aeac>] kmem_cache_free+0x7e/0x20f
[ 0.030000] [<ffffffff8133692e>] acpi_os_release_object+0x15/0x20
[ 0.030000] [<ffffffff8133692e>] acpi_os_release_object+0x15/0x20
[ 0.030000] [<ffffffff81374964>] acpi_ut_delete_generic_state+0x2b/0x34
[ 0.030000] [<ffffffff81374964>] acpi_ut_delete_generic_state+0x2b/0x34
[ 0.030000] [<ffffffff8134dec1>] acpi_ds_scope_stack_clear+0x37/0x44
[ 0.030000] [<ffffffff8134dec1>] acpi_ds_scope_stack_clear+0x37/0x44
[ 0.030000] [<ffffffff81369666>] acpi_ps_parse_aml+0x1e1/0x402
[ 0.030000] [<ffffffff81369666>] acpi_ps_parse_aml+0x1e1/0x402
[ 0.030000] [<ffffffff81349703>] acpi_ds_auto_serialize_method+0xd9/0x10b
[ 0.030000] [<ffffffff81349703>] acpi_ds_auto_serialize_method+0xd9/0x10b
[ 0.030000] [<ffffffff813494a5>] acpi_ds_init_one_object+0x110/0x144
[ 0.030000] [<ffffffff813494a5>] acpi_ds_init_one_object+0x110/0x144
[ 0.030000] [<ffffffff813658a4>] acpi_ns_walk_namespace+0x11a/0x247
[ 0.030000] [<ffffffff813658a4>] acpi_ns_walk_namespace+0x11a/0x247
[ 0.030000] [<ffffffff81349395>] ? acpi_ds_create_index_field+0x12a/0x12a
[ 0.030000] [<ffffffff81349395>] ? acpi_ds_create_index_field+0x12a/0x12a
[ 0.030000] [<ffffffff81349571>] acpi_ds_initialize_objects+0x98/0x10e
[ 0.030000] [<ffffffff81349571>] acpi_ds_initialize_objects+0x98/0x10e
[ 0.030000] [<ffffffff8156bc6c>] ? _raw_spin_unlock_irqrestore+0xe5/0x10f
[ 0.030000] [<ffffffff8156bc6c>] ? _raw_spin_unlock_irqrestore+0xe5/0x10f
[ 0.030000] [<ffffffff81361f99>] acpi_ns_load_table+0xe4/0xf3
[ 0.030000] [<ffffffff81361f99>] acpi_ns_load_table+0xe4/0xf3
[ 0.030000] [<ffffffff81f80965>] acpi_load_tables+0xea/0x225
[ 0.030000] [<ffffffff81f80965>] acpi_load_tables+0xea/0x225
[ 0.030000] [<ffffffff81f7f249>] acpi_early_init+0xd8/0x1ac
[ 0.030000] [<ffffffff81f7f249>] acpi_early_init+0xd8/0x1ac
[ 0.030000] [<ffffffff81f42602>] start_kernel+0x6d5/0x787
[ 0.030000] [<ffffffff81f42602>] start_kernel+0x6d5/0x787
[ 0.030000] [<ffffffff81f41120>] ? early_idt_handlers+0x120/0x120
[ 0.030000] [<ffffffff81f41120>] ? early_idt_handlers+0x120/0x120
[ 0.030000] [<ffffffff81f41587>] x86_64_start_reservations+0x46/0x4f
[ 0.030000] [<ffffffff81f41587>] x86_64_start_reservations+0x46/0x4f
[ 0.030000] [<ffffffff81f4175a>] x86_64_start_kernel+0x1ca/0x1e0
[ 0.030000] [<ffffffff81f4175a>] x86_64_start_kernel+0x1ca/0x1e0
[ 0.030000] Code:
[ 0.030000] Code: c3 c3 55 55 be be 08 08 00 00 00 00 00 00 48 48 ff ff 05 05 ab ab 04 04 fe fe 00 00 48 48 89 89 e5 e5 e8 e8 67 67 fd fd 21 21 00 00 48 48 ff ff 05 05 a4 a4 04 04 fe fe 00 00 5d 5d c3 c3 e8 e8 55 55 87 87 49 49 00 00 48 48 ff ff 05 05 7e 7e 39 39 fe fe 00 00 <f6> <f6> 47 47 50 50 80 80 55 55 48 48 89 89 e5 e5 75 75 07 07 b8 b8 00 00 04 04 00 00 00 00 eb eb 22 22 8b 8b 8f 8f 90 90 00 00
[ 0.030000] RIP
[ 0.030000] RIP [<ffffffff810d68a2>] default_scale_cpu_capacity+0xc/0x41
[<ffffffff810d68a2>] default_scale_cpu_capacity+0xc/0x41
[ 0.030000] RSP <ffff880012603d10>
[ 0.030000] RSP <ffff880012603d10>
[ 0.030000] CR2: 0000000000000050
[ 0.030000] CR2: 0000000000000050
[ 0.030000] ---[ end trace 8aa5f3406d78ad18 ]---
[ 0.030000] ---[ end trace 8aa5f3406d78ad18 ]---
git bisect start 41ae5f4aaef4889974485552fd2c9e0e8d86fc2f b2776bf7149bddd1f4161f14f79520f17fc1d71d --
git bisect good e1945e18b82b6923b0e3ce492ae35fd4587d45eb # 13:10 20+ 0 Merge 'vfs/iov_iter-net-2' into devel-lkp-ib04-smoke-201412101243
git bisect bad 524d698e93870a340afaf5b647d4cce84fb6f880 # 13:12 0- 20 Merge 'clk/eas-next' into devel-lkp-ib04-smoke-201412101243
git bisect good c1a1272dcf10f1bea314226c76245604fbf91c87 # 13:17 20+ 20 sched: updated comments of CLONE_NEWUTS and CLONE_NEWIPC
git bisect good 7c2684baf9042237fa3f72c9f230637911fe9b53 # 13:21 20+ 20 sched: energy_model: simple cpu frequency scaling policy
git bisect good 123c1de3f5f485b44b1b84c50b40cbafe1e379d6 # 13:25 20+ 0 sched: add ftrace for io latency tracking
git bisect bad 318e8cc222050c8c542c7471224fe3ba1ac18062 # 13:29 12- 20 arm: Frequency invariant scheduler load-tracking support
git bisect good b9ed965defe8f8ee2e57e0a9372c70b883a4ea3f # 13:34 35+ 35 Merge remote-tracking branch 'eas-next/eas-next' into sched/cpuidle/eas-next
git bisect bad 1fadb581b0be9420b143e43ff2f4a07ea7e45f6c # 13:38 4- 35 sched: Make usage and load tracking cpu scale-invariant
git bisect good e754569101f392e1924d8ce6f087ea4cfad91d69 # 13:45 35+ 35 sched: Make load tracking frequency scale-invariant
# first bad commit: [1fadb581b0be9420b143e43ff2f4a07ea7e45f6c] sched: Make usage and load tracking cpu scale-invariant
git bisect good e754569101f392e1924d8ce6f087ea4cfad91d69 # 13:49 105+ 140 sched: Make load tracking frequency scale-invariant
# extra tests on HEAD of linux-devel/devel-lkp-ib04-smoke-201412101243
git bisect bad 41ae5f4aaef4889974485552fd2c9e0e8d86fc2f # 13:49 0- 16 0day head guard for 'devel-lkp-ib04-smoke-201412101243'
# extra tests on tree/branch clk/eas-next
git bisect bad 67cc03886394320689d30d65d65b386756d47e39 # 13:58 26- 96 sched: Include blocked load in weighted_cpuload
# extra tests on tree/branch linus/master
git bisect good 86c6a2fddf0b89b494c7616f2c06cf915c4bff01 # 14:22 105+ 0 Merge branch 'sched-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
# extra tests on tree/branch next/master
git bisect good 5348e33950aad8d5ab06d83cb7ac4e6b4198f773 # 14:27 105+ 0 Add linux-next specific files for 20141209
This script may reproduce the error.
----------------------------------------------------------------------------
#!/bin/bash
kernel=$1
kvm=(
qemu-system-x86_64
-cpu kvm64
-enable-kvm
-kernel $kernel
-m 320
-smp 2
-net nic,vlan=1,model=e1000
-net user,vlan=1
-boot order=nc
-no-reboot
-watchdog i6300esb
-rtc base=localtime
-serial stdio
-display none
-monitor null
)
append=(
hung_task_panic=1
earlyprintk=ttyS0,115200
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
load_ramdisk=2
prompt_ramdisk=0
console=ttyS0,115200
console=tty0
vga=normal
root=/dev/ram0
rw
drbd.minor_count=8
)
"${kvm[@]}" --append "${append[*]}"
----------------------------------------------------------------------------
Thanks,
Fengguang
View attachment "dmesg-quantal-client8-1:20141210133740:x86_64-randconfig-ib0-12101221:3.18.0-rc2-00089-g1fadb58:3" of type "text/plain" (32181 bytes)
View attachment "dmesg-quantal-client9-12:20141210134436:x86_64-randconfig-ib0-12101221:3.18.0-rc2-00088-ge754569:4" of type "text/plain" (77550 bytes)
View attachment "config-3.18.0-rc2-00089-g1fadb58" of type "text/plain" (68659 bytes)
_______________________________________________
LKP mailing list
LKP@...ux.intel.com
Powered by blists - more mailing lists