[11518.169823] run fstests generic/251 at 2023-07-23 00:06:16
[11518.863324] BTRFS: device fsid 13921637-4436-40f4-9cb4-e48f1103a380 devid 1 transid 2189255 /dev/mapper/vg0-lv0 scanned by mount (1591712)
[11518.864819] BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
[11518.864828] BTRFS info (device dm-0): using free space tree
[11518.901839] BTRFS info (device dm-0): auto enabling async discard
[11519.245240] BTRFS: device fsid 90d1dca2-db9e-446a-ad7e-5061588b6598 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (1591760)
[11519.282193] BTRFS info (device dm-9): using crc32c (crc32c-intel) checksum algorithm
[11519.282202] BTRFS info (device dm-9): disk space caching is enabled
[11519.286166] BTRFS info (device dm-9): auto enabling async discard
[11519.286322] BTRFS info (device dm-9): checking UUID tree
[11914.604429] ======================================================
[11914.604900] WARNING: possible circular locking dependency detected
[11914.605415] 6.5.0-rc2+ #1248 Not tainted
[11914.605768] ------------------------------------------------------
[11914.606299] kswapd0/47 is trying to acquire lock:
[11914.606722] ffff8a3bf8942378 (btrfs_trans_num_writers){++++}-{0:0}, at: join_transaction+0x19f/0x550
[11914.607502]
but task is already holding lock:
[11914.607978] ffff8a3c300d2600 (sb_internal#2){++++}-{0:0}, at: btrfs_commit_inode_delayed_inode+0x5f/0x120
[11914.608759]
which lock already depends on the new lock.
[11914.609408]
the existing dependency chain (in reverse order) is:
[11914.610027]
-> #3 (sb_internal#2){++++}-{0:0}:
[11914.610535] start_transaction+0x401/0x730
[11914.610924] btrfs_commit_inode_delayed_inode+0x5f/0x120
[11914.611402] btrfs_evict_inode+0x273/0x3c0
[11914.611786] evict+0xcc/0x1d0
[11914.612073] inode_lru_isolate+0x14d/0x1e0
[11914.612478] __list_lru_walk_one+0xbe/0x1c0
[11914.612889] list_lru_walk_one+0x58/0x80
[11914.613244] prune_icache_sb+0x39/0x60
[11914.613584] super_cache_scan+0x161/0x1f0
[11914.613967] do_shrink_slab+0x163/0x340
[11914.614334] shrink_slab+0x1d7/0x2a0
[11914.614737] shrink_node+0x2eb/0x7b0
[11914.615221] balance_pgdat+0x344/0x780
[11914.615724] kswapd+0x205/0x410
[11914.616227] kthread+0xfc/0x130
[11914.616705] ret_from_fork+0x2d/0x50
[11914.617238] ret_from_fork_asm+0x1b/0x30
[11914.617975]
-> #2 (fs_reclaim){+.+.}-{0:0}:
[11914.618570] fs_reclaim_acquire+0xa5/0xe0
[11914.619074] kmem_cache_alloc_lru+0x4e/0x570
[11914.619609] btrfs_alloc_inode+0x2d/0x250
[11914.620272] alloc_inode+0x1a/0xc0
[11914.620734] iget5_locked+0xba/0x110
[11914.621195] btrfs_iget+0x43/0xe0
[11914.621505] create_reloc_inode+0x19d/0x370
[11914.622051] btrfs_relocate_block_group+0x1b7/0x410
[11914.622827] btrfs_relocate_chunk+0x4c/0x190
[11914.623340] btrfs_balance+0x8e7/0x11d0
[11914.623802] btrfs_ioctl+0x1d3d/0x2900
[11914.624335] __x64_sys_ioctl+0x8b/0xc0
[11914.624716] do_syscall_64+0x38/0x90
[11914.625080] entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[11914.625563]
-> #1 (btrfs_trans_num_extwriters){++++}-{0:0}:
[11914.626172] join_transaction+0xdb/0x550
[11914.626573] start_transaction+0x24f/0x730
[11914.626977] btrfs_uuid_scan_kthread+0x2bc/0x3d0
[11914.627434] kthread+0xfc/0x130
[11914.627758] ret_from_fork+0x2d/0x50
[11914.628110] ret_from_fork_asm+0x1b/0x30
[11914.628505]
-> #0 (btrfs_trans_num_writers){++++}-{0:0}:
[11914.629084] __lock_acquire+0x1415/0x2190
[11914.629486] lock_acquire+0xc7/0x2b0
[11914.629841] join_transaction+0x1cd/0x550
[11914.630238] start_transaction+0x24f/0x730
[11914.630739] btrfs_commit_inode_delayed_inode+0x5f/0x120
[11914.631198] btrfs_evict_inode+0x273/0x3c0
[11914.631654] evict+0xcc/0x1d0
[11914.631973] inode_lru_isolate+0x14d/0x1e0
[11914.632355] __list_lru_walk_one+0xbe/0x1c0
[11914.632773] list_lru_walk_one+0x58/0x80
[11914.633139] prune_icache_sb+0x39/0x60
[11914.633503] super_cache_scan+0x161/0x1f0
[11914.633874] do_shrink_slab+0x163/0x340
[11914.634239] shrink_slab+0x1d7/0x2a0
[11914.634593] shrink_node+0x2eb/0x7b0
[11914.634946] balance_pgdat+0x344/0x780
[11914.635228] kswapd+0x205/0x410
[11914.635487] kthread+0xfc/0x130
[11914.635721] ret_from_fork+0x2d/0x50
[11914.636016] ret_from_fork_asm+0x1b/0x30
[11914.636349]
other info that might help us debug this:
[11914.637109] Chain exists of:
btrfs_trans_num_writers --> fs_reclaim --> sb_internal#2
[11914.638215] Possible unsafe locking scenario:
[11914.638903] CPU0 CPU1
[11914.639389] ---- ----
[11914.639864] rlock(sb_internal#2);
[11914.640218] lock(fs_reclaim);
[11914.640774] lock(sb_internal#2);
[11914.641329] rlock(btrfs_trans_num_writers);
[11914.641743]
*** DEADLOCK ***
[11914.642326] 4 locks held by kswapd0/47:
[11914.642708] #0: ffffffff9fe62280 (fs_reclaim){+.+.}-{0:0}, at: balance_pgdat+0x492/0x780
[11914.643513] #1: ffffffff9fe507d0 (shrinker_rwsem){++++}-{3:3}, at: shrink_slab+0x113/0x2a0
[11914.644291] #2: ffff8a3c300d20e0 (&type->s_umount_key#45){++++}-{3:3}, at: super_cache_scan+0x38/0x1f0
[11914.645032] #3: ffff8a3c300d2600 (sb_internal#2){++++}-{0:0}, at: btrfs_commit_inode_delayed_inode+0x5f/0x120
[11914.645944]
stack backtrace:
[11914.646342] CPU: 1 PID: 47 Comm: kswapd0 Not tainted 6.5.0-rc2+ #1248
[11914.646943] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[11914.647677] Call Trace:
[11914.648260]
[11914.648471] dump_stack_lvl+0x58/0x90
[11914.648808] check_noncircular+0x101/0x110
[11914.649158] __lock_acquire+0x1415/0x2190
[11914.649516] lock_acquire+0xc7/0x2b0
[11914.649852] ? join_transaction+0x19f/0x550
[11914.650213] ? lock_release+0x134/0x270
[11914.650737] join_transaction+0x1cd/0x550
[11914.651074] ? join_transaction+0x19f/0x550
[11914.651453] start_transaction+0x24f/0x730
[11914.651838] btrfs_commit_inode_delayed_inode+0x5f/0x120
[11914.652313] btrfs_evict_inode+0x273/0x3c0
[11914.652696] ? lock_release+0x134/0x270
[11914.653222] ? __pfx_wake_bit_function+0x10/0x10
[11914.653694] evict+0xcc/0x1d0
[11914.653965] inode_lru_isolate+0x14d/0x1e0
[11914.654427] __list_lru_walk_one+0xbe/0x1c0
[11914.654764] ? __pfx_inode_lru_isolate+0x10/0x10
[11914.655098] ? __pfx_inode_lru_isolate+0x10/0x10
[11914.655490] list_lru_walk_one+0x58/0x80
[11914.655796] prune_icache_sb+0x39/0x60
[11914.656128] super_cache_scan+0x161/0x1f0
[11914.656521] do_shrink_slab+0x163/0x340
[11914.656913] ? lock_is_held_type+0xe2/0x140
[11914.657344] shrink_slab+0x1d7/0x2a0
[11914.657709] shrink_node+0x2eb/0x7b0
[11914.658086] balance_pgdat+0x344/0x780
[11914.658451] kswapd+0x205/0x410
[11914.658717] ? __pfx_autoremove_wake_function+0x10/0x10
[11914.659257] ? __pfx_kswapd+0x10/0x10
[11914.659708] kthread+0xfc/0x130
[11914.660110] ? __pfx_kthread+0x10/0x10
[11914.660590] ret_from_fork+0x2d/0x50
[11914.661025] ? __pfx_kthread+0x10/0x10
[11914.661501] ret_from_fork_asm+0x1b/0x30
[11914.661974] RIP: 0000:0x0
[11914.662327] Code: Unable to access opcode bytes at 0xffffffffffffffd6.
[11914.663110] RSP: 0000:0000000000000000 EFLAGS: 00000000 ORIG_RAX: 0000000000000000
[11914.664031] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
[11914.664749] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
[11914.665718] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[11914.666221] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[11914.666991] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[11914.667678]
[12441.660261] BTRFS: device fsid 90d1dca2-db9e-446a-ad7e-5061588b6598 devid 1 transid 76 /dev/mapper/vg0-lv9 scanned by mount (1599323)
[12441.662601] BTRFS info (device dm-9): using crc32c (crc32c-intel) checksum algorithm
[12441.663258] BTRFS info (device dm-9): disk space caching is enabled
[12441.667420] BTRFS info (device dm-9): auto enabling async discard