[ 2417.771050] run fstests btrfs/056 at 2022-04-03 21:31:41
[ 2418.008536] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 2418.008803] BTRFS info (device dm-0): using free space tree
[ 2418.009014] BTRFS info (device dm-0): has skinny extents
[ 2418.184954] BTRFS: device fsid d317a46a-0009-430c-8868-61e81a587f99 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (351151)
[ 2418.274637] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 2418.274904] BTRFS info (device dm-11): turning on async discard
[ 2418.275107] BTRFS info (device dm-11): disk space caching is enabled
[ 2418.275312] BTRFS info (device dm-11): has skinny extents
[ 2418.277002] BTRFS info (device dm-11): checking UUID tree
[ 2418.363299] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (347777)
[ 2418.364428] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (347777)
[ 2418.435333] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 2418.435574] BTRFS info (device dm-11): turning on async discard
[ 2418.435787] BTRFS info (device dm-11): disk space caching is enabled
[ 2418.435998] BTRFS info (device dm-11): has skinny extents
[ 2418.438006] BTRFS info (device dm-11): start tree-log replay
[ 2418.444205] BTRFS info (device dm-11): checking UUID tree
[ 2418.526657] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 2418.526977] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 351289, name: dmsetup
[ 2418.527253] preempt_count: 101, expected: 0
[ 2418.527418] RCU nest depth: 1, expected: 0
[ 2418.527578] INFO: lockdep is turned off.
[ 2418.527754] Preemption disabled at:
[ 2418.527755] [<0000000000000000>] 0x0
[ 2418.528085] CPU: 0 PID: 351289 Comm: dmsetup Not tainted 5.17.0+ #641
[ 2418.528290] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 2418.528593] Call Trace:
[ 2418.528732]  
[ 2418.528859]  dump_stack_lvl+0x56/0x6f
[ 2418.529031]  __might_resched.cold+0xff/0x13a
[ 2418.529199]  blk_release_queue+0x24/0x120
[ 2418.529364]  kobject_put+0x7c/0x1d0
[ 2418.529522]  ? rcu_do_batch+0x1ac/0x570
[ 2418.529687]  blkg_free.part.0+0x41/0x60
[ 2418.529849]  rcu_do_batch+0x1e1/0x570
[ 2418.530013]  ? rcu_do_batch+0x1ac/0x570
[ 2418.530181]  rcu_core+0x2cb/0x460
[ 2418.530331]  __do_softirq+0x178/0x517
[ 2418.530491]  __irq_exit_rcu+0xe3/0x160
[ 2418.530654]  irq_exit_rcu+0xa/0x20
[ 2418.530809]  sysvec_apic_timer_interrupt+0xa2/0xd0
[ 2418.531757]  
[ 2418.531978]  
[ 2418.532208]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 2418.532480] RIP: 0010:__mod_node_page_state+0x7c/0xc0
[ 2418.532760] Code: 48 c1 f9 3f 48 89 c8 48 31 d8 65 41 8a 17 48 29 c8 48 0f be d2 48 39 c2 7c 29 48 c7 c7 df b2 90 a3 e8 68 f3 ac 00 65 88 5d 00 <5b> 5d 41 5c 41 5d 41 5e 41 5f c3 f7 c2 ff 0f 00 00 75 26 49 c1 fc
[ 2418.533291] RSP: 0000:ffffb12640befd38 EFLAGS: 00000286
[ 2418.533474] RAX: 0000000000000000 RBX: 0000000000000001 RCX: 0000000000000000
[ 2418.533690] RDX: 0000000000000014 RSI: ffffffffa390b2df RDI: ffffffffa389480e
[ 2418.533909] RBP: 000000000003a572 R08: 0000000000000000 R09: 0000000000000000
[ 2418.534130] R10: ffff9be28d1d7d30 R11: ffff9be29365f9a0 R12: 0000000000000001
[ 2418.534344] R13: ffff9be2fffd3000 R14: 0000000000000011 R15: 000000000003a560
[ 2418.534567]  ? __mod_node_page_state+0x78/0xc0
[ 2418.534744]  __mod_lruvec_state+0x22/0x40
[ 2418.534921]  __mod_lruvec_page_state+0xd5/0x220
[ 2418.535095]  page_add_new_anon_rmap+0xb7/0x210
[ 2418.535264]  __handle_mm_fault+0x127d/0x1460
[ 2418.535434]  ? mmap_region+0x2da/0x620
[ 2418.535595]  handle_mm_fault+0x11e/0x3a0
[ 2418.535755]  do_user_addr_fault+0x1e9/0x6b0
[ 2418.535926]  exc_page_fault+0x78/0x280
[ 2418.536087]  ? asm_exc_page_fault+0x8/0x30
[ 2418.536256]  asm_exc_page_fault+0x1e/0x30
[ 2418.536417] RIP: 0033:0x7f395c5206db
[ 2418.536572] Code: 89 5c 24 20 be 01 00 00 00 48 89 54 24 18 ff 15 5b 17 02 00 48 89 c5 48 85 c0 0f 84 4c 02 00 00 48 8b 54 24 18 4c 8b 5c 24 20 <48> 89 40 28 4c 89 e6 4c 8d 8c 10 80 04 00 00 4c 89 da 4c 89 88 d0
[ 2418.537099] RSP: 002b:00007ffe6f200e70 EFLAGS: 00010206
[ 2418.537282] RAX: 00007f395c125000 RBX: 0000000000000000 RCX: 00007f395c1254b0
[ 2418.537499] RDX: 0000000000000000 RSI: 0000000000002000 RDI: 0000000000000000
[ 2418.537724] RBP: 00007f395c125000 R08: 00000000ffffffff R09: 0000000000000000
[ 2418.537952] R10: 0000000000000022 R11: 0000000000000010 R12: 00007f395c2bb7b5
[ 2418.538169] R13: 00007f395c50c9f0 R14: 000000000000000f R15: 0000000000000000
[ 2418.538393]  
[ 2418.580708] BTRFS: device fsid de794cb1-f2c0-459f-8db8-6b5bd351173c devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (351288)
[ 2418.664327] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 2418.664573] BTRFS info (device dm-11): turning on async discard
[ 2418.664801] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[ 2418.665093] BTRFS info (device dm-11): force lzo compression, level 0
[ 2418.665303] BTRFS info (device dm-11): disk space caching is enabled
[ 2418.665506] BTRFS info (device dm-11): has skinny extents
[ 2418.667248] BTRFS info (device dm-11): checking UUID tree
[ 2418.749282] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (347777)
[ 2418.750182] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (347777)
[ 2418.821940] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 2418.822272] BTRFS info (device dm-11): turning on async discard
[ 2418.822480] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[ 2418.822803] BTRFS info (device dm-11): force lzo compression, level 0
[ 2418.823022] BTRFS info (device dm-11): disk space caching is enabled
[ 2418.823227] BTRFS info (device dm-11): has skinny extents
[ 2418.825282] BTRFS info (device dm-11): start tree-log replay
[ 2418.831554] BTRFS info (device dm-11): checking UUID tree
[ 2418.956981] BTRFS: device fsid eaff107f-c775-4017-ad7a-da9e0a965d61 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (351425)
[ 2419.031744] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 2419.038505] BTRFS info (device dm-11): turning on async discard
[ 2419.038730] BTRFS info (device dm-11): disk space caching is enabled
[ 2419.038946] BTRFS info (device dm-11): has skinny extents
[ 2419.042303] BTRFS info (device dm-11): checking UUID tree
[ 2419.119461] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (347777)
[ 2419.120905] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (347777)
[ 2419.201818] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 2419.202074] BTRFS info (device dm-11): turning on async discard
[ 2419.202272] BTRFS info (device dm-11): disk space caching is enabled
[ 2419.202477] BTRFS info (device dm-11): has skinny extents
[ 2419.204188] BTRFS info (device dm-11): start tree-log replay
[ 2419.210356] BTRFS info (device dm-11): checking UUID tree
[ 2419.341807] BTRFS: device fsid 0a057f98-2b1e-4455-8d89-e72c762390b0 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (351562)
[ 2419.416049] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 2419.416312] BTRFS info (device dm-11): turning on async discard
[ 2419.416515] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[ 2419.416838] BTRFS info (device dm-11): force lzo compression, level 0
[ 2419.417060] BTRFS info (device dm-11): disk space caching is enabled
[ 2419.417272] BTRFS info (device dm-11): has skinny extents
[ 2419.418918] BTRFS info (device dm-11): checking UUID tree
[ 2419.500401] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (347777)
[ 2419.501737] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (347777)
[ 2419.572114] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 2419.572374] BTRFS info (device dm-11): turning on async discard
[ 2419.572582] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[ 2419.572906] BTRFS info (device dm-11): force lzo compression, level 0
[ 2419.573122] BTRFS info (device dm-11): disk space caching is enabled
[ 2419.573334] BTRFS info (device dm-11): has skinny extents
[ 2419.574917] BTRFS info (device dm-11): start tree-log replay
[ 2419.581893] BTRFS info (device dm-11): checking UUID tree
[ 2419.649643] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 2419.649958] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 351701, name: udevadm
[ 2419.650251] preempt_count: 100, expected: 0
[ 2419.650419] RCU nest depth: 0, expected: 0
[ 2419.650583] INFO: lockdep is turned off.
[ 2419.650767] Preemption disabled at:
[ 2419.650769] [] __do_softirq+0x5e/0x517
[ 2419.651127] CPU: 0 PID: 351701 Comm: udevadm Tainted: G        W         5.17.0+ #641
[ 2419.651417] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 2419.651711] Call Trace:
[ 2419.651852]  
[ 2419.651995]  dump_stack_lvl+0x56/0x6f
[ 2419.652160]  __might_resched.cold+0xff/0x13a
[ 2419.652338]  blk_release_queue+0x24/0x120
[ 2419.652508]  kobject_put+0x7c/0x1d0
[ 2419.652668]  ? rcu_do_batch+0x1ac/0x570
[ 2419.652832]  blkg_free.part.0+0x41/0x60
[ 2419.653003]  rcu_do_batch+0x1e1/0x570
[ 2419.653166]  ? rcu_do_batch+0x1ac/0x570
[ 2419.653333]  rcu_core+0x2cb/0x460
[ 2419.653491]  __do_softirq+0x178/0x517
[ 2419.653656]  __irq_exit_rcu+0xe3/0x160
[ 2419.653822]  irq_exit_rcu+0xa/0x20
[ 2419.653984]  sysvec_apic_timer_interrupt+0x54/0xd0
[ 2419.654169]  ? asm_sysvec_apic_timer_interrupt+0xa/0x20
[ 2419.654363]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 2419.654552] RIP: 0033:0x7fa4be027b08
[ 2419.654713] Code: ff ff 66 0f 6f 0c 0e 66 0f 73 d8 03 66 0f 73 db 03 e9 fc 0e 00 00 66 66 2e 0f 1f 84 00 00 00 00 00 90 66 0f ef c0 66 0f 6f 17 <66> 0f 6f 0e 66 0f 74 c1 66 0f 73 fa 0c 66 0f 74 d1 66 0f f8 d0 66
[ 2419.655256] RSP: 002b:00007ffcfa17cfc8 EFLAGS: 00000206
[ 2419.655448] RAX: 0000000000000000 RBX: 00007fa4be007510 RCX: 000000000000000c
[ 2419.655673] RDX: 000000000000ffff RSI: 00007fa4bdfe9170 RDI: 00007fa4be0074f0
[ 2419.655902] RBP: 00007fa4bdfe917c R08: 000000000000ffff R09: ffffffffffffab58
[ 2419.656127] R10: 00007fa4be027b00 R11: 00007fa4bd760f08 R12: 00007fa4be007510
[ 2419.656353] R13: 00007fa4bdfe917c R14: 00007fa4be037000 R15: 00007fa4be007510
[ 2419.656587]