[15152.132173] run fstests btrfs/190 at 2022-04-03 01:14:58
[15152.578498] BTRFS: device fsid 5f7f68e3-3996-4fa4-98f8-7fa8b1c2d2dc devid 1 transid 6 /dev/mapper/logwrites-test scanned by mkfs.btrfs (3418591)
[15152.589533] BTRFS info (device dm-11): flagging fs with big metadata feature
[15152.589974] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[15152.590490] BTRFS info (device dm-11): use lzo compression, level 0
[15152.590869] BTRFS info (device dm-11): disk space caching is enabled
[15152.591247] BTRFS info (device dm-11): has skinny extents
[15152.595490] BTRFS info (device dm-11): checking UUID tree
[15152.610995] BTRFS warning (device dm-11): qgroup rescan is already in progress
[15152.620295] BTRFS info (device dm-11): qgroup scan completed (inconsistency flag cleared)
[15153.795781] BTRFS info (device dm-11): balance: start -f -m -s
[15153.796496] BTRFS info (device dm-11): relocating block group 30408704 flags metadata|dup
[15153.837951] BTRFS info (device dm-11): found 20 extents, stage: move data extents
[15153.871083] BTRFS info (device dm-11): relocating block group 22020096 flags system|dup
[15153.906134] BTRFS info (device dm-11): found 1 extents, stage: move data extents
[15153.938292] BTRFS info (device dm-11): balance: ended with status: 0
[15153.993261] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[15153.994092] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[15153.994572] preempt_count: 101, expected: 0
[15153.994827] RCU nest depth: 0, expected: 0
[15153.995159] INFO: lockdep is turned off.
[15153.995441] Preemption disabled at:
[15153.995442] [] ___slab_alloc+0x961/0xf50
[15153.996012] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G        W         5.17.0+ #640
[15153.996456] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[15153.996958] Call Trace:
[15153.997110]  
[15153.997237]  dump_stack_lvl+0x56/0x6f
[15153.997464]  __might_resched.cold+0xff/0x13a
[15153.997778]  blk_release_queue+0x24/0x120
[15153.998028]  kobject_put+0x7c/0x1d0
[15153.998243]  ? rcu_do_batch+0x1ac/0x570
[15153.998476]  blkg_free.part.0+0x41/0x60
[15153.998708]  rcu_do_batch+0x1e1/0x570
[15153.998934]  ? rcu_do_batch+0x1ac/0x570
[15153.999167]  rcu_core+0x2cb/0x460
[15153.999369]  __do_softirq+0x178/0x517
[15153.999593]  __irq_exit_rcu+0xe3/0x160
[15153.999822]  irq_exit_rcu+0xa/0x20
[15154.000028]  sysvec_apic_timer_interrupt+0xa2/0xd0
[15154.000315]  
[15154.000446]  
[15154.000576]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[15154.000885] RIP: 0010:native_safe_halt+0xb/0x10
[15154.001155] Code: 54 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
[15154.002238] RSP: 0018:ffffa8c180093ef8 EFLAGS: 00000246
[15154.002548] RAX: ffffffffabe64a80 RBX: ffff9da100340000 RCX: 0000000000000000
[15154.002969] RDX: ffff9da100340000 RSI: ffffffffac87e4d9 RDI: ffffffffabe64bf6
[15154.003388] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[15154.003812] R10: 0000000000000002 R11: ffff9da17bd20c88 R12: 0000000000000000
[15154.004228] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[15154.004655]  ? mwait_idle+0x80/0x80
[15154.004869]  ? default_idle_call+0x26/0xa0
[15154.005115]  default_idle+0xa/0x10
[15154.005320]  default_idle_call+0x5e/0xa0
[15154.005554]  do_idle+0x1e9/0x240
[15154.005755]  cpu_startup_entry+0x19/0x20
[15154.005991]  secondary_startup_64_no_verify+0xd5/0xdb
[15154.006294]  
[15154.054095] BTRFS info (device dm-9): flagging fs with big metadata feature
[15154.054674] BTRFS info (device dm-9): use lzo compression, level 0
[15154.055048] BTRFS info (device dm-9): disk space caching is enabled
[15154.055439] BTRFS info (device dm-9): has skinny extents
[15154.148581] BTRFS info (device dm-9): flagging fs with big metadata feature
[15154.149018] BTRFS info (device dm-9): use lzo compression, level 0
[15154.149403] BTRFS info (device dm-9): disk space caching is enabled
[15154.149897] BTRFS info (device dm-9): has skinny extents
[15154.164878] BTRFS info (device dm-9): qgroup scan completed (inconsistency flag cleared)
[15154.253935] BTRFS info (device dm-9): flagging fs with big metadata feature
[15154.254556] BTRFS info (device dm-9): use lzo compression, level 0
[15154.255013] BTRFS info (device dm-9): disk space caching is enabled
[15154.255541] BTRFS info (device dm-9): has skinny extents
[15154.343006] BTRFS info (device dm-9): flagging fs with big metadata feature
[15154.343631] BTRFS info (device dm-9): use lzo compression, level 0
[15154.344143] BTRFS info (device dm-9): disk space caching is enabled
[15154.344650] BTRFS info (device dm-9): has skinny extents
[15154.361002] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15154.361632] BTRFS info (device dm-9): relocating block group 30408704 flags metadata|dup
[15154.394874] BTRFS info (device dm-9): found 20 extents, stage: move data extents
[15154.419715] BTRFS info (device dm-9): balance: paused
[15154.512340] BTRFS info (device dm-9): flagging fs with big metadata feature
[15154.512751] BTRFS info: devid 1 device path /dev/mapper/vg0-lv9 changed to /dev/dm-9 scanned by systemd-udevd (3417412)
[15154.512816] BTRFS info (device dm-9): use lzo compression, level 0
[15154.514040] BTRFS info (device dm-9): disk space caching is enabled
[15154.514149] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/vg0-lv9 scanned by systemd-udevd (3417412)
[15154.514424] BTRFS info (device dm-9): has skinny extents
[15154.517525] BTRFS info (device dm-9): checking UUID tree
[15154.530807] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15154.531445] BTRFS info (device dm-9): balance: paused
[15154.618632] BTRFS info (device dm-9): flagging fs with big metadata feature
[15154.619075] BTRFS info (device dm-9): use lzo compression, level 0
[15154.619473] BTRFS info (device dm-9): disk space caching is enabled
[15154.619919] BTRFS info (device dm-9): has skinny extents
[15155.137995] _btrfs_printk: 22 callbacks suppressed
[15155.137998] BTRFS info (device dm-9): balance: paused
[15155.230381] BTRFS info (device dm-9): flagging fs with big metadata feature
[15155.230980] BTRFS info (device dm-9): use lzo compression, level 0
[15155.231517] BTRFS info (device dm-9): disk space caching is enabled
[15155.232042] BTRFS info (device dm-9): has skinny extents
[15155.234562] BTRFS info (device dm-9): checking UUID tree
[15155.251410] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15155.251954] BTRFS info (device dm-9): relocating block group 298844160 flags metadata|dup
[15155.282294] BTRFS info (device dm-9): found 20 extents, stage: move data extents
[15155.306092] BTRFS info (device dm-9): balance: paused
[15155.394547] BTRFS info (device dm-9): flagging fs with big metadata feature
[15155.394990] BTRFS info (device dm-9): use lzo compression, level 0
[15155.395383] BTRFS info (device dm-9): disk space caching is enabled
[15155.395763] BTRFS info (device dm-9): has skinny extents
[15155.397667] BTRFS info (device dm-9): checking UUID tree
[15155.411004] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15155.411472] BTRFS info (device dm-9): balance: paused
[15155.506953] BTRFS info (device dm-9): flagging fs with big metadata feature
[15155.507427] BTRFS info (device dm-9): use lzo compression, level 0
[15155.507812] BTRFS info (device dm-9): disk space caching is enabled
[15155.508204] BTRFS info (device dm-9): has skinny extents
[15155.510073] BTRFS info (device dm-9): checking UUID tree
[15155.529163] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15155.529934] BTRFS info (device dm-9): relocating block group 567279616 flags system|dup
[15155.595580] BTRFS info (device dm-9): balance: paused
[15155.725841] BTRFS info (device dm-9): flagging fs with big metadata feature
[15155.726457] BTRFS info (device dm-9): use lzo compression, level 0
[15155.726974] BTRFS info (device dm-9): disk space caching is enabled
[15155.727489] BTRFS info (device dm-9): has skinny extents
[15155.733294] BTRFS info (device dm-9): checking UUID tree
[15155.743297] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15155.743755] BTRFS info (device dm-9): balance: paused
[15155.855563] BTRFS info (device dm-9): flagging fs with big metadata feature
[15155.856070] BTRFS info (device dm-9): use lzo compression, level 0
[15155.856508] BTRFS info (device dm-9): disk space caching is enabled
[15155.856939] BTRFS info (device dm-9): has skinny extents
[15155.859154] BTRFS info (device dm-9): checking UUID tree
[15155.874126] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15155.874673] BTRFS info (device dm-9): relocating block group 567279616 flags system|dup
[15155.899746] BTRFS info (device dm-9): found 1 extents, stage: move data extents
[15155.924848] BTRFS info (device dm-9): balance: paused
[15156.042520] BTRFS info (device dm-9): flagging fs with big metadata feature
[15156.042967] BTRFS info (device dm-9): use lzo compression, level 0
[15156.043364] BTRFS info (device dm-9): disk space caching is enabled
[15156.043752] BTRFS info (device dm-9): has skinny extents
[15156.046096] BTRFS info (device dm-9): checking UUID tree
[15156.058391] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15156.058875] BTRFS info (device dm-9): balance: paused
[15156.158086] BTRFS info (device dm-9): flagging fs with big metadata feature
[15156.158538] BTRFS info (device dm-9): use lzo compression, level 0
[15156.158914] BTRFS info (device dm-9): disk space caching is enabled
[15156.159296] BTRFS info (device dm-9): has skinny extents
[15156.160981] BTRFS info (device dm-9): checking UUID tree
[15156.171304] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15156.172345] BTRFS info (device dm-9): relocating block group 567279616 flags system|dup
[15156.204606] BTRFS info (device dm-9): found 1 extents, stage: move data extents
[15156.228092] BTRFS info (device dm-9): balance: paused
[15156.328250] BTRFS info (device dm-9): flagging fs with big metadata feature
[15156.328719] BTRFS info (device dm-9): use lzo compression, level 0
[15156.329089] BTRFS info (device dm-9): disk space caching is enabled
[15156.329480] BTRFS info (device dm-9): has skinny extents
[15156.331738] BTRFS info (device dm-9): checking UUID tree
[15156.346885] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[15156.347360] BTRFS info (device dm-9): balance: paused
[15156.445034] BTRFS info (device dm-9): flagging fs with big metadata feature
[15156.445479] BTRFS info (device dm-9): use lzo compression, level 0
[15156.445854] BTRFS info (device dm-9): disk space caching is enabled
[15156.446245] BTRFS info (device dm-9): has skinny extents
[15156.556653] BTRFS info (device dm-9): flagging fs with big metadata feature
[15156.557093] BTRFS info (device dm-9): use lzo compression, level 0
[15156.557477] BTRFS info (device dm-9): disk space caching is enabled
[15156.557855] BTRFS info (device dm-9): has skinny extents