[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <20181224125620.guph2apbk4snhirq@inn2.lkp.intel.com>
Date: Mon, 24 Dec 2018 20:56:20 +0800
From: kernel test robot <lkp@...el.com>
To: Matthew Wilcox <willy@...radead.org>
Cc: LKML <linux-kernel@...r.kernel.org>,
Linus Torvalds <torvalds@...ux-foundation.org>, lkp@...org
Subject: [xarray] b803b42823: BUG:soft_lockup-CPU##stuck_for#s
FYI, we noticed the following commit (built with gcc-4.9):
commit: b803b42823d0d9e8b6deccf01ffc2aba5d0738df ("xarray: Add XArray iterators")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: trinity
with following parameters:
runtime: 300s
test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 768M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+---------------------------------------------------------------+------------+------------+
| | 41aec91f55 | b803b42823 |
+---------------------------------------------------------------+------------+------------+
| boot_successes | 18 | 5 |
| boot_failures | 2 | 17 |
| WARNING:at_drivers/ata/libata-core.c:#ata_host_detach[libata] | 2 | 4 |
| EIP:ata_host_detach | 2 | 4 |
| BUG:soft_lockup-CPU##stuck_for#s | 0 | 13 |
| EIP:lock_is_held_type | 0 | 9 |
| Kernel_panic-not_syncing:softlockup:hung_tasks | 0 | 13 |
| EIP:lock_release | 0 | 1 |
| EIP:xas_find | 0 | 1 |
| EIP:lock_acquire | 0 | 2 |
+---------------------------------------------------------------+------------+------------+
[ 51.886077] watchdog: BUG: soft lockup - CPU#0 stuck for 23s! [swapper:1]
[ 51.886077] Modules linked in:
[ 51.886077] irq event stamp: 2387290
[ 51.886077] hardirqs last enabled at (2387289): [<8ae9ab9d>] __call_rcu+0x7d/0xa0
[ 51.886077] hardirqs last disabled at (2387290): [<8ae015a9>] trace_hardirqs_off_thunk+0xc/0x13
[ 51.886077] softirqs last enabled at (2387276): [<8b69352d>] __do_softirq+0x31d/0x34f
[ 51.886077] softirqs last disabled at (2387269): [<8ae1880c>] do_softirq_own_stack+0x1c/0x30
[ 51.886077] CPU: 0 PID: 1 Comm: swapper Not tainted 4.19.0-rc5-00251-gb803b42 #1
[ 51.886077] EIP: lock_is_held_type+0xb3/0xf0
[ 51.886077] Code: c1 e1 05 31 db 29 c1 8a 84 0e fe 03 00 00 83 e0 03 39 c2 0f 94 c3 a1 20 31 a8 8b c7 80 e4 03 00 00 00 00 00 00 8b 45 ec 50 9d <66> 66 66 90 83 c4 0c 89 d8 5b 5e 5f 5d c3 8d b4 26 00 00 00 00 31
[ 51.886077] EAX: 00200246 EBX: 00000000 ECX: 781103e8 EDX: 8bab9bd0
[ 51.886077] ESI: 00000001 EDI: 78110000 EBP: 78105ec0 ESP: 78105ea8
[ 51.886077] DS: 007b ES: 007b FS: 0000 GS: 00e0 SS: 0068 EFLAGS: 00200246
[ 51.886077] CR0: 80050033 CR2: 00000000 CR3: 13c12000 CR4: 000006d0
[ 51.886077] Call Trace:
[ 51.886077] ? xas_find+0x11b/0x240
[ 51.886077] ? xa_find+0xc2/0xe0
[ 51.886077] ? check_find+0x11a/0x420
[ 51.886077] ? check_multi_store+0xa40/0xa40
[ 51.886077] ? xarray_checks+0x30/0x70
[ 51.886077] ? do_one_initcall+0x68/0x253
[ 51.886077] ? parse_args+0x18a/0x2d0
[ 51.886077] ? rcu_read_lock_sched_held+0x33/0x70
[ 51.886077] ? trace_initcall_level+0x57/0x8d
[ 51.886077] ? kernel_init_freeable+0x164/0x232
[ 51.886077] ? rest_init+0xb0/0xb0
[ 51.886077] ? kernel_init+0x8/0xf0
[ 51.886077] ? ret_from_fork+0x19/0x30
[ 51.886077] Kernel panic - not syncing: softlockup: hung tasks
[ 51.886077] CPU: 0 PID: 1 Comm: swapper Tainted: G L 4.19.0-rc5-00251-gb803b42 #1
[ 51.886077] Call Trace:
[ 51.886077] ? dump_stack+0x16/0x26
[ 51.886077] ? panic+0x8b/0x1c8
[ 51.886077] ? watchdog_timer_fn+0x24a/0x250
[ 51.886077] ? __lockup_detector_cleanup+0x30/0x30
[ 51.886077] ? __hrtimer_run_queues+0x17c/0x3b0
[ 51.886077] ? __lockup_detector_cleanup+0x30/0x30
[ 51.886077] ? hrtimer_run_queues+0x8c/0xe0
[ 51.886077] ? run_local_timers+0x8/0x30
[ 51.886077] ? update_process_times+0x17/0x40
[ 51.886077] ? tick_periodic+0x29/0xc0
[ 51.886077] ? tick_handle_periodic+0x13/0x60
[ 51.886077] ? smp_apic_timer_interrupt+0x77/0x1b0
[ 51.886077] ? apic_timer_interrupt+0xd6/0xe0
[ 51.886077] ? printk+0x5/0x10
[ 51.886077] ? lock_is_held_type+0xb3/0xf0
[ 51.886077] ? xas_find+0x11b/0x240
[ 51.886077] ? xa_find+0xc2/0xe0
[ 51.886077] ? check_find+0x11a/0x420
[ 51.886077] ? check_multi_store+0xa40/0xa40
[ 51.886077] ? xarray_checks+0x30/0x70
[ 51.886077] ? do_one_initcall+0x68/0x253
[ 51.886077] ? parse_args+0x18a/0x2d0
[ 51.886077] ? rcu_read_lock_sched_held+0x33/0x70
[ 51.886077] ? trace_initcall_level+0x57/0x8d
[ 51.886077] ? kernel_init_freeable+0x164/0x232
[ 51.886077] ? rest_init+0xb0/0xb0
[ 51.886077] ? kernel_init+0x8/0xf0
[ 51.886077] ? ret_from_fork+0x19/0x30
[ 51.886077] Kernel Offset: 0x11e00000 from 0x79000000 (relocation range: 0x78000000-0xa87dbfff)
Elapsed time: 60
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Rong Chen
View attachment "config-4.19.0-rc5-00251-gb803b42" of type "text/plain" (128693 bytes)
View attachment "job-script" of type "text/plain" (4274 bytes)
Download attachment "dmesg.xz" of type "application/x-xz" (9124 bytes)
Powered by blists - more mailing lists