| lists.openwall.net | lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC | |
|
Open Source and information security mailing list archives
| ||
|
Message-ID: <20170630013402.GG28710@yexl-desktop>
Date: Fri, 30 Jun 2017 09:34:02 +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] c4a9ff748c: BUG:scheduling_while_atomic
FYI, we noticed the following commit:
commit: c4a9ff748c1ca2fe81e012ac32e1daa70702778b ("ACPI: button: Add a workaround to fix an order issue for old userspace")
url: https://github.com/0day-ci/linux/commits/Lv-Zheng/ACPI-button-Fix-button-lid_init_state-method-mode/20170622-143854
in testcase: netperf
with following parameters:
ip: ipv4
runtime: 300s
nr_threads: 1
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.12-rc6 | c4a9ff748c |
+-----------------------------------------------------------------------------------------------------+-----------+------------+
| boot_successes | 9404 | 3 |
| boot_failures | 2560 | 9 |
| ACPI_Error:Field[CPB3]at#exceeds_Buffer[NULL]size#(bits)(#/dsopcode-#) | 365 | |
| ACPI_Error:Method_parse/execution_failed[~_SB._OSC](Node#),AE_AML_BUFFER_LIMIT(#/psparse-#) | 365 | |
| cpu_clock_throttled | 362 | |
| Kernel_panic-not_syncing:Fatal_hardware_error | 2 | |
| Mem-Info | 560 | |
| invoked_oom-killer:gfp_mask=0x | 528 | |
| Out_of_memory:Kill_process | 80 | |
| BUG:Bad_page_state_in_process | 25 | |
| BUG:Bad_rss-counter_state_mm:#idx:#val | 18 | |
| BUG:Bad_page_map_in_process | 7 | |
| page_allocation_failure:order:#,mode:#(GFP_ATOMIC|__GFP_COMP|__GFP_NOTRACK),nodemask=(null) | 3 | |
| WARNING:at_lib/list_debug.c:#__list_add_valid | 2 | |
| INFO:rcu_sched_detected_stalls_on_CPUs/tasks | 2 | |
| BUG:Bad_page_state:#messages_suppressed | 1 | |
| WARNING:at_drivers/gpu/drm/drm_irq.c:#drm_wait_one_vblank[drm] | 19 | |
| WARNING:at_lib/list_debug.c:#__list_del_entry_valid | 2 | |
| general_protection_fault:#[##] | 2 | |
| Kernel_panic-not_syncing:Fatal_exception | 3 | |
| page_allocation_failure:order:#,mode:#(GFP_ATOMIC|__GFP_COMP|__GFP_ZERO),nodemask=(null) | 18 | |
| WARNING:at_drivers/gpu/drm/drm_vblank.c:#drm_wait_one_vblank[drm] | 5 | |
| page_allocation_failure:order:#,mode:#(GFP_KERNEL|__GFP_NORETRY),nodemask=(null) | 11 | |
| BUG:sleeping_function_called_from_invalid_context_at_kernel/locking/rwsem.c | 4 | |
| BUG:non-zero_nr_ptes_on_freeing_mm | 13 | |
| ACPI_Error:Field[CPB3]at_bit_offset/length#exceeds_size_of_target_Buffer(#bits)(#/dsopcode-#) | 116 | |
| ACPI_Error:Method_parse/execution_failed~_SB._OSC,AE_AML_BUFFER_LIMIT(#/psparse-#) | 116 | |
| ACPI_Error:Method_parse/execution_failed~_SB.PC00.IOTR._CRS,AE_AML_NO_RESOURCE_END_TAG(#/psparse-#) | 129 | |
| ACPI_Error:Method_execution_failed~_SB.PC00.IOTR._CRS,AE_AML_NO_RESOURCE_END_TAG(#/uteval-#) | 129 | |
| Kernel_panic-not_syncing:Hard_LOCKUP | 103 | |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 20 | |
| ACPI_Error:[~_SB_.PCI0.XHC_.RHUB.HS11]Namespace_lookup_failure,AE_NOT_FOUND(#/dswload-#) | 15 | |
| ACPI_Error:#table_load_failures,#successful(#/tbxfload-#) | 15 | |
| WARNING:at_drivers/gpu/drm/i915/intel_display.c:#intel_modeset_init[i915] | 259 | 9 |
| BUG:sleeping_function_called_from_invalid_context_at_kernel/locking/mutex.c | 3 | 1 |
| INFO:creating/lkp/benchmarks/ltp/output_directory | 351 | |
| INFO:creating/lkp/benchmarks/ltp/results_directory | 351 | |
| INFO:ltp-pan_reported_some_tests_FAIL | 88 | |
| INFO:ltp-pan_reported_all_tests_PASS | 208 | |
| page_allocation_failure:order:#,mode:#(GFP_HIGHUSER_MOVABLE|__GFP_ZERO),nodemask=(null) | 2 | |
| WARNING:at_kernel/events/core.c:#add_event_to_ctx | 5 | |
| WARNING:at_kernel/events/core.c:#event_sched_out | 5 | |
| BUG:sleeping_function_called_from_invalid_context_at_kernel/irq/manage.c | 1 | |
| calltrace:init_netconsole | 1 | |
| calltrace:SyS_finit_module | 2 | |
| calltrace:SyS_write | 1 | |
| BUG:unable_to_handle_kernel | 1 | |
| Oops:#[##] | 1 | |
| WARNING:at_fs/sysfs/dir.c:#sysfs_warn_dup | 1 | |
| calltrace:parport_pc_init | 1 | |
| WARNING:at_lib/kobject.c:#kobject_add_internal | 1 | |
| Kernel_panic-not_syncing:Out_of_memory_and_no_killable_processes | 447 | |
| BUG:kernel_hang_in_test_stage | 263 | |
| BUG:soft_lockup-CPU##stuck_for#s | 1 | |
| Kernel_panic-not_syncing:softlockup:hung_tasks | 1 | |
| BUG:kernel_reboot-without-warning_in_boot_stage | 1 | |
| BUG:kernel_reboot-without-warning_in_test_stage | 12 | |
| WARNING:at_kernel/workqueue.c:#process_one_work | 1 | |
| BUG:scheduling_while_atomic | 0 | 8 |
| WARNING:at_kernel/time/timer.c:#call_timer_fn | 0 | 8 |
+-----------------------------------------------------------------------------------------------------+-----------+------------+
[ 14.828015] BUG: scheduling while atomic: swapper/0/0/0x00000102
[ 14.828552] Modules linked in:
[ 14.828846] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.12.0-rc6-00001-gc4a9ff74 #1
[ 14.829454] Hardware name: LENOVO IdeaPad U410 /Lenovo , BIOS 65CN15WW 06/05/2012
[ 14.830113] Call Trace:
[ 14.830363] <IRQ>
[ 14.831578] dump_stack+0x63/0x86
[ 14.831887] __schedule_bug+0x54/0x70
[ 14.832212] __schedule+0x633/0x850
[ 14.832530] schedule+0x3d/0x90
[ 14.832826] schedule_timeout+0x174/0x310
[ 14.833176] ? call_timer_fn+0x150/0x150
[ 14.833518] ec_guard+0x1c6/0x1d0
[ 14.833821] ? ec_guard+0x1c6/0x1d0
[ 14.834135] ? remove_wait_queue+0x70/0x70
[ 14.834487] acpi_ec_transaction+0x181/0x3b0
[ 14.834850] acpi_ec_read+0x42/0x50
[ 14.835166] acpi_ec_space_handler+0xa5/0x240
[ 14.835534] ? __update_load_avg_se+0x15b/0x180
[ 14.835955] ? acpi_os_signal_semaphore+0x4d/0x90
[ 14.836345] ? acpi_ut_release_mutex+0x11c/0x127
[ 14.836727] acpi_ev_address_space_dispatch+0x2ce/0x33a
[ 14.837147] ? ec_transaction+0x50/0x50
[ 14.837483] acpi_ex_access_region+0x414/0x4ca
[ 14.837858] ? __might_sleep+0x4a/0x80
[ 14.838187] acpi_ex_field_datum_io+0x178/0x3fa
[ 14.838564] acpi_ex_extract_from_field+0x151/0x2bb
[ 14.838964] acpi_ex_read_data_from_field+0x380/0x3d0
[ 14.839374] acpi_ex_resolve_node_to_value+0x326/0x443
[ 14.839790] acpi_ex_resolve_to_value+0x374/0x40e
[ 14.840179] acpi_ds_evaluate_name_path+0xa3/0x143
[ 14.840573] acpi_ds_exec_end_op+0xd1/0x6c6
[ 14.840930] acpi_ps_parse_loop+0x819/0x8b5
[ 14.841287] ? acpi_ut_trace+0x26/0x66
[ 14.841617] acpi_ps_parse_aml+0x1ac/0x4a1
[ 14.841968] acpi_ps_execute_method+0x1f4/0x2b6
[ 14.842349] acpi_ns_evaluate+0x2ee/0x435
[ 14.842696] acpi_evaluate_object+0x178/0x38e
[ 14.843065] ? acpi_lid_update_state+0x50/0x50
[ 14.843439] acpi_evaluate_integer+0x3e/0xd0
[ 14.843802] acpi_lid_update_state+0x27/0x50
[ 14.844164] acpi_lid_timeout+0x1d/0x30
[ 14.844501] call_timer_fn+0x35/0x150
[ 14.844828] run_timer_softirq+0x1e8/0x460
[ 14.845180] ? ktime_get+0x41/0xa0
[ 14.845490] ? lapic_next_deadline+0x26/0x30
[ 14.845851] ? clockevents_program_event+0x7a/0xf0
[ 14.846246] __do_softirq+0x104/0x2ab
[ 14.846572] irq_exit+0xf1/0x100
[ 14.846872] smp_apic_timer_interrupt+0x3d/0x50
[ 14.847249] apic_timer_interrupt+0x93/0xa0
[ 14.847608] RIP: 0010:cpuidle_enter_state+0x121/0x2d0
[ 14.848013] RSP: 0018:ffffffff81e03df0 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
[ 14.848618] RAX: 0000000000000000 RBX: 0000000000000005 RCX: 000000000000001f
[ 14.849151] RDX: 0000000373cf2cc5 RSI: ffff88011f2195d8 RDI: 0000000000000000
[ 14.849682] RBP: ffffffff81e03e28 R08: 00000000000f41c9 R09: 0000000000000018
[ 14.850214] R10: ffffffff81e03dc0 R11: 000000000007cf4d R12: ffff88011f225800
[ 14.850747] R13: ffffffff81fa9c58 R14: 0000000373cf2cc5 R15: ffffffff81fa9c40
[ 14.851281] </IRQ>
[ 14.851516] cpuidle_enter+0x17/0x20
[ 14.851837] call_cpuidle+0x23/0x40
[ 14.852152] do_idle+0x189/0x1e0
[ 14.852451] cpu_startup_entry+0x1d/0x20
[ 14.852791] rest_init+0x85/0x90
[ 14.853093] start_kernel+0x3f8/0x405
[ 14.853419] ? early_idt_handler_array+0x120/0x120
[ 14.853812] x86_64_start_reservations+0x2f/0x31
[ 14.854195] x86_64_start_kernel+0x143/0x152
[ 14.854557] secondary_startup_64+0x9f/0x9f
[ 14.854990] ACPI : button: The lid device is not compliant to SW_LID.
[ 14.855491] timer: acpi_lid_timeout+0x0/0x30 preempt leak: 00000101 -> 00000000
[ 14.856086] ------------[ cut here ]------------
[ 14.856473] WARNING: CPU: 0 PID: 0 at kernel/time/timer.c:1275 call_timer_fn+0x13c/0x150
[ 14.857188] Modules linked in:
[ 14.857479] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G W 4.12.0-rc6-00001-gc4a9ff74 #1
[ 14.858158] Hardware name: LENOVO IdeaPad U410 /Lenovo , BIOS 65CN15WW 06/05/2012
[ 14.858818] task: ffffffff81e104c0 task.stack: ffffffff81e00000
[ 14.859279] RIP: 0010:call_timer_fn+0x13c/0x150
[ 14.859655] RSP: 0018:ffff88011f203e98 EFLAGS: 00010292
[ 14.860073] RAX: 0000000000000043 RBX: 0000000000000001 RCX: ffffffff81e61488
[ 14.860607] RDX: 0000000000000001 RSI: 0000000000000092 RDI: 0000000000000246
[ 14.861138] RBP: ffff88011f203ec0 R08: 0000000000000000 R09: 000000000000035e
[ 14.861672] R10: ffffea0004714b40 R11: 000000008237d701 R12: 0000000000000101
[ 14.862203] R13: ffff8800c7535990 R14: ffffffff815734e0 R15: ffff880101cb6800
[ 14.862735] FS: 0000000000000000(0000) GS:ffff88011f200000(0000) knlGS:0000000000000000
[ 14.863371] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 14.863819] CR2: 00007fc0dcc49267 CR3: 000000011de09000 CR4: 00000000001406f0
[ 14.864354] Call Trace:
[ 14.864605] <IRQ>
[ 14.864831] run_timer_softirq+0x1e8/0x460
[ 14.865185] ? ktime_get+0x41/0xa0
[ 14.865493] ? lapic_next_deadline+0x26/0x30
[ 14.865854] ? clockevents_program_event+0x7a/0xf0
[ 14.866248] __do_softirq+0x104/0x2ab
[ 14.866573] irq_exit+0xf1/0x100
[ 14.866874] smp_apic_timer_interrupt+0x3d/0x50
[ 14.867252] apic_timer_interrupt+0x93/0xa0
[ 14.867609] RIP: 0010:cpuidle_enter_state+0x121/0x2d0
[ 14.868017] RSP: 0018:ffffffff81e03df0 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
[ 14.868619] RAX: 0000000000000000 RBX: 0000000000000005 RCX: 000000000000001f
[ 14.869151] RDX: 0000000373cf2cc5 RSI: ffff88011f2195d8 RDI: 0000000000000000
[ 14.869682] RBP: ffffffff81e03e28 R08: 00000000000f41c9 R09: 0000000000000018
[ 14.870216] R10: ffffffff81e03dc0 R11: 000000000007cf4d R12: ffff88011f225800
[ 14.870747] R13: ffffffff81fa9c58 R14: 0000000373cf2cc5 R15: ffffffff81fa9c40
[ 14.871278] </IRQ>
[ 14.871513] cpuidle_enter+0x17/0x20
[ 14.871831] call_cpuidle+0x23/0x40
[ 14.872143] do_idle+0x189/0x1e0
[ 14.872443] cpu_startup_entry+0x1d/0x20
[ 14.872783] rest_init+0x85/0x90
[ 14.873083] start_kernel+0x3f8/0x405
[ 14.873411] ? early_idt_handler_array+0x120/0x120
[ 14.873807] x86_64_start_reservations+0x2f/0x31
[ 14.874192] x86_64_start_kernel+0x143/0x152
[ 14.874554] secondary_startup_64+0x9f/0x9f
[ 14.874910] Code: 03 48 85 c0 75 eb 65 ff 0d e2 9f f1 7e e9 0c ff ff ff 44 89 e2 4c 89 f6 48 c7 c7 08 5d ca 81 c6 05 d1 24 e2 00 01 e8 81 66 0a 00 <0f> ff e9 16 ff ff ff 0f 1f 00 66 2e 0f 1f 84 00 00 00 00 00 0f
[ 14.876305] ---[ end trace dfc99d55faf65cc8 ]---
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.12.0-rc6-00001-gc4a9ff74" of type "text/plain" (159327 bytes)
View attachment "job-script" of type "text/plain" (7137 bytes)
Download attachment "dmesg.xz" of type "application/octet-stream" (21552 bytes)
View attachment "netperf" of type "text/plain" (544 bytes)
View attachment "job.yaml" of type "text/plain" (4667 bytes)
View attachment "reproduce" of type "text/plain" (329 bytes)
Powered by blists - more mailing lists