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
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <20171130131620.rm7sndeoahgjm7jb@wfg-t540p.sh.intel.com>
Date:   Thu, 30 Nov 2017 21:16:20 +0800
From:   Fengguang Wu <fengguang.wu@...el.com>
To:     netdev@...r.kernel.org
Cc:     Jiri Pirko <jiri@...lanox.com>, linux-kernel@...r.kernel.org,
        lkp@...org
Subject: [test_parman_move] watchdog: BUG: soft lockup - CPU#0 stuck for 22s!
 [swapper:1]

Hello,

FYI this happens in mainline kernel 4.15.0-rc1.
It at least dates back to v4.12 .

It occurs in 2 out of 2 boots.

[   95.347718] test passed
[   95.359028] test_printf: all 260 tests passed
[   96.656859] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 3332
[   96.770961] test_bitmap: all 460506 tests passed
[   96.783469] test_uuid: all 18 tests passed
[  124.230111] watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [swapper:1]
[  124.230111] CPU: 0 PID: 1 Comm: swapper Not tainted 4.15.0-rc1 #360
[  124.230111] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[  124.230111] task: d3430000 task.stack: d342c000
[  124.230111] EIP: test_parman_move+0xe/0xb0:
						test_parman_move at lib/test_parman.c:119
[  124.230111] EFLAGS: 00200212 CPU: 0
[  124.230111] EAX: d0c00000 EBX: 00000004 ECX: 00000930 EDX: 0000090c
[  124.230111] ESI: d0740324 EDI: d359f680 EBP: d342dec4 ESP: d342debc
[  124.230111]  DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068
[  124.230111] CR0: 80050033 CR2: 00000000 CR3: 02b2b000 CR4: 000006b0
[  124.230111] Call Trace:
[  124.230111]  parman_lsort_item_add+0x9d/0x190:
						__list_del_entry at include/linux/list.h:117
						 (inlined by) list_move_tail at include/linux/list.h:182
						 (inlined by) parman_prio_shift_down at lib/parman.c:144
						 (inlined by) parman_lsort_item_add at lib/parman.c:200
[  124.230111]  parman_item_add+0x9/0x10:
						parman_item_add at lib/parman.c:356
[  124.230111]  test_parman_init+0x358/0x3b5:
						test_parman_run at lib/test_parman.c:284
						 (inlined by) test_parman_lsort at lib/test_parman.c:369
						 (inlined by) test_parman_init at lib/test_parman.c:383
[  124.230111]  ? test_uuid_init+0x1a9/0x1a9:
						test_parman_init at lib/test_parman.c:382
[  124.230111]  do_one_initcall+0x7c/0x10e:
						do_one_initcall at init/main.c:826
[  124.230111]  ? kernel_init_freeable+0xc3/0x15b:
						do_initcall_level at init/main.c:891
						 (inlined by) do_initcalls at init/main.c:900
						 (inlined by) do_basic_setup at init/main.c:918
						 (inlined by) kernel_init_freeable at init/main.c:1066
[  124.230111]  kernel_init_freeable+0xe3/0x15b:
						do_initcall_level at init/main.c:892
						 (inlined by) do_initcalls at init/main.c:900
						 (inlined by) do_basic_setup at init/main.c:918
						 (inlined by) kernel_init_freeable at init/main.c:1066
[  124.230111]  ? rest_init+0xc0/0xc0:
						kernel_init at init/main.c:990
[  124.230111]  kernel_init+0xb/0xf0:
						kernel_init at init/main.c:995
[  124.230111]  ? schedule_tail_wrapper+0x9/0xc:
						schedule_tail_wrapper at arch/x86/entry/entry_32.S:267
[  124.230111]  ret_from_fork+0x19/0x24:
						ret_from_fork at arch/x86/entry/entry_32.S:299
[  124.230111] Code: e8 48 5f c2 00 5d 85 c0 0f 94 c0 0f b6 c0 c3 90 90 90 90 90 90 90 90 90 90 90 90 90 90 55 89 e5 57 53 8b 5d 08 8b 40 04 c1 e3 02 <8d> 3c 90 89 fa 8d 04 88 89 d9 e8 a3 be c2 00 83 fb 08 89 da 73
[  124.230111] Kernel panic - not syncing: softlockup: hung tasks
[  124.230111] CPU: 0 PID: 1 Comm: swapper Tainted: G             L   4.15.0-rc1 #360
[  124.230111] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[  124.230111] Call Trace:
[  124.230111]  dump_stack+0x16/0x19:
						dump_stack at lib/dump_stack.c:64
[  124.230111]  panic+0x86/0x1bd:
						panic at kernel/panic.c:194
