[18328.319605] run fstests btrfs/056 at 2022-04-04 01:56:52
[18328.542135] BTRFS info (device dm-0): flagging fs with big metadata feature
[18328.542362] BTRFS info (device dm-0): using free space tree
[18328.542548] BTRFS info (device dm-0): has skinny extents
[18328.749604] BTRFS: device fsid f290a4fc-9948-4be4-80fe-c4bf5350f752 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2979392)
[18328.815599] BTRFS info (device dm-11): flagging fs with big metadata feature
[18328.815826] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[18328.816090] BTRFS info (device dm-11): use zstd compression, level 3
[18328.816316] BTRFS info (device dm-11): turning on async discard
[18328.816501] BTRFS info (device dm-11): disk space caching is enabled
[18328.816706] BTRFS info (device dm-11): has skinny extents
[18328.818346] BTRFS info (device dm-11): checking UUID tree
[18328.959601] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2976006)
[18328.960403] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2976006)
[18329.022883] BTRFS info (device dm-11): flagging fs with big metadata feature
[18329.023131] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[18329.023396] BTRFS info (device dm-11): use zstd compression, level 3
[18329.023590] BTRFS info (device dm-11): turning on async discard
[18329.023771] BTRFS info (device dm-11): disk space caching is enabled
[18329.023956] BTRFS info (device dm-11): has skinny extents
[18329.025521] BTRFS info (device dm-11): start tree-log replay
[18329.036507] BTRFS info (device dm-11): checking UUID tree
[18329.112127] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[18329.112425] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 2979529, name: mkfs.btrfs
[18329.112696] preempt_count: 100, expected: 0
[18329.112860] RCU nest depth: 0, expected: 0
[18329.113013] INFO: lockdep is turned off.
[18329.113181] Preemption disabled at:
[18329.113181] [] __do_softirq+0x5e/0x517
[18329.113558] CPU: 1 PID: 2979529 Comm: mkfs.btrfs Tainted: G W 5.17.0+ #641
[18329.114061] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[18329.114407] Call Trace:
[18329.114609]
[18329.114781] dump_stack_lvl+0x56/0x6f
[18329.114975] __might_resched.cold+0xff/0x13a
[18329.115169] blk_release_queue+0x24/0x120
[18329.115347] kobject_put+0x7c/0x1d0
[18329.115552] ? rcu_do_batch+0x1ac/0x570
[18329.115703] blkg_free.part.0+0x41/0x60
[18329.115877] rcu_do_batch+0x1e1/0x570
[18329.116076] ? rcu_do_batch+0x1ac/0x570
[18329.116279] rcu_core+0x2cb/0x460
[18329.116480] __do_softirq+0x178/0x517
[18329.116636] __irq_exit_rcu+0xe3/0x160
[18329.116787] irq_exit_rcu+0xa/0x20
[18329.116930] sysvec_apic_timer_interrupt+0xa2/0xd0
[18329.117100]
[18329.117261]
[18329.117406] asm_sysvec_apic_timer_interrupt+0x12/0x20
[18329.117662] RIP: 0010:do_user_addr_fault+0x2ba/0x6b0
[18329.117835] Code: 01 00 00 48 83 c4 18 4c 89 ea 48 89 ee 4c 89 e7 5b 5d 41 5c 41 5d 41 5e 41 5f e9 b1 fb ff ff e8 9c 79 1a 00 fb 0f 1f 44 00 00 54 02 00 00 e9 31 fe ff ff 0f 0b e9 4c ff ff ff 31 f6 4c 89 f7
[18329.118325] RSP: 0000:ffffb12643d0fee0 EFLAGS: 00000246
[18329.118497] RAX: 0000000080000000 RBX: 0000000000000000 RCX: 0000000000000000
[18329.118702] RDX: 00007f4678254000 RSI: 0000000000000006 RDI: ffffffffa21048b4
[18329.118923] RBP: 0000000000000006 R08: 0000000000000000 R09: 0000000000000000
[18329.119155] R10: 0000000000000000 R11: 0000000000000000 R12: ffffb12643d0ff58
[18329.119373] R13: 00007f4678254000 R14: ffff9be2d48b9a00 R15: 0000000000000000
[18329.119586] ? do_user_addr_fault+0x2b4/0x6b0
[18329.119751] exc_page_fault+0x78/0x280
[18329.119902] ? asm_exc_page_fault+0x8/0x30
[18329.120055] asm_exc_page_fault+0x1e/0x30
[18329.120205] RIP: 0033:0x7f4678432411
[18329.120354] Code: 01 00 00 48 83 fa 40 77 77 c5 fe 7f 44 17 e0 c5 fe 7f 07 c5 f8 77 c3 66 90 f3 0f 1e fa c5 f8 77 48 89 d1 40 0f b6 c6 48 89 fa aa 48 89 d0 c3 66 0f 1f 84 00 00 00 00 00 f3 0f 1e fa 48 39 d1
[18329.120884] RSP: 002b:00007ffdc77b8908 EFLAGS: 00010206
[18329.121071] RAX: 0000000000000000 RBX: 00007f46780ac010 RCX: 0000000000058010
[18329.121279] RDX: 00007f46780ac010 RSI: 0000000000000000 RDI: 00007f4678254000
[18329.121484] RBP: 0000000000200000 R08: 00007f46780ac010 R09: 0000000000000000
[18329.121698] R10: fffffffffffffb0c R11: 00007f4678432430 R12: 0000000000000000
[18329.121905] R13: 0000000000000003 R14: 0000000000000000 R15: 0000000000000000
[18329.122115]
[18329.233982] BTRFS: device fsid d0008cfd-8a50-43f2-bcbc-eaf9ba2f8aec devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2979529)
[18329.299889] BTRFS info (device dm-11): flagging fs with big metadata feature
[18329.300136] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[18329.300413] BTRFS info (device dm-11): use zstd compression, level 3
[18329.300613] BTRFS info (device dm-11): turning on async discard
[18329.300797] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[18329.301061] BTRFS info (device dm-11): force lzo compression, level 0
[18329.301276] BTRFS info (device dm-11): disk space caching is enabled
[18329.301474] BTRFS info (device dm-11): has skinny extents
[18329.302954] BTRFS info (device dm-11): checking UUID tree
[18329.487196] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2976006)
[18329.487960] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2976006)
[18329.559527] BTRFS info (device dm-11): flagging fs with big metadata feature
[18329.559767] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[18329.560020] BTRFS info (device dm-11): use zstd compression, level 3
[18329.560228] BTRFS info (device dm-11): turning on async discard
[18329.560408] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[18329.560677] BTRFS info (device dm-11): force lzo compression, level 0
[18329.560860] BTRFS info (device dm-11): disk space caching is enabled
[18329.561043] BTRFS info (device dm-11): has skinny extents
[18329.562664] BTRFS info (device dm-11): start tree-log replay
[18329.579463] BTRFS info (device dm-11): checking UUID tree
[18329.794927] BTRFS: device fsid bbcb6f00-2d44-49a8-8b6a-4bd8d0a8c1c7 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2979668)
[18329.867504] BTRFS info (device dm-11): flagging fs with big metadata feature
[18329.867746] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[18329.868006] BTRFS info (device dm-11): use zstd compression, level 3
[18329.868216] BTRFS info (device dm-11): turning on async discard
[18329.868395] BTRFS info (device dm-11): disk space caching is enabled
[18329.868620] BTRFS info (device dm-11): has skinny extents
[18330.187110] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[18330.187420] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 2976006, name: systemd-udevd
[18330.187772] preempt_count: 100, expected: 0
[18330.187963] RCU nest depth: 0, expected: 0
[18330.188143] INFO: lockdep is turned off.
[18330.188305] Preemption disabled at:
[18330.188306] [] __do_softirq+0x5e/0x517
[18330.188702] CPU: 0 PID: 2976006 Comm: systemd-udevd Tainted: G W 5.17.0+ #641
[18330.189003] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[18330.189285] Call Trace:
[18330.189422]
[18330.189554] dump_stack_lvl+0x56/0x6f
[18330.189704] __might_resched.cold+0xff/0x13a
[18330.189861] blk_release_queue+0x24/0x120
[18330.190016] kobject_put+0x7c/0x1d0
[18330.190156] ? rcu_do_batch+0x1ac/0x570
[18330.190310] blkg_free.part.0+0x41/0x60
[18330.190455] rcu_do_batch+0x1e1/0x570
[18330.190602] ? rcu_do_batch+0x1ac/0x570
[18330.190751] rcu_core+0x2cb/0x460
[18330.190890] __do_softirq+0x178/0x517
[18330.191034] __irq_exit_rcu+0xe3/0x160
[18330.191183] irq_exit_rcu+0xa/0x20
[18330.191322] sysvec_apic_timer_interrupt+0x54/0xd0
[18330.191483] ? asm_sysvec_apic_timer_interrupt+0xa/0x20
[18330.191660] asm_sysvec_apic_timer_interrupt+0x12/0x20
[18330.191832] RIP: 0033:0x7fe1321975a0
[18330.191975] Code: 8d 35 5c 93 05 00 e8 ff db eb ff 0f 1f 80 00 00 00 00 b8 e7 ff ff ff 48 83 c4 08 c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 <41> 57 41 56 41 55 41 54 55 53 48 83 ec 18 64 48 8b 04 25 28 00 00
[18330.192446] RSP: 002b:00007ffd60e19168 EFLAGS: 00000202
[18330.198428] RAX: 00007ffd60e191b8 RBX: 000055a021e47fe0 RCX: 00007ffd60e18d20
[18330.198643] RDX: 0000000000000054 RSI: 00007ffd60e191b8 RDI: 000055a021ead4a0
[18330.198844] RBP: 00007ffd60e1d600 R08: 0000000000000000 R09: 0000000000000000
[18330.199042] R10: 2c30a44af20c9940 R11: 00007ffd60e195d8 R12: 000055a021ead4a0
[18330.199240] R13: 000055a021e6f830 R14: 00007ffd60e191c0 R15: 000055a021e811b0
[18330.199442]
[18330.325173] BTRFS: device fsid 5e8ad11f-f6ee-4fe6-ad70-f9de525fdc02 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2979805)