igt@vgem_basic@sysfs - abort - inconsistent {IN-SOFTIRQ-W} -> {SOFTIRQ-ON-W} usage, kworker/.* takes at: blk_mq_dispatch_rq_list
https://intel-gfx-ci.01.org/tree/drm-tip/IGTPW_9383/shard-snb2/igt@vgem_basic@sysfs.html
<4> [170.872973]
<4> [170.872988] ================================
<4> [170.873006] WARNING: inconsistent lock state
<4> [170.873016] 6.5.0-rc1-CI_DRM_13369-g0595153b5c23+ #1 Not tainted
<4> [170.873028] --------------------------------
<4> [170.873038] inconsistent {IN-SOFTIRQ-W} -> {SOFTIRQ-ON-W} usage.
<4> [170.873050] kworker/1:1/65 [HC0[0]:SC0[0]:HE0:SE1] takes:
<4> [170.873063] ffff8881038d4118 (&sbq->ws[i].wait){+.?.}-{2:2}, at: blk_mq_dispatch_rq_list+0x56e/0x840
<4> [170.873088] {IN-SOFTIRQ-W} state was registered at:
<4> [170.873099] lock_acquire+0xd8/0x2d0
<4> [170.873118] _raw_spin_lock_irqsave+0x3d/0x60
<4> [170.873130] __wake_up_common_lock+0x62/0xd0
<4> [170.873150] sbitmap_queue_wake_up+0x74/0xa0
<4> [170.873163] sbitmap_queue_clear+0x3b/0x60
<4> [170.873173] __blk_mq_free_request+0x6c/0xe0
<4> [170.873184] scsi_end_request+0xfc/0x300
<4> [170.873195] scsi_io_completion+0x40/0x5a0
<4> [170.873206] blk_complete_reqs+0x3e/0x50
<4> [170.873216] __do_softirq+0xc6/0x3a9
<4> [170.873234] irq_exit_rcu+0x8e/0xd0
<4> [170.873244] common_interrupt+0xbc/0xe0
<4> [170.873255] asm_common_interrupt+0x26/0x40
<4> [170.873275] finish_task_switch+0xb4/0x280
<4> [170.873286] __schedule+0x3ac/0xd70
<4> [170.873296] schedule+0x5c/0xd0
<4> [170.873305] worker_thread+0xcb/0x3a0
<4> [170.873316] kthread+0x101/0x130
<4> [170.873326] ret_from_fork+0x2c/0x50
<4> [170.873336] irq event stamp: 942442
<4> [170.873344] hardirqs last enabled at (942441): [<ffffffff81ca9b38>] _raw_spin_unlock_irqrestore+0x58/0x70
<4> [170.873371] hardirqs last disabled at (942442): [<ffffffff81ca97c5>] _raw_spin_lock_irq+0x45/0x50
<4> [170.873397] softirqs last enabled at (934136): [<ffffffff81caac6d>] __do_softirq+0x2bd/0x3a9
<4> [170.873414] softirqs last disabled at (934131): [<ffffffff810d7bfe>] irq_exit_rcu+0x8e/0xd0
<4> [170.873431]
other info that might help us debug this:
<4> [170.873444] Possible unsafe locking scenario:
<4> [170.873457] CPU0
<4> [170.873463] ----
<4> [170.873470] lock(&sbq->ws[i].wait);
<4> [170.873488] <Interrupt>
<4> [170.873495] lock(&sbq->ws[i].wait);
<4> [170.873505]
*** DEADLOCK ***
<4> [170.873835] 5 locks held by kworker/1:1/65:
<4> [170.874164] #0: ffff888100083338 ((wq_completion)events_freezable_power_){+.+.}-{0:0}, at: process_one_work+0x1bd/0x500
<4> [170.874513] #1: ffffc90000277e60 ((work_completion)(&(&ev->dwork)->work)){+.+.}-{0:0}, at: process_one_work+0x1c1/0x500
<4> [170.874864] #2: ffffffff82739200 (rcu_read_lock){....}-{1:2}, at: blk_mq_run_hw_queue+0x130/0x440
<4> [170.875222] #3: ffff8881038d4118 (&sbq->ws[i].wait){+.?.}-{2:2}, at: blk_mq_dispatch_rq_list+0x56e/0x840
<4> [170.875584] #4: ffff8881090211b0 (&hctx->dispatch_wait_lock){+...}-{2:2}, at: blk_mq_dispatch_rq_list+0x587/0x840
<4> [170.875951]
stack backtrace:
<4> [170.876644] CPU: 1 PID: 65 Comm: kworker/1:1 Not tainted 6.5.0-rc1-CI_DRM_13369-g0595153b5c23+ #1
<4> [170.877011] Hardware name: Dell Inc. XPS 8300 /0Y2MRG, BIOS A06 10/17/2011
<4> [170.877366] Workqueue: events_freezable_power_ disk_events_workfn
<4> [170.877720] Call Trace:
<4> [170.878066] <TASK>
<4> [170.878409] dump_stack_lvl+0x64/0xb0
<4> [170.878755] mark_lock.part.0+0x8cc/0xcf0
<4> [170.879104] ? lock_acquire+0xd8/0x2d0
<4> [170.879450] ? find_held_lock+0x2b/0x80
<4> [170.879796] mark_held_locks+0x49/0x80
<4> [170.880137] lockdep_hardirqs_on_prepare+0xf8/0x1d0
<4> [170.880480] trace_hardirqs_on+0x46/0xa0
<4> [170.880823] _raw_spin_unlock_irq+0x23/0x50
<4> [170.881177] __blk_mq_get_driver_tag+0x131/0x180
<4> [170.881523] blk_mq_dispatch_rq_list+0x7f0/0x840
<4> [170.881872] __blk_mq_sched_dispatch_requests+0xa7/0x670
<4> [170.882220] blk_mq_sched_dispatch_requests+0x32/0x60
<4> [170.882567] blk_mq_run_hw_queue+0x16f/0x440
<4> [170.882915] blk_execute_rq+0x109/0x250
<4> [170.883262] scsi_execute_cmd+0x113/0x270
<4> [170.883606] scsi_test_unit_ready+0x7d/0x100
<4> [170.883953] sd_check_events+0xf0/0x140
<4> [170.884297] disk_check_events+0x38/0x100
<4> [170.884643] process_one_work+0x251/0x500
<4> [170.884983] worker_thread+0x4f/0x3a0
<4> [170.885319] ? __pfx_worker_thread+0x10/0x10
<4> [170.885650] kthread+0x101/0x130
<4> [170.885994] ? __pfx_kthread+0x10/0x10
<4> [170.886314] ret_from_fork+0x2c/0x50
<4> [170.886631] </TASK>