[15791.718280] run fstests btrfs/190 at 2022-04-02 01:13:42
[15792.205901] BTRFS: device fsid f12f0536-e3c6-4941-aa19-104f0ad548f8 devid 1 transid 6 /dev/mapper/logwrites-test scanned by mkfs.btrfs (3376393)
[15792.212300] BTRFS info (device dm-9): flagging fs with big metadata feature
[15792.212514] BTRFS info (device dm-9): use zlib compression, level 3
[15792.212776] BTRFS info (device dm-9): using free space tree
[15792.212950] BTRFS info (device dm-9): has skinny extents
[15792.214479] BTRFS info (device dm-9): checking UUID tree
[15792.226368] BTRFS warning (device dm-9): qgroup rescan is already in progress
[15792.229822] BTRFS info (device dm-9): qgroup scan completed (inconsistency flag cleared)
[15793.431698] BTRFS info (device dm-9): balance: start -f -m -s
[15793.432282] BTRFS info (device dm-9): relocating block group 30408704 flags metadata|dup
[15793.454434] BTRFS info (device dm-9): found 20 extents, stage: move data extents
[15793.466294] BTRFS info (device dm-9): relocating block group 22020096 flags system|dup
[15793.481252] BTRFS info (device dm-9): found 1 extents, stage: move data extents
[15793.493231] BTRFS info (device dm-9): balance: ended with status: 0
[15793.533713] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[15793.534037] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[15793.534342] preempt_count: 101, expected: 0
[15793.534525] RCU nest depth: 0, expected: 0
[15793.534725] INFO: lockdep is turned off.
[15793.534941] Preemption disabled at:
[15793.534942] [] ___slab_alloc+0x961/0xf50
[15793.535312] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G        W         5.17.0+ #639
[15793.535548] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[15793.536392] Call Trace:
[15793.536597]  
[15793.536775]  dump_stack_lvl+0x56/0x6f
[15793.536993]  __might_resched.cold+0xff/0x13a
[15793.537225]  blk_release_queue+0x24/0x120
[15793.537461]  kobject_put+0x7c/0x1d0
[15793.537669]  ? rcu_do_batch+0x1ac/0x570
[15793.537887]  blkg_free.part.0+0x41/0x60
[15793.538096]  rcu_do_batch+0x1e1/0x570
[15793.538303]  ? rcu_do_batch+0x1ac/0x570
[15793.538520]  rcu_core+0x2cb/0x460
[15793.538730]  __do_softirq+0x178/0x517
[15793.538938]  __irq_exit_rcu+0xe3/0x160
[15793.539147]  irq_exit_rcu+0xa/0x20
[15793.539355]  sysvec_apic_timer_interrupt+0xa2/0xd0
[15793.539541]  
[15793.539655]  
[15793.539769]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[15793.539930] RIP: 0010:native_safe_halt+0xb/0x10
[15793.540081] Code: 6d ff ff ff 7f 5b c3 65 48 8b 04 25 c0 fe 01 00 f0 80 48 02 20 48 8b 00 a8 08 75 c3 eb 80 cc eb 07 0f 00 2d 79 b7 5b 00 fb f4  0f 1f 40 00 eb 07 0f 00 2d 69 b7 5b 00 f4 c3 cc cc cc cc cc 0f
[15793.540536] RSP: 0018:ffffa59280093ef8 EFLAGS: 00000246
[15793.540704] RAX: ffffffff92e64a80 RBX: ffff936080340000 RCX: 0000000000000000
[15793.540896] RDX: ffff936080340000 RSI: ffffffff9387e4d9 RDI: ffffffff92e64bf6
[15793.541085] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[15793.541275] R10: 0000000000000002 R11: ffff9360fbd20c88 R12: 0000000000000000
[15793.541466] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[15793.541660]  ? mwait_idle+0x80/0x80
[15793.541793]  ? default_idle_call+0x26/0xa0
[15793.541941]  default_idle+0xa/0x10
[15793.542075]  default_idle_call+0x5e/0xa0
[15793.542215]  do_idle+0x1e9/0x240
[15793.542349]  cpu_startup_entry+0x19/0x20
[15793.542491]  secondary_startup_64_no_verify+0xd5/0xdb
[15793.542655]  
[15793.588087] BTRFS info (device dm-7): flagging fs with big metadata feature
[15793.588308] BTRFS info (device dm-7): use zlib compression, level 3
[15793.588492] BTRFS info (device dm-7): using free space tree
[15793.594251] BTRFS info (device dm-7): has skinny extents
[15793.666607] BTRFS info (device dm-7): flagging fs with big metadata feature
[15793.666939] BTRFS info (device dm-7): use zlib compression, level 3
[15793.667206] BTRFS info (device dm-7): using free space tree
[15793.667450] BTRFS info (device dm-7): has skinny extents
[15793.678834] BTRFS info (device dm-7): qgroup scan completed (inconsistency flag cleared)
[15793.760200] BTRFS info (device dm-7): flagging fs with big metadata feature
[15793.760509] BTRFS info (device dm-7): use zlib compression, level 3
[15793.760809] BTRFS info (device dm-7): using free space tree
[15793.761054] BTRFS info (device dm-7): has skinny extents
[15793.848436] BTRFS info (device dm-7): flagging fs with big metadata feature
[15793.848662] BTRFS info (device dm-7): use zlib compression, level 3
[15793.848901] BTRFS info (device dm-7): using free space tree
[15793.849074] BTRFS info (device dm-7): has skinny extents
[15793.859835] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[15793.860217] BTRFS info (device dm-7): balance: paused
[15793.941928] BTRFS info (device dm-7): flagging fs with big metadata feature
[15793.942228] BTRFS info (device dm-7): use zlib compression, level 3
[15793.942491] BTRFS info (device dm-7): using free space tree
[15793.942772] BTRFS info (device dm-7): has skinny extents
[15793.947469] BTRFS info (device dm-7): checking UUID tree
[15793.953399] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[15793.953776] BTRFS info (device dm-7): relocating block group 298844160 flags metadata|dup
[15793.967697] BTRFS info (device dm-7): balance: paused
[15794.059420] BTRFS info (device dm-7): flagging fs with big metadata feature
[15794.059753] BTRFS info (device dm-7): use zlib compression, level 3
[15794.060018] BTRFS info (device dm-7): using free space tree
[15794.060264] BTRFS info (device dm-7): has skinny extents
[15794.075279] BTRFS info (device dm-7): checking UUID tree
[15794.079079] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[15794.079366] BTRFS info (device dm-7): relocating block group 298844160 flags metadata|dup
[15794.095547] BTRFS info (device dm-7): found 20 extents, stage: move data extents
[15794.104712] BTRFS info (device dm-7): balance: paused
[15794.196484] BTRFS info (device dm-7): flagging fs with big metadata feature
[15794.196849] BTRFS info (device dm-7): use zlib compression, level 3
[15794.197109] BTRFS info (device dm-7): using free space tree
[15794.197362] BTRFS info (device dm-7): has skinny extents
[15794.753999] _btrfs_printk: 40 callbacks suppressed
[15794.754002] BTRFS info (device dm-7): flagging fs with big metadata feature
[15794.754375] BTRFS info (device dm-7): use zlib compression, level 3
[15794.754555] BTRFS info (device dm-7): using free space tree
[15794.754742] BTRFS info (device dm-7): has skinny extents
[15794.756696] BTRFS info (device dm-7): checking UUID tree
[15794.762328] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[15794.767791] BTRFS info (device dm-7): relocating block group 567279616 flags system|dup
[15794.777554] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[15794.786626] BTRFS info (device dm-7): balance: paused
[15794.864119] BTRFS info (device dm-7): flagging fs with big metadata feature
[15794.864340] BTRFS info (device dm-7): use zlib compression, level 3
[15794.864524] BTRFS info (device dm-7): using free space tree
[15794.864718] BTRFS info (device dm-7): has skinny extents
[15794.866490] BTRFS info (device dm-7): checking UUID tree
[15794.871583] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[15794.872066] BTRFS info (device dm-7): relocating block group 567279616 flags system|dup
[15794.885004] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[15794.894017] BTRFS info (device dm-7): balance: paused
[15794.975167] BTRFS info (device dm-7): flagging fs with big metadata feature
[15794.975380] BTRFS info (device dm-7): use zlib compression, level 3
[15794.975562] BTRFS info (device dm-7): using free space tree
[15794.976252] BTRFS info (device dm-7): has skinny extents
[15794.978237] BTRFS info (device dm-7): checking UUID tree
[15794.983921] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[15794.989500] BTRFS info (device dm-7): relocating block group 567279616 flags system|dup
[15794.999194] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[15795.009472] BTRFS info (device dm-7): balance: paused
[15795.105374] BTRFS info (device dm-7): flagging fs with big metadata feature
[15795.105592] BTRFS info (device dm-7): use zlib compression, level 3
[15795.105837] BTRFS info (device dm-7): using free space tree
[15795.106007] BTRFS info (device dm-7): has skinny extents
[15795.108187] BTRFS info (device dm-7): checking UUID tree
[15795.112320] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[15795.112864] BTRFS info (device dm-7): relocating block group 567279616 flags system|dup
[15795.125245] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[15795.134782] BTRFS info (device dm-7): balance: paused
[15795.232930] BTRFS info (device dm-7): flagging fs with big metadata feature
[15795.233153] BTRFS info (device dm-7): use zlib compression, level 3
[15795.233337] BTRFS info (device dm-7): using free space tree
[15795.233509] BTRFS info (device dm-7): has skinny extents
[15795.235863] BTRFS info (device dm-7): checking UUID tree
[15795.241352] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[15795.241621] BTRFS info (device dm-7): balance: paused
[15795.327906] BTRFS info (device dm-7): flagging fs with big metadata feature
[15795.328124] BTRFS info (device dm-7): use zlib compression, level 3
[15795.328308] BTRFS info (device dm-7): using free space tree
[15795.328482] BTRFS info (device dm-7): has skinny extents
[15795.437260] BTRFS info (device dm-7): flagging fs with big metadata feature
[15795.437483] BTRFS info (device dm-7): use zlib compression, level 3
[15795.437702] BTRFS info (device dm-7): using free space tree
[15795.437906] BTRFS info (device dm-7): has skinny extents