[<prev] [next>] [<thread-prev] [day] [month] [year] [list]
Message-ID: <20170613061700.GE3723@yexl-desktop>
Date: Tue, 13 Jun 2017 14:17:00 +0800
From: kernel test robot <xiaolong.ye@...el.com>
To: Lv Zheng <lv.zheng@...el.com>
Cc: "Rafael J . Wysocki" <rafael.j.wysocki@...el.com>,
"Rafael J . Wysocki" <rjw@...ysocki.net>,
Len Brown <len.brown@...el.com>, Lv Zheng <lv.zheng@...el.com>,
Lv Zheng <zetalog@...il.com>, linux-kernel@...r.kernel.org,
linux-acpi@...r.kernel.org, systemd-devel@...ts.freedesktop.org,
Benjamin Tissoires <benjamin.tissoires@...hat.com>,
Peter Hutterer <peter.hutterer@...-t.net>, lkp@...org
Subject: [lkp-robot] [ACPI] 4d0c35c1af: BUG:scheduling_while_atomic
FYI, we noticed the following commit:
commit: 4d0c35c1af080033a9c2b0ac5734ca78f9bc3c63 ("ACPI: button: Fix issue that button notify cannot report stateful SW_LID state")
url: https://github.com/0day-ci/linux/commits/Lv-Zheng/ACPI-button-Fix-button-lid_init_state-method-mode/20170608-210525
in testcase: netperf
with following parameters:
ip: ipv4
runtime: 300s
nr_threads: 200%
cluster: cs-localhost
test: TCP_CRR
cpufreq_governor: performance
test-description: Netperf is a benchmark that can be use to measure various aspect of networking performance.
test-url: http://www.netperf.org/netperf/
on test machine: 4 threads Intel(R) Core(TM) i5-3317U CPU @ 1.70GHz with 4G memory
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+---------------------------------------------------------------------------+----------+------------+
| | v4.9-rc8 | 4d0c35c1af |
+---------------------------------------------------------------------------+----------+------------+
| boot_successes | 1249 | 2 |
| boot_failures | 100 | 10 |
| BUG:sleeping_function_called_from_invalid_context_at_kernel/irq/manage.c | 17 | |
| calltrace:SyS_write | 8 | |
| calltrace:init_netconsole | 9 | |
| calltrace:SyS_finit_module | 40 | 1 |
| WARNING:at_drivers/gpu/drm/i915/intel_display.c:#intel_modeset_init[i915] | 20 | 1 |
| calltrace:i915_init | 20 | 1 |
| drm:intel_set_cpu_fifo_underrun_reporting[i915]] | 1 | |
| drm:intel_cpu_fifo_underrun_irq_handler[i915]] | 1 | |
| drm:intel_set_pch_fifo_underrun_reporting[i915]] | 1 | |
| drm:intel_pch_fifo_underrun_irq_handler[i915]] | 1 | |
| WARNING:at_fs/sysfs/dir.c:#sysfs_warn_dup | 11 | |
| calltrace:parport_pc_init | 11 | |
| WARNING:at_lib/kobject.c:#kobject_add_internal | 11 | |
| invoked_oom-killer:gfp_mask=0x | 27 | 2 |
| Mem-Info | 27 | 2 |
| Kernel_panic-not_syncing:Out_of_memory_and_no_killable_processes | 27 | 2 |
| BUG:kernel_hang_in_test_stage | 11 | |
| WARNING:at_net/mac80211/driver-ops.h:#ieee80211_set_default_key[mac80211] | 7 | |
| calltrace:SyS_sendmsg | 7 | |
| WARNING:at_net/mac80211/driver-ops.h:#ieee80211_key_replace[mac80211] | 7 | |
| BUG:kernel_hang_in_boot_stage | 2 | |
| BUG:kernel_in_stage | 11 | |
| BUG:scheduling_while_atomic | 0 | 8 |
| WARNING:at_kernel/time/timer.c:#call_timer_fn | 0 | 8 |
| BUG:sleeping_function_called_from_invalid_context_at_mm/slab.h | 0 | 8 |
| calltrace:intel_lid_notify | 0 | 8 |
| calltrace:SyS_sendto | 0 | 8 |
| calltrace:SyS_connect | 0 | 8 |
| calltrace:SyS_read | 0 | 4 |
| calltrace:smpboot_thread_fn | 0 | 8 |
| calltrace:SyS_recvfrom | 0 | 7 |
| calltrace:SyS_accept | 0 | 5 |
| BUG:unable_to_handle_kernel | 0 | 6 |
| Oops:#[##] | 0 | 6 |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 0 | 6 |
| calltrace:SyS_socket | 0 | 3 |
| WARNING:at_net/sched/sch_generic.c:#dev_watchdog | 0 | 1 |
| BUG:soft_lockup-CPU##stuck_for#s | 0 | 2 |
| Kernel_panic-not_syncing:softlockup:hung_tasks | 0 | 2 |
| WARNING:at_arch/x86/kernel/smp.c:#native_smp_send_reschedule | 0 | 1 |
| INFO:rcu_sched_detected_stalls_on_CPUs/tasks | 0 | 1 |
| RIP:smp_call_function_many | 0 | 1 |
| calltrace:SyS_seccomp | 0 | 1 |
| calltrace:SyS_nanosleep | 0 | 1 |
| calltrace:SyS_bind | 0 | 1 |
+---------------------------------------------------------------------------+----------+------------+
[ 16.440882] BUG: scheduling while atomic: swapper/2/0/0x00000102
[ 16.441400] Modules linked in:
[ 16.441750] CPU: 2 PID: 0 Comm: swapper/2 Not tainted 4.9.0-rc8-00001-g4d0c35c #1
[ 16.442346] Hardware name: LENOVO IdeaPad U410 /Lenovo , BIOS 65CN15WW 06/05/2012
[ 16.443007] ffff880112a837b0 ffffffff81477139 0000000000000000 ffff880112a993c0
[ 16.443830] ffff880112a837c0 ffffffff810a7d04 ffff880112a83818 ffffffff81962ed4
[ 16.444651] 0000000000000422 0000000000000008 ffff880112a993c0 ffff880112a837f8
[ 16.445473] Call Trace:
[ 16.446670] <IRQ>
[ 16.446857] [<ffffffff81477139>] dump_stack+0x63/0x8a
[ 16.447329] [<ffffffff810a7d04>] __schedule_bug+0x54/0x70
[ 16.447766] [<ffffffff81962ed4>] __schedule+0x554/0x6f0
[ 16.448191] [<ffffffff819630ad>] schedule+0x3d/0x90
[ 16.448594] [<ffffffff819666f6>] schedule_timeout+0x1d6/0x3f0
[ 16.449052] [<ffffffff810f0340>] ? del_timer_sync+0x50/0x50
[ 16.449501] [<ffffffff810c634f>] ? prepare_to_wait_event+0x7f/0x100
[ 16.449989] [<ffffffff81506972>] ec_guard+0x173/0x1b1
[ 16.450405] [<ffffffff810c63d0>] ? prepare_to_wait_event+0x100/0x100
[ 16.450897] [<ffffffff81507956>] acpi_ec_transaction+0x13f/0x2f2
[ 16.451369] [<ffffffff81507b56>] acpi_ec_read+0x4d/0x59
[ 16.451794] [<ffffffff81507cb9>] acpi_ec_space_handler+0xce/0x183
[ 16.452271] [<ffffffff814fdb35>] ? acpi_os_signal_semaphore+0x74/0x84
[ 16.452771] [<ffffffff81542030>] ? acpi_ut_release_mutex+0x11c/0x127
[ 16.453264] [<ffffffff8151b2b3>] acpi_ev_address_space_dispatch+0x2ce/0x33a
[ 16.453792] [<ffffffff81507beb>] ? ec_transaction+0x4f/0x4f
[ 16.454239] [<ffffffff81522ef6>] acpi_ex_access_region+0x414/0x4ca
[ 16.454719] [<ffffffff810a81da>] ? __might_sleep+0x4a/0x80
[ 16.455159] [<ffffffff81523386>] acpi_ex_field_datum_io+0x178/0x3fa
[ 16.455647] [<ffffffff8152392c>] acpi_ex_extract_from_field+0x151/0x2bb
[ 16.456157] [<ffffffff81522592>] acpi_ex_read_data_from_field+0x380/0x3d0
[ 16.456676] [<ffffffff815279f2>] acpi_ex_resolve_node_to_value+0x326/0x443
[ 16.457202] [<ffffffff81527e83>] acpi_ex_resolve_to_value+0x374/0x40e
[ 16.457700] [<ffffffff81515151>] acpi_ds_evaluate_name_path+0xa3/0x143
[ 16.458204] [<ffffffff815157c0>] acpi_ds_exec_end_op+0xd1/0x6c6
[ 16.458670] [<ffffffff815365c5>] acpi_ps_parse_loop+0x7d7/0x873
[ 16.459137] [<ffffffff8153f1f3>] ? acpi_ut_trace+0x26/0x66
[ 16.459579] [<ffffffff8153786c>] acpi_ps_parse_aml+0x1ac/0x4a1
[ 16.460041] [<ffffffff81538526>] acpi_ps_execute_method+0x1f4/0x2b6
[ 16.460529] [<ffffffff8152f567>] acpi_ns_evaluate+0x2ee/0x435
[ 16.460985] [<ffffffff81534209>] acpi_evaluate_object+0x178/0x38e
[ 16.461463] [<ffffffff814fe210>] acpi_evaluate_integer+0x44/0xca
[ 16.461934] [<ffffffff810aba12>] ? check_preempt_curr+0x52/0x90
[ 16.462403] [<ffffffff8154533d>] ? acpi_button_notify+0x133/0x133
[ 16.462880] [<ffffffff81544b04>] acpi_lid_evaluate_state+0x1c/0x33
[ 16.463401] [<ffffffff815451f9>] acpi_lid_update_state+0x16/0x27
[ 16.463875] [<ffffffff8154535d>] acpi_lid_timeout+0x20/0x37
[ 16.464320] [<ffffffff810f0385>] call_timer_fn+0x35/0x130
[ 16.464756] [<ffffffff810f0962>] run_timer_softirq+0x222/0x4e0
[ 16.465218] [<ffffffff810f8c01>] ? ktime_get+0x41/0xb0
[ 16.465640] [<ffffffff81053256>] ? lapic_next_deadline+0x26/0x30
[ 16.466112] [<ffffffff8196af74>] __do_softirq+0x104/0x2ab
[ 16.466550] [<ffffffff810869c1>] irq_exit+0xf1/0x100
[ 16.466959] [<ffffffff8196ad72>] smp_apic_timer_interrupt+0x42/0x50
[ 16.467446] [<ffffffff81969f2c>] apic_timer_interrupt+0x8c/0xa0
[ 16.467908] <EOI>
[ 16.468089] [<ffffffff817d3b12>] ? cpuidle_enter_state+0x122/0x2e0
[ 16.468669] [<ffffffff817d3d07>] cpuidle_enter+0x17/0x20
[ 16.469099] [<ffffffff810c6983>] call_cpuidle+0x23/0x40
[ 16.469525] [<ffffffff810c6bb4>] cpu_startup_entry+0x114/0x200
[ 16.469988] [<ffffffff81051d57>] start_secondary+0x107/0x130
[ 16.470515] ACPI : button: The lid device is not compliant to SW_LID.
[ 16.471013] ------------[ cut here ]------------
[ 16.471397] WARNING: CPU: 2 PID: 0 at kernel/time/timer.c:1315 call_timer_fn+0x128/0x130
[ 16.472117] timer: acpi_lid_timeout+0x0/0x37 preempt leak: 00000101 -> 00000000
[ 16.472699] Modules linked in:
[ 16.473046] CPU: 2 PID: 0 Comm: swapper/2 Tainted: G W 4.9.0-rc8-00001-g4d0c35c #1
[ 16.473713] Hardware name: LENOVO IdeaPad U410 /Lenovo , BIOS 65CN15WW 06/05/2012
[ 16.474368] ffff880112a83de8 ffffffff81477139 ffff880112a83e38 0000000000000000
[ 16.475191] ffff880112a83e28 ffffffff810803db 0000052300000246 0000000000000001
[ 16.476013] ffff8800b4f0b190 0000000000000101 ffffffff8154533d ffff88010d4e5800
[ 16.476835] Call Trace:
[ 16.477082] <IRQ>
[ 16.477262] [<ffffffff81477139>] dump_stack+0x63/0x8a
[ 16.477734] [<ffffffff810803db>] __warn+0xcb/0xf0
[ 16.478128] [<ffffffff8154533d>] ? acpi_button_notify+0x133/0x133
[ 16.478603] [<ffffffff8108044f>] warn_slowpath_fmt+0x4f/0x60
[ 16.479054] [<ffffffff81544a59>] ? acpi_lid_tick+0x2f/0x32
[ 16.479494] [<ffffffff8154533d>] ? acpi_button_notify+0x133/0x133
[ 16.479970] [<ffffffff810f0478>] call_timer_fn+0x128/0x130
[ 16.480410] [<ffffffff810f0962>] run_timer_softirq+0x222/0x4e0
[ 16.480871] [<ffffffff810f8c01>] ? ktime_get+0x41/0xb0
[ 16.481290] [<ffffffff81053256>] ? lapic_next_deadline+0x26/0x30
[ 16.481763] [<ffffffff8196af74>] __do_softirq+0x104/0x2ab
[ 16.482199] [<ffffffff810869c1>] irq_exit+0xf1/0x100
[ 16.482607] [<ffffffff8196ad72>] smp_apic_timer_interrupt+0x42/0x50
[ 16.483093] [<ffffffff81969f2c>] apic_timer_interrupt+0x8c/0xa0
[ 16.483555] <EOI>
[ 16.483734] [<ffffffff817d3b12>] ? cpuidle_enter_state+0x122/0x2e0
[ 16.484313] [<ffffffff817d3d07>] cpuidle_enter+0x17/0x20
[ 16.484745] [<ffffffff810c6983>] call_cpuidle+0x23/0x40
[ 16.485169] [<ffffffff810c6bb4>] cpu_startup_entry+0x114/0x200
[ 16.485630] [<ffffffff81051d57>] start_secondary+0x107/0x130
[ 16.486081] ---[ end trace 1414925b5a440cdd ]---
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Xiaolong
View attachment "config-4.9.0-rc8-00001-g4d0c35c" of type "text/plain" (154152 bytes)
View attachment "job-script" of type "text/plain" (7171 bytes)
Download attachment "dmesg.xz" of type "application/octet-stream" (43988 bytes)
View attachment "netperf" of type "text/plain" (4185 bytes)
View attachment "job.yaml" of type "text/plain" (4654 bytes)
View attachment "reproduce" of type "text/plain" (686 bytes)
Powered by blists - more mailing lists