Hi all,
I noticed the splat below on one of my test VMs when running latest
upstream with lockdep enabled. I'm not really sure why this occurs
because I'm not actually using this device for anything I'm aware of. I
suppose it's possible this has a busted userspace or kvm config, as this
is just one of a handful of scratch VMs I have around for development
purposes. I'm happy to try and dig further into it or just expunge it if
this is of little interest.
FWIW, the splat itself reproduces back before ->open_mutex was created
from bd_mutex by commit a8698707a183 ("block: move bd_mutex to struct
gendisk"). I went as far back as v5.10 and still observed it.
Brian
--- 8< ---
[ 11.667694] block (null): writer mapped to sr0
[ 11.677407] ============================================
[ 11.680650] WARNING: possible recursive locking detected
[ 11.683581] 6.8.0+ #346 Tainted: G E
[ 11.686246] --------------------------------------------
[ 11.689075] systemd-udevd/1438 is trying to acquire lock:
[ 11.690607] ffff8bb78f553cc8 (&disk->open_mutex){+.+.}-{3:3}, at: bdev_open+0x60/0x3e0
[ 11.692504]
but task is already holding lock:
[ 11.693921] ffff8bb786b39cc8 (&disk->open_mutex){+.+.}-{3:3}, at: bdev_open+0x239/0x3e0
[ 11.695806]
other info that might help us debug this:
[ 11.697362] Possible unsafe locking scenario:
[ 11.698779] CPU0
[ 11.699397] ----
[ 11.699994] lock(&disk->open_mutex);
[ 11.700923] lock(&disk->open_mutex);
[ 11.701849]
*** DEADLOCK ***
[ 11.703273] May be due to missing lock nesting notation
[ 11.704878] 3 locks held by systemd-udevd/1438:
[ 11.705967] #0: ffff8bb786b39cc8 (&disk->open_mutex){+.+.}-{3:3}, at: bdev_open+0x239/0x3e0
[ 11.707966] #1: ffffffffc085c768 (pktcdvd_mutex){+.+.}-{3:3}, at: pkt_open+0x2b/0x630 [pktcdvd]
[ 11.710080] #2: ffffffffc085d868 (&ctl_mutex#2){+.+.}-{3:3}, at: pkt_open+0x39/0x630 [pktcdvd]
[ 11.712164]
stack backtrace:
[ 11.713200] CPU: 3 PID: 1438 Comm: systemd-udevd Tainted: G E 6.8.0+ #346
[ 11.715122] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-1.fc38 04/01/2014
[ 11.717123] Call Trace:
[ 11.717741] <TASK>
[ 11.718271] dump_stack_lvl+0x79/0xb0
[ 11.719194] __lock_acquire+0x1228/0x2170
[ 11.720172] lock_acquire+0xbb/0x2c0
[ 11.721030] ? bdev_open+0x60/0x3e0
[ 11.721869] __mutex_lock+0x77/0xd40
[ 11.722724] ? bdev_open+0x60/0x3e0
[ 11.723558] ? find_held_lock+0x2b/0x80
[ 11.724470] ? bdev_open+0x56/0x3e0
[ 11.725324] ? bdev_open+0x60/0x3e0
[ 11.726173] ? bdev_open+0x60/0x3e0
[ 11.727031] bdev_open+0x60/0x3e0
[ 11.727844] bdev_file_open_by_dev+0xbf/0x120
[ 11.728909] pkt_open+0x10e/0x630 [pktcdvd]
[ 11.729944] ? bdev_open+0x22f/0x3e0
[ 11.730815] ? lock_release+0xb8/0x270
[ 11.731729] ? bdev_open+0x239/0x3e0
[ 11.732605] blkdev_get_whole+0x25/0x90
[ 11.733544] bdev_open+0x29f/0x3e0
[ 11.734380] ? iput.part.0+0x34/0x260
[ 11.735277] ? __pfx_blkdev_open+0x10/0x10
[ 11.736282] blkdev_open+0x8b/0xc0
[ 11.737090] do_dentry_open+0x172/0x580
[ 11.738002] path_openat+0x3a9/0xa30
[ 11.738864] do_filp_open+0xa1/0x130
[ 11.739731] ? _raw_spin_unlock+0x23/0x40
[ 11.740700] do_sys_openat2+0x82/0xb0
[ 11.741596] __x64_sys_openat+0x49/0x80
[ 11.742529] do_syscall_64+0x7c/0x190
[ 11.743406] entry_SYSCALL_64_after_hwframe+0x6c/0x74
[ 11.744599] RIP: 0033:0x7f30e4afd70b
[ 11.745450] Code: 25 00 00 41 00 3d 00 00 41 00 74 4b 64 8b 04 25 18 00 00 00 85 c0 75 67 44 89 e2 48 89 ee bf 9c ff ff ff b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 0f 87 91 00 00 00 48 8b 54 24 28 64 48 2b 14 25
[ 11.749817] RSP: 002b:00007ffdafd13250 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
[ 11.751633] RAX: ffffffffffffffda RBX: 0000000000006000 RCX: 00007f30e4afd70b
[ 11.753306] RDX: 0000000000080900 RSI: 00007ffdafd132d0 RDI: 00000000ffffff9c
[ 11.754966] RBP: 00007ffdafd132d0 R08: 0000000000000000 R09: 00007ffdafd13160
[ 11.756624] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000080900
[ 11.758311] R13: 0000000000080900 R14: 0000000000000006 R15: 00007ffdafd13470
[ 11.760041] </TASK>
