[ 5555.841000] run fstests btrfs/233 at 2022-04-03 22:23:59
[ 5556.045903] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 5556.046117] BTRFS info (device dm-0): using free space tree
[ 5556.046287] BTRFS info (device dm-0): has skinny extents
[ 5556.277613] BTRFS: device fsid afb8cdb8-9330-4f11-94a2-c577db26e631 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (1006424)
[ 5556.370346] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 5556.370609] BTRFS info (device dm-11): turning on async discard
[ 5556.370794] BTRFS info (device dm-11): disk space caching is enabled
[ 5556.370974] BTRFS info (device dm-11): has skinny extents
[ 5556.372710] BTRFS info (device dm-11): checking UUID tree
[ 5556.478575] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (1006117)
[ 5556.479357] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (1006117)
[ 5556.537707] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 5556.537933] BTRFS info (device dm-11): disk space caching is enabled
[ 5556.538119] BTRFS info (device dm-11): has skinny extents
[ 5558.611487] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 5558.611771] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 1006522, name: mkfs.btrfs
[ 5558.612025] preempt_count: 100, expected: 0
[ 5558.612174] RCU nest depth: 0, expected: 0
[ 5558.612317] INFO: lockdep is turned off.
[ 5558.612455] Preemption disabled at:
[ 5558.612456] [] __do_softirq+0x5e/0x517
[ 5558.612790] CPU: 1 PID: 1006522 Comm: mkfs.btrfs Tainted: G        W         5.17.0+ #641
[ 5558.613036] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 5558.613432] Call Trace:
[ 5558.613568]  
[ 5558.613786]  dump_stack_lvl+0x56/0x6f
[ 5558.613955]  __might_resched.cold+0xff/0x13a
[ 5558.614125]  blk_release_queue+0x24/0x120
[ 5558.614305]  kobject_put+0x7c/0x1d0
[ 5558.614472]  ? rcu_do_batch+0x1ac/0x570
[ 5558.614622]  blkg_free.part.0+0x41/0x60
[ 5558.614789]  rcu_do_batch+0x1e1/0x570
[ 5558.614973]  ? rcu_do_batch+0x1ac/0x570
[ 5558.615174]  rcu_core+0x2cb/0x460
[ 5558.615319]  __do_softirq+0x178/0x517
[ 5558.615484]  __irq_exit_rcu+0xe3/0x160
[ 5558.615627]  irq_exit_rcu+0xa/0x20
[ 5558.615768]  sysvec_apic_timer_interrupt+0xa2/0xd0
[ 5558.615928]  
[ 5558.616043]  
[ 5558.616154]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 5558.616320] RIP: 0010:try_charge_memcg+0x163/0x850
[ 5558.616481] Code: 04 00 00 48 c7 43 28 00 00 00 00 48 c7 c6 5c c6 42 a2 48 89 df e8 bd a6 db ff 4d 85 e4 74 0b e8 d3 fb e7 ff fb 0f 1f 44 00 00 <45> 84 ff 0f 85 23 02 00 00 0f 1f 44 00 00 45 89 f7 4c 8d 64 24 28
[ 5558.616942] RSP: 0018:ffffb12644307ad0 EFLAGS: 00000246
[ 5558.617105] RAX: 0000000080000000 RBX: ffff9be2fbd2f620 RCX: 0000000000000000
[ 5558.617300] RDX: 0000000000000014 RSI: ffffffffa242c65c RDI: ffffffffa242c67d
[ 5558.617507] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[ 5558.618313] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000200
[ 5558.618512] R13: ffff9be2906c6000 R14: 0000000000000020 R15: 0000000000000001
[ 5558.618713]  ? try_charge_memcg+0x13c/0x850
[ 5558.618863]  ? try_charge_memcg+0x15d/0x850
[ 5558.619012]  ? rcu_read_lock_sched_held+0x12/0x60
[ 5558.619169]  ? lock_release+0x1ed/0x2c0
[ 5558.619349]  charge_memcg+0xd8/0x1a0
[ 5558.619505]  __mem_cgroup_charge+0x2d/0x60
[ 5558.619653]  __filemap_add_folio+0x375/0x6a0
[ 5558.619811]  ? mod_lruvec_state+0x60/0x60
[ 5558.619958]  filemap_add_folio+0x27/0x80
[ 5558.620103]  __filemap_get_folio+0x1ac/0x4d0
[ 5558.620252]  ? blkdev_llseek+0x60/0x60
[ 5558.620393]  pagecache_get_page+0x15/0x90
[ 5558.620541]  block_write_begin+0x24/0x130
[ 5558.620686]  generic_perform_write+0xa9/0x1d0
[ 5558.620845]  __generic_file_write_iter+0xdb/0x1a0
[ 5558.621002]  blkdev_write_iter+0xc1/0x150
[ 5558.621152]  new_sync_write+0xf6/0x160
[ 5558.621294]  vfs_write+0x290/0x390
[ 5558.621427]  __x64_sys_pwrite64+0x6f/0xb0
[ 5558.621576]  do_syscall_64+0x38/0x90
[ 5558.621723]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 5558.621886] RIP: 0033:0x7f92bcc8d53a
[ 5558.622023] Code: d8 64 89 02 48 c7 c0 ff ff ff ff eb ba 0f 1f 00 f3 0f 1e fa 49 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 15 b8 12 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 5e c3 0f 1f 44 00 00 48 83 ec 28 48 89 54 24
[ 5558.622488] RSP: 002b:00007fff32b23fb8 EFLAGS: 00000246 ORIG_RAX: 0000000000000012
[ 5558.622729] RAX: ffffffffffffffda RBX: 00007f92bc88e010 RCX: 00007f92bcc8d53a
[ 5558.622925] RDX: 0000000000200000 RSI: 00007f92bc88e010 RDI: 0000000000000003
[ 5558.623122] RBP: 0000000000200000 R08: 00007f92bc88e010 R09: 0000000000000000
[ 5558.623317] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
[ 5558.623514] R13: 0000000000000003 R14: 0000000000000000 R15: 0000000000000000
[ 5558.623717]  
[ 5558.746771] BTRFS: device fsid 015753e3-df7b-48b4-a802-eb9b59f1d0ec devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (1006522)
[ 5558.812507] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 5558.812735] BTRFS info (device dm-11): disk space caching is enabled
[ 5558.812921] BTRFS info (device dm-11): has skinny extents
[ 5558.814274] BTRFS info (device dm-11): checking UUID tree
[ 5558.924667] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (1006117)
[ 5558.925436] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (1006117)
[ 5558.983676] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 5558.983908] BTRFS info (device dm-11): disk space caching is enabled
[ 5558.984092] BTRFS info (device dm-11): has skinny extents
[ 5559.000912] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 5559.001130] BTRFS info (device dm-11): disk space caching is enabled
[ 5559.001314] BTRFS info (device dm-11): has skinny extents
[ 5559.005796] BTRFS info (device dm-11: state M): disk space caching is enabled