[39323.898168] run fstests generic/619 at 2023-07-04 07:47:26
[39324.378132] BTRFS: device fsid 442e5b9d-ccad-458f-8dc7-acd1904d321e devid 1 transid 1253106 /dev/mapper/vg0-lv0 scanned by mount (1646501)
[39324.379246] BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
[39324.379252] BTRFS info (device dm-0): using free space tree
[39324.384626] BTRFS info (device dm-0): auto enabling async discard
[39324.838763] BTRFS: device fsid a61bb961-460c-4cee-8718-10b15888e0b0 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1646575)
[39324.858459] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39324.858468] BTRFS info (device dm-7): use zlib compression, level 3
[39324.858472] BTRFS info (device dm-7): using free space tree
[39324.864361] BTRFS info (device dm-7): auto enabling async discard
[39324.864482] BTRFS info (device dm-7): checking UUID tree
[39327.732323] BTRFS: device fsid ab9bb9cc-02dd-4821-978e-192aea1e74a2 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1646957)
[39327.753844] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39327.753852] BTRFS info (device dm-7): use zlib compression, level 3
[39327.753856] BTRFS info (device dm-7): using free space tree
[39327.758599] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (1645541)
[39327.760215] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (1645541)
[39327.792446] BTRFS info (device dm-7): auto enabling async discard
[39327.792569] BTRFS info (device dm-7): checking UUID tree
[39329.156989] ================================
[39329.157164] WARNING: inconsistent lock state
[39329.157340] 6.4.0-rc7+ #1229 Not tainted
[39329.157514] --------------------------------
[39329.157758] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage.
[39329.157961] kworker/u4:5/1597828 [HC0[0]:SC1[1]:HE1:SE0] takes:
[39329.158212] ffff93640f95cd20 (&fs_info->delayed_iput_lock){+.?.}-{2:2}, at: btrfs_add_delayed_iput+0x67/0xd0
[39329.158608] {SOFTIRQ-ON-W} state was registered at:
[39329.158865] lock_acquire+0xc7/0x2b0
[39329.159029] _raw_spin_lock+0x2f/0x40
[39329.159211] btrfs_run_delayed_iputs+0x22/0x80
[39329.159387] cleaner_kthread+0xe5/0x160
[39329.160784] kthread+0xfc/0x130
[39329.160943] ret_from_fork+0x29/0x50
[39329.161195] irq event stamp: 786856
[39329.161424] hardirqs last enabled at (786856): [] mod_lruvec_page_state+0x47/0x60
[39329.161782] hardirqs last disabled at (786855): [] mod_lruvec_page_state+0x34/0x60
[39329.162123] softirqs last enabled at (785702): [] __irq_exit_rcu+0xeb/0x160
[39329.162548] softirqs last disabled at (786499): [] __irq_exit_rcu+0xeb/0x160
[39329.162933]
other info that might help us debug this:
[39329.163214] Possible unsafe locking scenario:
[39329.163494] CPU0
[39329.163629] ----
[39329.163766] lock(&fs_info->delayed_iput_lock);
[39329.163939]
[39329.164075] lock(&fs_info->delayed_iput_lock);
[39329.164256]
*** DEADLOCK ***
[39329.164539] 2 locks held by kworker/u4:5/1597828:
[39329.164791] #0: ffff9363c0329538 ((wq_completion)writeback){+.+.}-{0:0}, at: process_one_work+0x1f4/0x530
[39329.165153] #1: ffffb89844a8be80 ((work_completion)(&(&wb->dwork)->work)){+.+.}-{0:0}, at: process_one_work+0x1f4/0x530
[39329.165501]
stack backtrace:
[39329.165757] CPU: 0 PID: 1597828 Comm: kworker/u4:5 Not tainted 6.4.0-rc7+ #1229
[39329.166064] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[39329.166359] Workqueue: writeback wb_workfn (flush-btrfs-7288)
[39329.166562] Call Trace:
[39329.166743]
[39329.166875] dump_stack_lvl+0x58/0x90
[39329.167045] mark_lock.part.0+0x697/0x820
[39329.167360] ? print_irq_inversion_bug.part.0+0x146/0x250
[39329.167683] __lock_acquire+0x7b0/0x2220
[39329.167949] ? __mod_node_page_state+0x91/0x100
[39329.168124] lock_acquire+0xc7/0x2b0
[39329.168300] ? btrfs_add_delayed_iput+0x67/0xd0
[39329.168543] ? __folio_end_writeback+0x5e/0x3f0
[39329.168864] _raw_spin_lock+0x2f/0x40
[39329.169050] ? btrfs_add_delayed_iput+0x67/0xd0
[39329.169266] btrfs_add_delayed_iput+0x67/0xd0
[39329.169444] btrfs_put_ordered_extent+0xc9/0x170
[39329.169760] clone_endio+0x10a/0x1c0
[39329.169935] blk_update_request+0x112/0x4c0
[39329.170145] blk_mq_end_request+0x1c/0x110
[39329.170367] blk_complete_reqs+0x3d/0x50
[39329.170646] __do_softirq+0xe6/0x45e
[39329.170810] __irq_exit_rcu+0xeb/0x160
[39329.171010] irq_exit_rcu+0xa/0x30
[39329.171227] common_interrupt+0xb8/0xd0
[39329.171451]
[39329.171601]
[39329.171768] asm_common_interrupt+0x22/0x40
[39329.171944] RIP: 0010:lock_release+0x159/0x270
[39329.172126] Code: e8 1c 24 de 00 b8 ff ff ff ff 65 0f c1 05 9f c6 de 7d 83 f8 01 0f 85 e0 00 00 00 41 f7 c5 00 02 00 00 74 06 fb 0f 1f 44 00 00 <48> 83 c4 10 5d 41 5c 41 5d 41 5e 41 5f c3 cc cc cc cc 65 8b 05 fa
[39329.172773] RSP: 0018:ffffb89844a8b980 EFLAGS: 00000206
[39329.172967] RAX: 0000000000000001 RBX: 0000000000000000 RCX: 0000000000000000
[39329.173193] RDX: 0000000000000002 RSI: ffffffff8392f3cc RDI: ffffffff839d4dd6
[39329.173421] RBP: ffffffff83d772c0 R08: 0000000000000000 R09: 0000000000000001
[39329.173651] R10: 0000000000000000 R11: 000000000003bc00 R12: ffff93640d2f8000
[39329.173878] R13: 0000000000000246 R14: ffffffff823fe12c R15: 0000000000000003
[39329.174108] ? folio_clear_dirty_for_io+0x16c/0x280
[39329.174302] folio_clear_dirty_for_io+0x184/0x280
[39329.174493] __extent_writepage_io+0x182/0x370
[39329.174680] ? writepage_delalloc+0x83/0x130
[39329.174858] extent_write_cache_pages+0x5c4/0x7d0
[39329.175047] extent_writepages+0x7b/0x130
[39329.175221] ? __pfx_end_bio_extent_writepage+0x10/0x10
[39329.175560] do_writepages+0xbf/0x190
[39329.175725] ? lock_release+0x134/0x270
[39329.175893] __writeback_single_inode+0x58/0x420
[39329.176080] writeback_sb_inodes+0x1f0/0x4d0
[39329.176257] wb_writeback+0xb7/0x320
[39329.176522] wb_workfn+0xc8/0x510
[39329.176683] ? lock_acquire+0xd7/0x2b0
[39329.176849] ? lock_release+0x134/0x270
[39329.177015] process_one_work+0x271/0x530
[39329.177185] worker_thread+0x52/0x3b0
[39329.177355] ? __pfx_worker_thread+0x10/0x10
[39329.177534] kthread+0xfc/0x130
[39329.177687] ? __pfx_kthread+0x10/0x10
[39329.177971] ret_from_fork+0x29/0x50
[39329.178140]
[39329.846414] BTRFS: device fsid 887f8b4d-0839-49e6-84a1-ec49271db729 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1647342)
[39329.877397] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39329.877671] BTRFS info (device dm-7): use zlib compression, level 3
[39329.877855] BTRFS info (device dm-7): using free space tree
[39329.906302] BTRFS info (device dm-7): auto enabling async discard
[39329.906651] BTRFS info (device dm-7): checking UUID tree
[39331.882106] BTRFS: device fsid 027513bd-364a-40e4-ae2b-1c1ea87ccbeb devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1647730)
[39331.913050] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39331.913378] BTRFS info (device dm-7): use zlib compression, level 3
[39331.913595] BTRFS info (device dm-7): using free space tree
[39331.929330] BTRFS info (device dm-7): auto enabling async discard
[39331.929719] BTRFS info (device dm-7): checking UUID tree
[39333.599001] BTRFS: device fsid ea40212d-3211-4f88-8651-156b5eb1e27c devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1647890)
[39333.632083] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (1645541)
[39333.632575] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39333.635644] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (1645541)
[39333.636212] BTRFS info (device dm-7): use zlib compression, level 3
[39333.636894] BTRFS info (device dm-7): using free space tree
[39333.639263] BTRFS info (device dm-7): auto enabling async discard
[39333.639591] BTRFS info (device dm-7): checking UUID tree
[39335.544703] BTRFS: device fsid e3070861-a667-4290-a592-36e125e79d68 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1648050)
[39335.573873] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39335.574225] BTRFS info (device dm-7): use zlib compression, level 3
[39335.574451] BTRFS info (device dm-7): using free space tree
[39335.576100] BTRFS info (device dm-7): auto enabling async discard
[39335.576468] BTRFS info (device dm-7): checking UUID tree
[39337.293839] BTRFS: device fsid 397fbf36-a1d1-4acb-a57a-b7ade3b23b46 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1648214)
[39337.327466] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (1645541)
[39337.327979] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39337.328237] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (1645541)
[39337.328270] BTRFS info (device dm-7): use zlib compression, level 3
[39337.328758] BTRFS info (device dm-7): using free space tree
[39337.330540] BTRFS info (device dm-7): auto enabling async discard
[39337.330805] BTRFS info (device dm-7): checking UUID tree
[39339.229221] BTRFS: device fsid a153488d-d956-422c-94d9-dd467d9f4666 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1648429)
[39339.266100] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39339.266427] BTRFS info (device dm-7): use zlib compression, level 3
[39339.266637] BTRFS info (device dm-7): using free space tree
[39339.269036] BTRFS info (device dm-7): auto enabling async discard
[39339.269350] BTRFS info (device dm-7): checking UUID tree
[39340.881557] BTRFS: device fsid 720ecbc0-9d9e-41e0-aa7f-1c3a66b0a711 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1648644)
[39340.892179] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39340.892452] BTRFS info (device dm-7): use zlib compression, level 3
[39340.892630] BTRFS info (device dm-7): using free space tree
[39340.896144] BTRFS info (device dm-7): auto enabling async discard
[39340.896423] BTRFS info (device dm-7): checking UUID tree
[39342.674916] BTRFS: device fsid 18cd37ea-c428-4b3a-8f7d-324443618d67 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1648860)
[39342.688323] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39342.688585] BTRFS info (device dm-7): use zlib compression, level 3
[39342.688781] BTRFS info (device dm-7): using free space tree
[39342.692109] BTRFS info (device dm-7): auto enabling async discard
[39342.692419] BTRFS info (device dm-7): checking UUID tree
[39345.332160] BTRFS: device fsid ba44a57f-a6e9-4f60-9d12-e515082ec550 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1649239)
[39345.344302] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39345.344635] BTRFS info (device dm-7): use zlib compression, level 3
[39345.344851] BTRFS info (device dm-7): using free space tree
[39345.349592] BTRFS info (device dm-7): auto enabling async discard
[39345.349917] BTRFS info (device dm-7): checking UUID tree
[39348.548478] BTRFS: device fsid 93a0a0a7-1bdf-4683-8060-ad6e9f60de80 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1649618)
[39348.560155] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39348.560476] BTRFS info (device dm-7): use zlib compression, level 3
[39348.560695] BTRFS info (device dm-7): using free space tree
[39348.564130] BTRFS info (device dm-7): auto enabling async discard
[39348.564519] BTRFS info (device dm-7): checking UUID tree
[39350.457627] BTRFS: device fsid 77f58668-93ac-4269-83a7-31dfbd4e6f72 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1649998)
[39350.468771] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39350.469130] BTRFS info (device dm-7): use zlib compression, level 3
[39350.469368] BTRFS info (device dm-7): using free space tree
[39350.472064] BTRFS info (device dm-7): auto enabling async discard
[39350.472438] BTRFS info (device dm-7): checking UUID tree
[39351.519358] BTRFS: device fsid 1cf8b2d9-dee3-4612-a836-4302c93b1a34 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1650158)
[39351.539594] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39351.539870] BTRFS info (device dm-7): use zlib compression, level 3
[39351.540072] BTRFS info (device dm-7): using free space tree
[39351.541844] BTRFS info (device dm-7): auto enabling async discard
[39351.542156] BTRFS info (device dm-7): checking UUID tree
[39352.482961] BTRFS: device fsid 4a6f41ca-bf82-421c-93ef-aa937c32eddf devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1650319)
[39352.506089] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39352.506489] BTRFS info (device dm-7): use zlib compression, level 3
[39352.506772] BTRFS info (device dm-7): using free space tree
[39352.515143] BTRFS info (device dm-7): auto enabling async discard
[39352.515485] BTRFS info (device dm-7): checking UUID tree
[39353.551853] BTRFS: device fsid f7e36c6b-a479-412f-aa30-9e52637b42d8 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1650480)
[39353.564269] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39353.564551] BTRFS info (device dm-7): use zlib compression, level 3
[39353.564813] BTRFS info (device dm-7): using free space tree
[39353.568007] BTRFS info (device dm-7): auto enabling async discard
[39353.568309] BTRFS info (device dm-7): checking UUID tree
[39354.828142] BTRFS: device fsid e487393a-2a30-41c6-93a8-d5496d0628f1 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1650695)
[39354.837336] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39354.837604] BTRFS info (device dm-7): use zlib compression, level 3
[39354.837789] BTRFS info (device dm-7): using free space tree
[39354.843057] BTRFS info (device dm-7): auto enabling async discard
[39354.843365] BTRFS info (device dm-7): checking UUID tree
[39356.088873] BTRFS: device fsid 1e7a45ed-d53e-4a3a-9545-18d9edad777b devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1650910)
[39356.099687] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[39356.100138] BTRFS info (device dm-7): use zlib compression, level 3
[39356.100429] BTRFS info (device dm-7): using free space tree
[39356.104980] BTRFS info (device dm-7): auto enabling async discard
[39356.105330] BTRFS info (device dm-7): checking UUID tree