[<prev] [next>] [day] [month] [year] [list]
Message-ID: <20181205050943.yuqnpoqqhet2eqfo@inn2.lkp.intel.com>
Date: Wed, 5 Dec 2018 13:09:43 +0800
From: kernel test robot <lkp@...el.com>
To: Bart Van Assche <bvanassche@....org>
Cc: LKML <linux-kernel@...r.kernel.org>,
Bart Van Assche <bart.vanassche@...disk.com>, lkp@...org
Subject: [locking/lockdep] f069edd342:
WARNING:at_kernel/locking/lockdep.c:#register_lock_class
FYI, we noticed the following commit (built with gcc-4.9):
commit: f069edd34280c56ed36bf35cc255c719df430abd ("locking/lockdep: Free lock classes that are no longer in use")
https://github.com/bvanassche/linux for-next
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-i386 -enable-kvm -cpu SandyBridge -smp 2 -m 512M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+----------------------------------------------------------+------------+------------+
| | 3c40bb11a6 | f069edd342 |
+----------------------------------------------------------+------------+------------+
| boot_successes | 0 | 0 |
| boot_failures | 12 | 10 |
| kernel_BUG_at_lib/list_debug.c | 12 | |
| invalid_opcode:#[##] | 12 | |
| EIP:__list_del_entry_valid | 12 | |
| Kernel_panic-not_syncing:Fatal_exception | 12 | |
| WARNING:at_kernel/locking/lockdep.c:#register_lock_class | 0 | 10 |
| EIP:register_lock_class | 0 | 10 |
| EIP:_raw_spin_unlock_irqrestore | 0 | 10 |
+----------------------------------------------------------+------------+------------+
[ 3.905016] WARNING: CPU: 0 PID: 0 at kernel/locking/lockdep.c:763 register_lock_class+0x430/0x5f0
[ 3.926405] Modules linked in:
[ 3.932628] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.20.0-rc4-00120-gf069edd #1
[ 3.945183] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 3.957710] EIP: register_lock_class+0x430/0x5f0
[ 3.965515] Code: 68 10 28 9c c1 e8 ab 2f 01 00 68 38 28 9c c1 e8 a1 2f 01 00 e8 ab cf 66 00 8b 06 83 c4 0c e9 88 fc ff ff 8d b4 26 00 00 00 00 <0f> 0b e9 ef fb ff ff 0f 0b a1 2c ae 4d c2 e9 3c ff ff ff 64 a1 d4
[ 4.000626] EAX: 00000000 EBX: c1a8ac80 ECX: 00000000 EDX: 00000000
[ 4.012492] ESI: dd2d5dfc EDI: 00000000 EBP: dcc39e38 ESP: dcc39e04
[ 4.025032] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00210046
[ 4.038610] CR0: 80050033 CR2: ffffffff CR3: 01da6000 CR4: 00000690
[ 4.051081] Call Trace:
[ 4.055718] <IRQ>
[ 4.059579] ? startup_32_smp+0x15f/0x170
[ 4.067289] __lock_acquire+0x53/0x1940
[ 4.074454] ? mark_lock+0x44b/0x5e0
[ 4.081321] ? __lock_acquire+0xe97/0x1940
[ 4.089066] ? pvclock_clocksource_read+0xae/0x1c0
[ 4.100322] lock_acquire+0x82/0x170
[ 4.107093] ? scheduler_tick+0x46/0x130
[ 4.114482] update_rq_clock+0xbe/0x230
[ 4.121636] ? scheduler_tick+0x46/0x130
[ 4.129060] ? prandom_u32+0x1b/0x30
[ 4.135937] scheduler_tick+0x46/0x130
[ 4.142958] update_process_times+0x36/0x40
[ 4.150679] tick_periodic+0x35/0xc0
[ 4.157510] tick_handle_periodic+0x1d/0x70
[ 4.165520] timer_interrupt+0xd/0x20
[ 4.172416] __handle_irq_event_percpu+0x75/0x410
[ 4.181430] handle_irq_event_percpu+0x26/0x60
[ 4.190565] handle_irq_event+0x29/0x50
[ 4.197670] ? irq_set_chained_handler_and_data+0x70/0x70
[ 4.208029] handle_level_irq+0x7a/0x110
[ 4.216004] handle_irq+0x121/0x160
[ 4.222586] </IRQ>
[ 4.226634] do_IRQ+0x48/0x110
[ 4.232796] common_interrupt+0xec/0x100
[ 4.240476] EIP: _raw_spin_unlock_irqrestore+0x2c/0x50
[ 4.250687] Code: e5 56 53 89 c6 89 d3 8d 40 10 8b 4d 04 ba 01 00 00 00 e8 57 d1 96 ff 89 f0 e8 10 1d 97 ff f6 c7 02 74 1b e8 e6 14 9e ff 53 9d <64> ff 0d d0 57 c5 c1 5b 5e 5d c3 89 f6 8d bc 27 00 00 00 00 53 9d
[ 4.287255] EAX: c1a8ac80 EBX: 00200246 ECX: 00001e2a EDX: 00000001
[ 4.298991] ESI: dcc20864 EDI: c1a9b440 EBP: c1a83f18 ESP: c1a83f10
[ 4.311110] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00200246
[ 4.324197] ? tracer_tracing_is_on+0x2b/0x30
[ 4.332820] ? perf_trace_console+0x8/0x160
[ 4.341245] __setup_irq+0x42b/0x6f0
[ 4.351587] setup_irq+0x70/0xd0
[ 4.359296] hpet_time_init+0x1d/0x2e
[ 4.366168] x86_late_time_init+0x9/0x16
[ 4.373515] start_kernel+0x414/0x491
[ 4.380227] i386_start_kernel+0x8f/0x93
[ 4.387387] startup_32_smp+0x15f/0x170
[ 4.394930] irq event stamp: 3500
[ 4.401181] hardirqs last enabled at (3497): [<c176897a>] _raw_spin_unlock_irqrestore+0x2a/0x50
[ 4.418122] hardirqs last disabled at (3498): [<c100167d>] trace_hardirqs_off_thunk+0xc/0x1f
[ 4.433681] softirqs last enabled at (3500): [<c108001c>] _local_bh_enable+0x4c/0x70
[ 4.448751] softirqs last disabled at (3499): [<c1080d00>] irq_enter+0x50/0x70
[ 4.462711] ---[ end trace fb8b0e5b02994760 ]---
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.20.0-rc4-00120-gf069edd" of type "text/plain" (112875 bytes)
View attachment "job-script" of type "text/plain" (4049 bytes)
Download attachment "dmesg.xz" of type "application/x-xz" (14672 bytes)
Powered by blists - more mailing lists