[  124.230111]  watchdog_timer_fn+0x1e7/0x1f0:
						watchdog_timer_fn at kernel/watchdog.c:443
[  124.230111]  ? watchdog+0x20/0x20:
						watchdog_timer_fn at kernel/watchdog.c:340
[  124.230111]  hrtimer_run_queues+0xf3/0x1d0:
						__run_hrtimer at kernel/time/hrtimer.c:1211
						 (inlined by) __hrtimer_run_queues at kernel/time/hrtimer.c:1275
						 (inlined by) hrtimer_run_queues at kernel/time/hrtimer.c:1414
[  124.230111]  run_local_timers+0x8/0x40:
						run_local_timers at kernel/time/timer.c:1700
[  124.230111]  update_process_times+0x22/0x50:
						update_process_times at kernel/time/timer.c:1630
[  124.230111]  tick_nohz_handler+0x66/0x100:
						tick_nohz_handler at kernel/time/tick-sched.c:1068
[  124.230111]  smp_apic_timer_interrupt+0x40/0x80:
						exiting_irq at arch/x86/include/asm/apic.h:540
						 (inlined by) smp_apic_timer_interrupt at arch/x86/kernel/apic/apic.c:1052
[  124.230111]  ? irq_exit+0x2f/0xb0:
						tick_irq_exit at kernel/softirq.c:385
						 (inlined by) irq_exit at kernel/softirq.c:407
[  124.230111]  apic_timer_interrupt+0x35/0x3c:
						apic_timer_interrupt at arch/x86/include/asm/entry_arch.h:36
[  124.230111] EIP: test_parman_move+0xe/0xb0:
						test_parman_move at lib/test_parman.c:119
[  124.230111] EFLAGS: 00200212 CPU: 0
[  124.230111] EAX: d0c00000 EBX: 00000004 ECX: 00000930 EDX: 0000090c
[  124.230111] ESI: d0740324 EDI: d359f680 EBP: d342dec4 ESP: d342debc
[  124.230111]  DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068
[  124.230111]  parman_lsort_item_add+0x9d/0x190:
						__list_del_entry at include/linux/list.h:117
						 (inlined by) list_move_tail at include/linux/list.h:182
						 (inlined by) parman_prio_shift_down at lib/parman.c:144
						 (inlined by) parman_lsort_item_add at lib/parman.c:200
[  124.230111]  parman_item_add+0x9/0x10:
						parman_item_add at lib/parman.c:356
[  124.230111]  test_parman_init+0x358/0x3b5:
						test_parman_run at lib/test_parman.c:284
						 (inlined by) test_parman_lsort at lib/test_parman.c:369
						 (inlined by) test_parman_init at lib/test_parman.c:383
[  124.230111]  ? test_uuid_init+0x1a9/0x1a9:
						test_parman_init at lib/test_parman.c:382
[  124.230111]  do_one_initcall+0x7c/0x10e:
						do_one_initcall at init/main.c:826
[  124.230111]  ? kernel_init_freeable+0xc3/0x15b:
						do_initcall_level at init/main.c:891
						 (inlined by) do_initcalls at init/main.c:900
						 (inlined by) do_basic_setup at init/main.c:918
						 (inlined by) kernel_init_freeable at init/main.c:1066
[  124.230111]  kernel_init_freeable+0xe3/0x15b:
						do_initcall_level at init/main.c:892
						 (inlined by) do_initcalls at init/main.c:900
						 (inlined by) do_basic_setup at init/main.c:918
						 (inlined by) kernel_init_freeable at init/main.c:1066
[  124.230111]  ? rest_init+0xc0/0xc0:
						kernel_init at init/main.c:990
[  124.230111]  kernel_init+0xb/0xf0:
						kernel_init at init/main.c:995
[  124.230111]  ? schedule_tail_wrapper+0x9/0xc:
						schedule_tail_wrapper at arch/x86/entry/entry_32.S:267
[  124.230111]  ret_from_fork+0x19/0x24:
						ret_from_fork at arch/x86/entry/entry_32.S:299
[  124.230111] Kernel Offset: disabled

Attached the full dmesg, kconfig and reproduce scripts.

Thanks,
Fengguang

View attachment "dmesg-vm-lkp-wsx03-openwrt-i386-23:20171129185407:i386-randconfig-x0-11291749:4.15.0-rc1:360" of type "text/plain" (32079 bytes)

View attachment ".config" of type "text/plain" (128700 bytes)

View attachment "job-script" of type "text/plain" (3707 bytes)

View attachment "reproduce-vm-lkp-wsx03-openwrt-i386-23:20171129185407:i386-randconfig-x0-11291749:4.15.0-rc1:360" of type "text/plain" (2177 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