[18944.804064] run fstests btrfs/190 at 2022-04-04 02:06:38
[18945.346469] BTRFS: device fsid 2e34ab98-05ae-4723-9be1-f6ac5911a1bd devid 1 transid 6 /dev/mapper/logwrites-test scanned by mkfs.btrfs (3565408)
[18945.356373] BTRFS info (device dm-11): flagging fs with big metadata feature
[18945.356844] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[18945.357339] BTRFS info (device dm-11): use lzo compression, level 0
[18945.357716] BTRFS info (device dm-11): disk space caching is enabled
[18945.358106] BTRFS info (device dm-11): has skinny extents
[18945.360331] BTRFS info (device dm-11): checking UUID tree
[18945.382136] BTRFS warning (device dm-11): qgroup rescan is already in progress
[18945.391274] BTRFS info (device dm-11): qgroup scan completed (inconsistency flag cleared)
[18946.637463] BTRFS info (device dm-11): balance: start -f -m -s
[18946.638081] BTRFS info (device dm-11): relocating block group 30408704 flags metadata|dup
[18946.735950] BTRFS info (device dm-11): found 20 extents, stage: move data extents
[18946.808654] BTRFS info (device dm-11): relocating block group 22020096 flags system|dup
[18946.892143] BTRFS info (device dm-11): found 1 extents, stage: move data extents
[18946.961088] BTRFS info (device dm-11): balance: ended with status: 0
[18947.064817] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[18947.065364] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0
[18947.065890] preempt_count: 101, expected: 0
[18947.066201] RCU nest depth: 0, expected: 0
[18947.066506] INFO: lockdep is turned off.
[18947.066816] Preemption disabled at:
[18947.066817] [] schedule_preempt_disabled+0x1e/0x20
[18947.067544] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G        W         5.17.0+ #641
[18947.068077] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[18947.068581] Call Trace:
[18947.068734]  
[18947.068862]  dump_stack_lvl+0x56/0x6f
[18947.069089]  __might_resched.cold+0xff/0x13a
[18947.069351]  blk_release_queue+0x24/0x120
[18947.069596]  kobject_put+0x7c/0x1d0
[18947.069810]  ? rcu_do_batch+0x1ac/0x570
[18947.070045]  blkg_free.part.0+0x41/0x60
[18947.070279]  rcu_do_batch+0x1e1/0x570
[18947.070505]  ? rcu_do_batch+0x1ac/0x570
[18947.070742]  rcu_core+0x2cb/0x460
[18947.070946]  __do_softirq+0x178/0x517
[18947.071172]  __irq_exit_rcu+0xe3/0x160
[18947.071403]  irq_exit_rcu+0xa/0x20
[18947.071610]  sysvec_apic_timer_interrupt+0xa2/0xd0
[18947.071899]  
[18947.072031]  
[18947.072163]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[18947.072474] RIP: 0010:native_safe_halt+0xb/0x10
[18947.072746] 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
[18947.073845] RSP: 0018:ffffffffaaa03ea8 EFLAGS: 00000246
[18947.074157] RAX: ffffffffa9e64a80 RBX: ffffffffaaa30a00 RCX: 0000000000000000
[18947.074584] RDX: ffffffffaaa30a00 RSI: ffffffffaa87e4d9 RDI: ffffffffa9e64bf6
[18947.075003] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[18947.075427] R10: 0000000000000000 R11: ffff94fcbbc20c88 R12: 0000000000000000
[18947.075847] R13: 0000000000000000 R14: ffffffffaaa30118 R15: 0000000000000073
[18947.076269]  ? mwait_idle+0x80/0x80
[18947.076486]  ? default_idle_call+0x26/0xa0
[18947.076739]  default_idle+0xa/0x10
[18947.076951]  default_idle_call+0x5e/0xa0
[18947.077189]  do_idle+0x1e9/0x240
[18947.077396]  cpu_startup_entry+0x19/0x20
[18947.077639]  start_kernel+0x98c/0x99e
[18947.077866]  ? copy_bootdata+0x18/0x55
[18947.078101]  secondary_startup_64_no_verify+0xd5/0xdb
[18947.078415]  
[18947.152824] BTRFS info (device dm-9): flagging fs with big metadata feature
[18947.153256] BTRFS info (device dm-9): use lzo compression, level 0
[18947.153633] BTRFS info (device dm-9): disk space caching is enabled
[18947.154021] BTRFS info (device dm-9): has skinny extents
[18947.234121] BTRFS info (device dm-9): flagging fs with big metadata feature
[18947.234566] BTRFS info (device dm-9): use lzo compression, level 0
[18947.234967] BTRFS info (device dm-9): disk space caching is enabled
[18947.235520] BTRFS info (device dm-9): has skinny extents
[18947.269216] BTRFS info (device dm-9): qgroup scan completed (inconsistency flag cleared)
[18947.403842] BTRFS info (device dm-9): flagging fs with big metadata feature
[18947.404348] BTRFS info (device dm-9): use lzo compression, level 0
[18947.404770] BTRFS info (device dm-9): disk space caching is enabled
[18947.405222] BTRFS info (device dm-9): has skinny extents
[18947.524759] BTRFS info (device dm-9): flagging fs with big metadata feature
[18947.525497] BTRFS info (device dm-9): use lzo compression, level 0
[18947.526099] BTRFS info (device dm-9): disk space caching is enabled
[18947.526700] BTRFS info (device dm-9): has skinny extents
[18947.571597] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18947.572107] BTRFS info (device dm-9): balance: canceled
[18947.674995] BTRFS info (device dm-9): flagging fs with big metadata feature
[18947.675446] BTRFS info (device dm-9): use lzo compression, level 0
[18947.675854] BTRFS info (device dm-9): disk space caching is enabled
[18947.676240] BTRFS info (device dm-9): has skinny extents
[18947.678175] BTRFS info (device dm-9): checking UUID tree
[18947.713208] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18947.714101] BTRFS info (device dm-9): relocating block group 298844160 flags metadata|dup
[18947.790563] BTRFS info (device dm-9): balance: paused
[18947.934104] BTRFS info (device dm-9): flagging fs with big metadata feature
[18947.934701] BTRFS info (device dm-9): use lzo compression, level 0
[18947.935235] BTRFS info (device dm-9): disk space caching is enabled
[18947.935816] BTRFS info (device dm-9): has skinny extents
[18947.987226] BTRFS info (device dm-9): checking UUID tree
[18948.028999] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18948.029530] BTRFS info (device dm-9): balance: paused
[18948.161067] BTRFS info (device dm-9): flagging fs with big metadata feature
[18948.161511] BTRFS info (device dm-9): use lzo compression, level 0
[18948.161900] BTRFS info (device dm-9): disk space caching is enabled
[18948.162277] BTRFS info (device dm-9): has skinny extents
[18948.202439] BTRFS info (device dm-9): checking UUID tree
[18948.216643] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18948.217123] BTRFS info (device dm-9): balance: paused
[18948.342845] BTRFS info (device dm-9): flagging fs with big metadata feature
[18948.343327] BTRFS info (device dm-9): use lzo compression, level 0
[18948.343696] BTRFS info (device dm-9): disk space caching is enabled
[18948.344085] BTRFS info (device dm-9): has skinny extents
[18948.346385] BTRFS info (device dm-9): checking UUID tree
[18948.360678] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18948.361147] BTRFS info (device dm-9): balance: paused
[18948.555540] BTRFS info (device dm-9): flagging fs with big metadata feature
[18948.556055] BTRFS info (device dm-9): use lzo compression, level 0
[18948.556480] BTRFS info (device dm-9): disk space caching is enabled
[18948.556885] BTRFS info (device dm-9): has skinny extents
[18948.559133] BTRFS info (device dm-9): checking UUID tree
[18948.574368] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18948.574950] BTRFS info (device dm-9): relocating block group 298844160 flags metadata|dup
[18948.721934] BTRFS info (device dm-9): found 20 extents, stage: move data extents
[18948.789066] BTRFS info (device dm-9): balance: paused
[18948.908854] BTRFS info (device dm-9): flagging fs with big metadata feature
[18948.909570] BTRFS info (device dm-9): use lzo compression, level 0
[18948.910121] BTRFS info (device dm-9): disk space caching is enabled
[18948.910684] BTRFS info (device dm-9): has skinny extents
[18948.914091] BTRFS info (device dm-9): checking UUID tree
[18948.931290] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18948.931933] BTRFS info (device dm-9): balance: paused
[18949.059920] BTRFS info (device dm-9): flagging fs with big metadata feature
[18949.060383] BTRFS info (device dm-9): use lzo compression, level 0
[18949.060770] BTRFS info (device dm-9): disk space caching is enabled
[18949.061182] BTRFS info (device dm-9): has skinny extents
[18949.063117] BTRFS info (device dm-9): checking UUID tree
[18949.096745] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18949.097309] BTRFS info (device dm-9): balance: paused
[18949.252740] BTRFS info (device dm-9): flagging fs with big metadata feature
[18949.253390] BTRFS info (device dm-9): use lzo compression, level 0
[18949.254000] BTRFS info (device dm-9): disk space caching is enabled
[18949.254687] BTRFS info (device dm-9): has skinny extents
[18949.257024] BTRFS info (device dm-9): checking UUID tree
[18949.291946] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18949.292535] BTRFS info (device dm-9): relocating block group 567279616 flags system|dup
[18949.349345] BTRFS info (device dm-9): found 1 extents, stage: move data extents
[18949.408649] BTRFS info (device dm-9): balance: paused
[18949.507844] BTRFS info (device dm-9): flagging fs with big metadata feature
[18949.508277] BTRFS info (device dm-9): use lzo compression, level 0
[18949.508651] BTRFS info (device dm-9): disk space caching is enabled
[18949.509050] BTRFS info (device dm-9): has skinny extents
[18949.511196] BTRFS info (device dm-9): checking UUID tree
[18949.524316] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18949.524798] BTRFS info (device dm-9): balance: canceled
[18949.643555] BTRFS info (device dm-9): flagging fs with big metadata feature
[18949.644038] BTRFS info (device dm-9): use lzo compression, level 0
[18949.644465] BTRFS info (device dm-9): disk space caching is enabled
[18949.644857] BTRFS info (device dm-9): has skinny extents
[18949.646865] BTRFS info (device dm-9): checking UUID tree
[18949.657260] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18949.657731] BTRFS info (device dm-9): balance: canceled
[18949.777173] BTRFS info (device dm-9): flagging fs with big metadata feature
[18949.777616] BTRFS info (device dm-9): use lzo compression, level 0
[18949.778003] BTRFS info (device dm-9): disk space caching is enabled
[18949.778376] BTRFS info (device dm-9): has skinny extents
[18949.781008] BTRFS info (device dm-9): checking UUID tree
[18949.791998] BTRFS info (device dm-9): balance: resume -f -musage=90 -susage=90
[18949.792465] BTRFS info (device dm-9): balance: paused
[18949.915995] BTRFS info (device dm-9): flagging fs with big metadata feature
[18949.916436] BTRFS info (device dm-9): use lzo compression, level 0
[18949.916823] BTRFS info (device dm-9): disk space caching is enabled