[ 871.556983] run fstests btrfs/003 at 2023-09-15 21:06:25
[ 871.945642] BTRFS: device fsid 442e5b9d-ccad-458f-8dc7-acd1904d321e devid 1 transid 1551519 /dev/mapper/vg0-lv0 scanned by mount (22063)
[ 871.946720] BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
[ 871.946727] BTRFS info (device dm-0): using free space tree
[ 871.951072] BTRFS info (device dm-0): auto enabling async discard
[ 873.043684] BTRFS: device fsid 9af00a19-069f-41a4-9e99-ba6b69eaf98d devid 1 transid 6 /dev/dm-7 scanned by systemd-udevd (22313)
[ 873.056892] BTRFS: device fsid 9af00a19-069f-41a4-9e99-ba6b69eaf98d devid 2 transid 6 /dev/mapper/vg0-lv6 scanned by mkfs.btrfs (22304)
[ 873.057051] BTRFS: device fsid 9af00a19-069f-41a4-9e99-ba6b69eaf98d devid 3 transid 6 /dev/mapper/vg0-lv5 scanned by mkfs.btrfs (22304)
[ 873.057323] BTRFS: device fsid 9af00a19-069f-41a4-9e99-ba6b69eaf98d devid 4 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (22304)
[ 873.057874] BTRFS: device fsid 9af00a19-069f-41a4-9e99-ba6b69eaf98d devid 5 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (22304)
[ 873.058264] BTRFS: device fsid 9af00a19-069f-41a4-9e99-ba6b69eaf98d devid 6 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (22304)
[ 873.058535] BTRFS: device fsid 9af00a19-069f-41a4-9e99-ba6b69eaf98d devid 7 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (22304)
[ 873.074398] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[ 873.074408] BTRFS info (device dm-7): using free space tree
[ 873.080323] BTRFS info (device dm-7): auto enabling async discard
[ 873.080483] BTRFS info (device dm-7): checking UUID tree
[ 873.087577] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (21870)
[ 873.091668] BTRFS info: devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (21915)
[ 873.091875] BTRFS info: devid 4 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (21917)
[ 873.093938] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (21870)
[ 873.094982] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (21915)
[ 873.105068] BTRFS info: devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (21917)
[ 873.113885] BTRFS info: devid 6 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (22313)
[ 873.117158] BTRFS info: devid 7 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (22308)
[ 873.122453] BTRFS info: devid 6 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (22313)
[ 873.126064] BTRFS info: devid 5 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (21925)
[ 873.132420] BTRFS info: devid 7 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (22308)
[ 873.134478] BTRFS info: devid 5 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (21925)
[ 873.214574] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22310)
[ 873.217213] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22310)
[ 873.284971] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22313)
[ 873.288006] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22313)
[ 873.331726] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22313)
[ 873.335480] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22313)
[ 876.990364] BTRFS: device fsid ad725fd6-c2e2-493b-ae54-1c9daa659d72 devid 1 transid 6 /dev/dm-7 scanned by systemd-udevd (22313)
[ 877.005445] BTRFS: device fsid ad725fd6-c2e2-493b-ae54-1c9daa659d72 devid 3 transid 6 /dev/dm-5 scanned by systemd-udevd (21915)
[ 877.015690] BTRFS: device fsid ad725fd6-c2e2-493b-ae54-1c9daa659d72 devid 2 transid 6 /dev/mapper/vg0-lv6 scanned by mkfs.btrfs (23959)
[ 877.018354] BTRFS: device fsid ad725fd6-c2e2-493b-ae54-1c9daa659d72 devid 4 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (23959)
[ 877.024781] BTRFS: device fsid ad725fd6-c2e2-493b-ae54-1c9daa659d72 devid 5 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (23959)
[ 877.025107] BTRFS: device fsid ad725fd6-c2e2-493b-ae54-1c9daa659d72 devid 6 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (23959)
[ 877.025982] BTRFS: device fsid ad725fd6-c2e2-493b-ae54-1c9daa659d72 devid 7 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (23959)
[ 877.044284] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[ 877.044295] BTRFS info (device dm-7): using free space tree
[ 877.046974] BTRFS info: devid 4 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (21917)
[ 877.047108] BTRFS info: devid 6 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (21925)
[ 877.049954] BTRFS info: devid 6 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (21925)
[ 877.052593] BTRFS info: devid 5 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (22313)
[ 877.054192] BTRFS info (device dm-7): auto enabling async discard
[ 877.054263] BTRFS info: devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (21917)
[ 877.054734] BTRFS info (device dm-7): checking UUID tree
[ 877.061280] BTRFS info: devid 5 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (22313)
[ 877.066924] BTRFS info: devid 7 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (22308)
[ 877.069996] BTRFS info: devid 7 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (22308)
[ 877.170300] BTRFS info: devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (21870)
[ 877.171687] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (21915)
[ 877.173788] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (21915)
[ 877.175955] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (21870)
[ 877.230768] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22313)
[ 877.235971] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22313)
[ 877.251938] BTRFS info: devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (21870)
[ 877.257386] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (21870)
[ 877.293125] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22313)
[ 877.296108] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22313)
[ 877.326347] BTRFS info: devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (21870)
[ 877.329573] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (21870)
[ 877.350627] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22313)
[ 877.354602] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22313)
[ 877.395122] BTRFS info: devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (21870)
[ 877.398689] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (21870)
[ 881.323286] BTRFS: device fsid db01c130-294e-4aae-bd19-6a93da2f2362 devid 1 transid 6 /dev/dm-7 scanned by systemd-udevd (22313)
[ 881.336762] BTRFS: device fsid db01c130-294e-4aae-bd19-6a93da2f2362 devid 3 transid 6 /dev/dm-5 scanned by systemd-udevd (21915)
[ 881.341238] BTRFS: device fsid db01c130-294e-4aae-bd19-6a93da2f2362 devid 2 transid 6 /dev/dm-6 scanned by systemd-udevd (21870)
[ 881.347830] BTRFS: device fsid db01c130-294e-4aae-bd19-6a93da2f2362 devid 5 transid 6 /dev/dm-3 scanned by systemd-udevd (22313)
[ 881.355379] BTRFS: device fsid db01c130-294e-4aae-bd19-6a93da2f2362 devid 4 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (25625)
[ 881.356420] BTRFS: device fsid db01c130-294e-4aae-bd19-6a93da2f2362 devid 6 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (25625)
[ 881.357307] BTRFS: device fsid db01c130-294e-4aae-bd19-6a93da2f2362 devid 7 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (25625)
[ 881.373836] BTRFS info: devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (21917)
[ 881.374480] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[ 881.374488] BTRFS info (device dm-7): using free space tree
[ 881.379531] BTRFS info (device dm-7): auto enabling async discard
[ 881.379696] BTRFS info (device dm-7): checking UUID tree
[ 881.388616] BTRFS info: devid 6 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (21870)
[ 881.390525] BTRFS info: devid 7 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (21915)
[ 881.391957] BTRFS info: devid 6 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (21870)
[ 881.394593] BTRFS info: devid 7 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (21915)
[ 881.469493] BTRFS info: devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (22313)
[ 881.474923] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (22313)
[ 881.481451] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (21925)
[ 881.485046] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (21925)
[ 881.493331] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22308)
[ 881.499029] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22308)
[ 881.569039] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (21870)
[ 881.577612] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (21870)
[ 881.594225] BTRFS info: devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (22313)
[ 881.598524] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (22313)
[ 881.600987] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (21915)
[ 881.614240] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (21915)
[ 881.646451] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (21870)
[ 881.650024] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (21870)
[ 881.706612] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (22313)
[ 881.710293] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (22313)
[ 885.469150] BTRFS: device fsid b28725a9-9670-436e-93af-a8c6c26979a9 devid 1 transid 6 /dev/dm-7 scanned by systemd-udevd (22313)
[ 885.484696] BTRFS: device fsid b28725a9-9670-436e-93af-a8c6c26979a9 devid 2 transid 6 /dev/dm-6 scanned by systemd-udevd (21870)
[ 885.492386] BTRFS: device fsid b28725a9-9670-436e-93af-a8c6c26979a9 devid 4 transid 6 /dev/dm-4 scanned by systemd-udevd (21917)
[ 885.500265] BTRFS: device fsid b28725a9-9670-436e-93af-a8c6c26979a9 devid 3 transid 6 /dev/mapper/vg0-lv5 scanned by mkfs.btrfs (27249)
[ 885.504593] BTRFS: device fsid b28725a9-9670-436e-93af-a8c6c26979a9 devid 5 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (27249)
[ 885.505208] BTRFS: device fsid b28725a9-9670-436e-93af-a8c6c26979a9 devid 6 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (27249)
[ 885.505476] BTRFS: device fsid b28725a9-9670-436e-93af-a8c6c26979a9 devid 7 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (27249)
[ 885.529625] BTRFS info: devid 6 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (22313)
[ 885.532039] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[ 885.532056] BTRFS info (device dm-7): using free space tree
[ 885.536126] BTRFS info: devid 6 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (22313)
[ 885.538686] BTRFS info: devid 7 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (21870)
[ 885.543069] BTRFS info (device dm-7): auto enabling async discard
[ 885.543201] BTRFS info (device dm-7): checking UUID tree
[ 885.546589] BTRFS info: devid 7 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (21870)
[ 885.602503] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22308)
[ 885.608415] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22308)
[ 885.620244] BTRFS info: devid 4 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (21915)
[ 885.622836] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (21917)
[ 885.628809] BTRFS info: devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (21915)
[ 885.631353] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (21917)
[ 885.686178] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22313)
[ 885.689175] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22313)
[ 885.729396] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (21915)
[ 885.730538] BTRFS info: devid 4 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (21870)
[ 885.735588] BTRFS info: devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (21870)
[ 885.738775] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (21915)
[ 885.758760] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (22313)
[ 885.761810] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (22313)
[ 885.817873] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (21915)
[ 885.818123] BTRFS info: devid 4 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (21870)
[ 885.822396] BTRFS info: devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (21870)
[ 885.828703] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (21915)
[ 888.807593] BTRFS: device fsid 997cd373-c8dd-481f-9520-4731ecead6b6 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mount (28887)
[ 888.809670] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[ 888.809682] BTRFS info (device dm-7): using free space tree
[ 888.820696] BTRFS info (device dm-7): auto enabling async discard
[ 888.820881] BTRFS info (device dm-7): checking UUID tree
[ 891.903338] BTRFS info (device dm-7): disk added /dev/mapper/vg0-lv5
[ 891.983436] BTRFS info (device dm-7): disk added /dev/mapper/vg0-lv4
[ 892.067148] BTRFS info (device dm-7): disk added /dev/mapper/vg0-lv3
[ 892.136181] BTRFS info (device dm-7): disk added /dev/mapper/vg0-lv2
[ 892.215233] BTRFS info (device dm-7): disk added /dev/mapper/vg0-lv1
[ 892.283472] BTRFS info (device dm-7): balance: start -d -m -s
[ 892.286266] BTRFS info (device dm-7): relocating block group 30408704 flags metadata|dup
[ 892.380070] BTRFS info (device dm-7): found 10 extents, stage: move data extents
[ 892.446270] BTRFS info (device dm-7): relocating block group 22020096 flags system|dup
[ 892.509761] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[ 892.554570] BTRFS info (device dm-7): relocating block group 13631488 flags data
[ 892.650112] BTRFS info (device dm-7): found 220 extents, stage: move data extents
[ 892.778600] BTRFS info (device dm-7): found 220 extents, stage: update data pointers
[ 892.839247] BTRFS info (device dm-7): balance: ended with status: 0
[ 893.676869] BTRFS: device fsid 24550143-dd74-4d7c-a5ab-9823b9d1efb8 devid 1 transid 6 /dev/dm-7 scanned by systemd-udevd (22313)
[ 893.679999] BTRFS: device fsid 24550143-dd74-4d7c-a5ab-9823b9d1efb8 devid 2 transid 6 /dev/mapper/vg0-lv6 scanned by mkfs.btrfs (30503)
[ 893.680165] BTRFS: device fsid 24550143-dd74-4d7c-a5ab-9823b9d1efb8 devid 3 transid 6 /dev/mapper/vg0-lv5 scanned by mkfs.btrfs (30503)
[ 893.681867] BTRFS: device fsid 24550143-dd74-4d7c-a5ab-9823b9d1efb8 devid 4 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (30503)
[ 893.682057] BTRFS: device fsid 24550143-dd74-4d7c-a5ab-9823b9d1efb8 devid 5 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (30503)
[ 893.682959] BTRFS: device fsid 24550143-dd74-4d7c-a5ab-9823b9d1efb8 devid 6 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (30503)
[ 893.684045] BTRFS: device fsid 24550143-dd74-4d7c-a5ab-9823b9d1efb8 devid 7 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (30503)
[ 893.708106] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[ 893.708116] BTRFS info (device dm-7): using free space tree
[ 893.709761] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (21870)
[ 893.714118] BTRFS info (device dm-7): auto enabling async discard
[ 893.714417] BTRFS info (device dm-7): checking UUID tree
[ 893.725933] BTRFS info: devid 7 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (22310)
[ 893.726742] BTRFS info: devid 5 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (21925)
[ 893.728271] BTRFS info: devid 7 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (22310)
[ 893.751140] BTRFS info: devid 4 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (21917)
[ 893.752583] BTRFS info: devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (21915)
[ 893.754090] BTRFS info: devid 5 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (21925)
[ 893.759479] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (21915)
[ 893.763750] BTRFS info: devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (21917)
[ 893.766204] BTRFS info: devid 6 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (22308)
[ 893.771508] BTRFS info: devid 6 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (22308)
[ 896.484049] ======================================================
[ 896.484197] WARNING: possible circular locking dependency detected
[ 896.484347] 6.6.0-rc1+ #1303 Not tainted
[ 896.484458] ------------------------------------------------------
[ 896.484605] btrfs/32120 is trying to acquire lock:
[ 896.484732] ffff8eaa826d5600 (sb_internal){.+.+}-{0:0}, at: btrfs_shrink_device+0x141/0x630
[ 896.484941]
but task is already holding lock:
[ 896.485081] ffff8eaa908fc8f8 (&fs_info->chunk_mutex){+.+.}-{3:3}, at: btrfs_shrink_device+0xf1/0x630
[ 896.485283]
which lock already depends on the new lock.
[ 896.485461]
the existing dependency chain (in reverse order) is:
[ 896.485627]
-> #3 (&fs_info->chunk_mutex){+.+.}-{3:3}:
[ 896.485782] __mutex_lock+0x75/0xcd0
[ 896.485908] btrfs_chunk_alloc+0x14d/0x690
[ 896.486080] find_free_extent+0xceb/0x1670
[ 896.486246] btrfs_reserve_extent+0x13a/0x250
[ 896.486409] cow_file_range+0x154/0x5b0
[ 896.486571] btrfs_run_delalloc_range+0x109/0x530
[ 896.486743] writepage_delalloc+0x7d/0x110
[ 896.486911] extent_write_cache_pages+0x5f5/0x820
[ 896.487082] extent_writepages+0x7b/0x130
[ 896.487237] do_writepages+0xbf/0x190
[ 896.487400] filemap_fdatawrite_wbc+0x66/0x90
[ 896.487568] start_delalloc_inodes+0x119/0x3e0
[ 896.487733] btrfs_start_delalloc_roots+0x182/0x280
[ 896.487908] flush_space+0x1cd/0x5a0
[ 896.488057] btrfs_async_reclaim_metadata_space+0x130/0x310
[ 896.488245] process_one_work+0x1ff/0x4e0
[ 896.488415] worker_thread+0x1d8/0x3d0
[ 896.488568] kthread+0xfc/0x130
[ 896.488716] ret_from_fork+0x2d/0x50
[ 896.488876] ret_from_fork_asm+0x1b/0x30
[ 896.489043]
-> #2 (btrfs_trans_num_extwriters){++++}-{0:0}:
[ 896.489284] join_transaction+0xb4/0x590
[ 896.489444] start_transaction+0x1a0/0xad0
[ 896.489604] btrfs_dirty_inode+0x40/0xd0
[ 896.489761] touch_atime+0x133/0x220
[ 896.489926] filemap_read+0x2f0/0x300
[ 896.490082] vfs_read+0x19e/0x2e0
[ 896.490237] ksys_read+0x55/0xd0
[ 896.490381] do_syscall_64+0x38/0x90
[ 896.490538] entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 896.490722]
-> #1 (btrfs_trans_num_writers){++++}-{0:0}:
[ 896.490961] join_transaction+0x87/0x590
[ 896.491123] start_transaction+0x1a0/0xad0
[ 896.491285] btrfs_dirty_inode+0x40/0xd0
[ 896.491442] touch_atime+0x133/0x220
[ 896.491591] filemap_read+0x2f0/0x300
[ 896.491748] vfs_read+0x19e/0x2e0
[ 896.491902] ksys_read+0x55/0xd0
[ 896.492048] do_syscall_64+0x38/0x90
[ 896.492202] entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 896.492380]
-> #0 (sb_internal){.+.+}-{0:0}:
[ 896.492606] __lock_acquire+0x1415/0x2190
[ 896.492787] lock_acquire+0xc7/0x2b0
[ 896.492944] start_transaction+0x493/0xad0
[ 896.493104] btrfs_shrink_device+0x141/0x630
[ 896.493265] btrfs_rm_device+0x18e/0x7e0
[ 896.493427] btrfs_ioctl+0x135c/0x2930
[ 896.493583] __x64_sys_ioctl+0x8b/0xc0
[ 896.493739] do_syscall_64+0x38/0x90
[ 896.493892] entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 896.494070]
other info that might help us debug this:
[ 896.494361] Chain exists of:
sb_internal --> btrfs_trans_num_extwriters --> &fs_info->chunk_mutex
[ 896.494766] Possible unsafe locking scenario:
[ 896.494990] CPU0 CPU1
[ 896.495148] ---- ----
[ 896.495304] lock(&fs_info->chunk_mutex);
[ 896.495452] lock(btrfs_trans_num_extwriters);
[ 896.495656] lock(&fs_info->chunk_mutex);
[ 896.495851] rlock(sb_internal);
[ 896.495994]
*** DEADLOCK ***
[ 896.496249] 2 locks held by btrfs/32120:
[ 896.496395] #0: ffff8eaa826d5410 (sb_writers#10){.+.+}-{0:0}, at: btrfs_ioctl+0x1316/0x2930
[ 896.496668] #1: ffff8eaa908fc8f8 (&fs_info->chunk_mutex){+.+.}-{3:3}, at: btrfs_shrink_device+0xf1/0x630
[ 896.496955]
stack backtrace:
[ 896.497147] CPU: 0 PID: 32120 Comm: btrfs Not tainted 6.6.0-rc1+ #1303
[ 896.497340] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 896.497614] Call Trace:
[ 896.497735]
[ 896.497853] dump_stack_lvl+0x58/0x90
[ 896.498012] check_noncircular+0x101/0x110
[ 896.498163] ? lockdep_unlock+0x5f/0xd0
[ 896.498309] ? __lock_acquire+0x11f1/0x2190
[ 896.498466] __lock_acquire+0x1415/0x2190
[ 896.498621] lock_acquire+0xc7/0x2b0
[ 896.498763] ? btrfs_shrink_device+0x141/0x630
[ 896.498928] start_transaction+0x493/0xad0
[ 896.499083] ? btrfs_shrink_device+0x141/0x630
[ 896.499240] btrfs_shrink_device+0x141/0x630
[ 896.499394] ? __mutex_unlock_slowpath+0x35/0x260
[ 896.499561] btrfs_rm_device+0x18e/0x7e0
[ 896.499714] btrfs_ioctl+0x135c/0x2930
[ 896.499870] ? __x64_sys_ioctl+0x8b/0xc0
[ 896.500021] __x64_sys_ioctl+0x8b/0xc0
[ 896.500173] do_syscall_64+0x38/0x90
[ 896.500319] entry_SYSCALL_64_after_hwframe+0x6e/0xd8
[ 896.500487] RIP: 0033:0x7f9e08bb40ab
[ 896.501316] Code: ff ff ff 85 c0 79 9b 49 c7 c4 ff ff ff ff 5b 5d 4c 89 e0 41 5c c3 66 0f 1f 84 00 00 00 00 00 f3 0f 1e fa b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 95 bd 0c 00 f7 d8 64 89 01 48
[ 896.501812] RSP: 002b:00007ffcc5eea078 EFLAGS: 00000202 ORIG_RAX: 0000000000000010
[ 896.502067] RAX: ffffffffffffffda RBX: 00007ffcc5eec260 RCX: 00007f9e08bb40ab
[ 896.502270] RDX: 00007ffcc5eeb090 RSI: 000000005000943a RDI: 0000000000000003
[ 896.502475] RBP: 0000000000000000 R08: 0000000000000010 R09: 00007f9e08c444e0
[ 896.502679] R10: 0000000000000022 R11: 0000000000000202 R12: 00007ffcc5eec260
[ 896.502887] R13: 0000000000000000 R14: 0000000000000003 R15: 00007ffcc5eec268
[ 896.503095]
[ 896.503507] BTRFS info (device dm-7): relocating block group 30408704 flags metadata|raid1
[ 896.533737] BTRFS info (device dm-7): found 10 extents, stage: move data extents
[ 896.560238] BTRFS info (device dm-7): relocating block group 22020096 flags system|raid1
[ 896.588041] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[ 896.638148] BTRFS info (device dm-7): device deleted: /dev/mapper/vg0-lv1