[ 4788.046189] run fstests btrfs/190 at 2022-04-03 22:10:41
[ 4788.539527] BTRFS: device fsid c749b1f5-54ec-4dba-9c4c-68c74be7b877 devid 1 transid 6 /dev/mapper/logwrites-test scanned by mkfs.btrfs (1003517)
[ 4788.550422] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 4788.551099] BTRFS info (device dm-11): disk space caching is enabled
[ 4788.551656] BTRFS info (device dm-11): has skinny extents
[ 4788.554192] BTRFS info (device dm-11): checking UUID tree
[ 4788.575024] BTRFS warning (device dm-11): qgroup rescan is already in progress
[ 4788.583918] BTRFS info (device dm-11): qgroup scan completed (inconsistency flag cleared)
[ 4789.841427] BTRFS info (device dm-11): balance: start -f -m -s
[ 4789.842334] BTRFS info (device dm-11): relocating block group 30408704 flags metadata|dup
[ 4789.956521] BTRFS info (device dm-11): found 82 extents, stage: move data extents
[ 4790.010619] BTRFS info (device dm-11): relocating block group 22020096 flags system|dup
[ 4790.044388] BTRFS info (device dm-11): found 1 extents, stage: move data extents
[ 4790.075547] BTRFS info (device dm-11): balance: ended with status: 0
[ 4790.145868] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 4790.146777] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[ 4790.147503] preempt_count: 101, expected: 0
[ 4790.147807] RCU nest depth: 0, expected: 0
[ 4790.148128] INFO: lockdep is turned off.
[ 4790.148568] Preemption disabled at:
[ 4790.148569] [] ___slab_alloc+0x961/0xf50
[ 4790.149144] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G        W         5.17.0+ #641
[ 4790.149616] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 4790.150122] Call Trace:
[ 4790.150287]  
[ 4790.150419]  dump_stack_lvl+0x56/0x6f
[ 4790.150650]  __might_resched.cold+0xff/0x13a
[ 4790.151100]  blk_release_queue+0x24/0x120
[ 4790.151353]  kobject_put+0x7c/0x1d0
[ 4790.151572]  ? rcu_do_batch+0x1ac/0x570
[ 4790.151803]  blkg_free.part.0+0x41/0x60
[ 4790.152045]  rcu_do_batch+0x1e1/0x570
[ 4790.152274]  ? rcu_do_batch+0x1ac/0x570
[ 4790.152507]  rcu_core+0x2cb/0x460
[ 4790.152709]  __do_softirq+0x178/0x517
[ 4790.152936]  __irq_exit_rcu+0xe3/0x160
[ 4790.153165]  irq_exit_rcu+0xa/0x20
[ 4790.153547]  sysvec_apic_timer_interrupt+0xa2/0xd0
[ 4790.153840]  
[ 4790.153971]  
[ 4790.154103]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 4790.154414] RIP: 0010:native_safe_halt+0xb/0x10
[ 4790.154687] Code: 56 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
[ 4790.155782] RSP: 0018:ffffa28440093ef8 EFLAGS: 00000246
[ 4790.156094] RAX: ffffffffa9e64a80 RBX: ffff94fc40340000 RCX: 0000000000000000
[ 4790.156518] RDX: ffff94fc40340000 RSI: ffffffffaa87e4d9 RDI: ffffffffa9e64bf6
[ 4790.156949] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[ 4790.157384] R10: 0000000000000000 R11: ffff94fcbbd20c88 R12: 0000000000000000
[ 4790.157834] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[ 4790.158277]  ? mwait_idle+0x80/0x80
[ 4790.158513]  ? default_idle_call+0x26/0xa0
[ 4790.158766]  default_idle+0xa/0x10
[ 4790.158971]  default_idle_call+0x5e/0xa0
[ 4790.159207]  do_idle+0x1e9/0x240
[ 4790.159421]  cpu_startup_entry+0x19/0x20
[ 4790.159659]  secondary_startup_64_no_verify+0xd5/0xdb
[ 4790.159965]  
[ 4790.227740] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4790.228192] BTRFS info (device dm-9): disk space caching is enabled
[ 4790.228572] BTRFS info (device dm-9): has skinny extents
[ 4790.383999] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4790.384452] BTRFS info (device dm-9): disk space caching is enabled
[ 4790.384873] BTRFS info (device dm-9): has skinny extents
[ 4790.409390] BTRFS info (device dm-9): qgroup scan completed (inconsistency flag cleared)
[ 4790.517531] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4790.518142] BTRFS info (device dm-9): disk space caching is enabled
[ 4790.518655] BTRFS info (device dm-9): has skinny extents
[ 4790.648092] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4790.648522] BTRFS info (device dm-9): disk space caching is enabled
[ 4790.648907] BTRFS info (device dm-9): has skinny extents
[ 4790.666710] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4790.667192] BTRFS info (device dm-9): balance: paused
[ 4790.798754] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4790.799352] BTRFS info (device dm-9): disk space caching is enabled
[ 4790.799865] BTRFS info (device dm-9): has skinny extents
[ 4790.802247] BTRFS info (device dm-9): checking UUID tree
[ 4790.820342] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4790.821264] BTRFS info (device dm-9): relocating block group 298844160 flags metadata|dup
[ 4790.852977] BTRFS info (device dm-9): balance: paused
[ 4790.978210] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4790.978657] BTRFS info (device dm-9): disk space caching is enabled
[ 4790.979062] BTRFS info (device dm-9): has skinny extents
[ 4791.008210] BTRFS info (device dm-9): checking UUID tree
[ 4791.018242] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4791.018702] BTRFS info (device dm-9): balance: paused
[ 4791.144784] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4791.145245] BTRFS info (device dm-9): disk space caching is enabled
[ 4791.145627] BTRFS info (device dm-9): has skinny extents
[ 4791.168161] BTRFS info (device dm-9): checking UUID tree
[ 4791.180367] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4791.180812] BTRFS info (device dm-9): balance: paused
[ 4791.308004] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4791.308447] BTRFS info (device dm-9): disk space caching is enabled
[ 4791.308878] BTRFS info (device dm-9): has skinny extents
[ 4791.310418] BTRFS info (device dm-9): checking UUID tree
[ 4791.424081] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4791.426527] BTRFS info (device dm-9): relocating block group 298844160 flags metadata|dup
[ 4791.762573] BTRFS info (device dm-9): found 82 extents, stage: move data extents
[ 4791.909611] BTRFS info (device dm-9): balance: paused
[ 4792.377177] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4792.377666] BTRFS info (device dm-9): disk space caching is enabled
[ 4792.378095] BTRFS info (device dm-9): has skinny extents
[ 4792.381132] BTRFS info (device dm-9): checking UUID tree
[ 4792.570956] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4792.573096] BTRFS info (device dm-9): balance: paused
[ 4792.918544] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4792.919055] BTRFS info (device dm-9): disk space caching is enabled
[ 4792.919492] BTRFS info (device dm-9): has skinny extents
[ 4792.921846] BTRFS info (device dm-9): checking UUID tree
[ 4793.092161] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4793.094564] BTRFS info (device dm-9): relocating block group 298844160 flags metadata|dup
[ 4793.487973] BTRFS info (device dm-9): found 82 extents, stage: move data extents
[ 4793.926184] BTRFS info (device dm-9): balance: paused
[ 4794.132696] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4794.133209] BTRFS info (device dm-9): disk space caching is enabled
[ 4794.133635] BTRFS info (device dm-9): has skinny extents
[ 4794.135859] BTRFS info (device dm-9): checking UUID tree
[ 4794.149077] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4794.149590] BTRFS info (device dm-9): balance: paused
[ 4794.274334] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4794.274764] BTRFS info (device dm-9): disk space caching is enabled
[ 4794.275154] BTRFS info (device dm-9): has skinny extents
[ 4794.277171] BTRFS info (device dm-9): checking UUID tree
[ 4794.291794] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4794.292780] BTRFS info (device dm-9): relocating block group 567279616 flags system|dup
[ 4794.326681] BTRFS info (device dm-9): found 1 extents, stage: move data extents
[ 4794.351583] BTRFS info (device dm-9): balance: paused
[ 4794.490067] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4794.490501] BTRFS info (device dm-9): disk space caching is enabled
[ 4794.491012] BTRFS info (device dm-9): has skinny extents
[ 4794.493550] BTRFS info (device dm-9): checking UUID tree
[ 4794.508977] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4794.509442] BTRFS info (device dm-9): balance: paused
[ 4794.645401] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4794.646013] BTRFS info (device dm-9): disk space caching is enabled
[ 4794.646543] BTRFS info (device dm-9): has skinny extents
[ 4794.653170] BTRFS info (device dm-9): checking UUID tree
[ 4794.665529] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4794.666010] BTRFS info (device dm-9): balance: paused
[ 4794.803482] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4794.803933] BTRFS info (device dm-9): disk space caching is enabled
[ 4794.804313] BTRFS info (device dm-9): has skinny extents
[ 4794.806451] BTRFS info (device dm-9): checking UUID tree
[ 4794.962752] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4794.963666] BTRFS info (device dm-9): relocating block group 567279616 flags system|dup
[ 4795.879238] BTRFS info (device dm-9): found 1 extents, stage: move data extents
[ 4796.346768] BTRFS info (device dm-9): balance: paused
[ 4796.743031] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4796.743662] BTRFS info (device dm-9): disk space caching is enabled
[ 4796.744247] BTRFS info (device dm-9): has skinny extents
[ 4796.747445] BTRFS info (device dm-9): checking UUID tree
[ 4796.885059] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[ 4796.889761] BTRFS info (device dm-9): relocating block group 567279616 flags system|dup
[ 4797.278753] BTRFS info (device dm-9): found 1 extents, stage: move data extents
[ 4797.372678] BTRFS info (device dm-9): balance: paused
[ 4797.532893] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4797.533327] BTRFS info (device dm-9): disk space caching is enabled
[ 4797.533697] BTRFS info (device dm-9): has skinny extents
[ 4797.675717] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4797.676190] BTRFS info (device dm-9): disk space caching is enabled
[ 4797.676583] BTRFS info (device dm-9): has skinny extents