[19212.299329] run fstests btrfs/190 at 2022-04-04 02:16:40
[19212.789502] BTRFS: device fsid 5f0cfa7e-2e8c-43f4-9f1b-2eb70b261a48 devid 1 transid 6 /dev/mapper/logwrites-test scanned by mkfs.btrfs (3359846)
[19212.798986] BTRFS info (device dm-9): flagging fs with big metadata feature
[19212.799202] BTRFS info (device dm-9): use zlib compression, level 3
[19212.799387] BTRFS info (device dm-9): using free space tree
[19212.799566] BTRFS info (device dm-9): has skinny extents
[19212.801212] BTRFS info (device dm-9): checking UUID tree
[19212.833180] BTRFS warning (device dm-9): qgroup rescan is already in progress
[19212.845664] BTRFS info (device dm-9): qgroup scan completed (inconsistency flag cleared)
[19214.188789] BTRFS info (device dm-9): balance: start -f -m -s
[19214.189434] BTRFS info (device dm-9): relocating block group 30408704 flags metadata|dup
[19214.227183] BTRFS info (device dm-9): found 20 extents, stage: move data extents
[19214.415855] BTRFS info (device dm-9): relocating block group 22020096 flags system|dup
[19214.460978] BTRFS info (device dm-9): found 1 extents, stage: move data extents
[19214.490373] BTRFS info (device dm-9): balance: ended with status: 0
[19214.552571] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[19214.552920] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3360907, name: replay-log
[19214.553220] preempt_count: 100, expected: 0
[19214.553365] RCU nest depth: 0, expected: 0
[19214.553520] INFO: lockdep is turned off.
[19214.553682] Preemption disabled at:
[19214.553683] [] __do_softirq+0x5e/0x517
[19214.554029] CPU: 0 PID: 3360907 Comm: replay-log Tainted: G        W         5.17.0+ #641
[19214.554345] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[19214.554679] Call Trace:
[19214.554818]  
[19214.554960]  dump_stack_lvl+0x56/0x6f
[19214.555139]  __might_resched.cold+0xff/0x13a
[19214.555322]  blk_release_queue+0x24/0x120
[19214.555518]  kobject_put+0x7c/0x1d0
[19214.555684]  ? rcu_do_batch+0x1ac/0x570
[19214.555856]  blkg_free.part.0+0x41/0x60
[19214.556003]  rcu_do_batch+0x1e1/0x570
[19214.556142]  ? rcu_do_batch+0x1ac/0x570
[19214.556284]  rcu_core+0x2cb/0x460
[19214.556422]  __do_softirq+0x178/0x517
[19214.556572]  __irq_exit_rcu+0xe3/0x160
[19214.556712]  irq_exit_rcu+0xa/0x20
[19214.556851]  sysvec_apic_timer_interrupt+0xa2/0xd0
[19214.557035]  
[19214.557195]  
[19214.557345]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[19214.557578] RIP: 0010:syscall_enter_from_user_mode+0x27/0x70
[19214.557804] Code: 00 00 00 41 54 49 89 f4 55 48 89 fd 48 8b 7c 24 10 e8 9d f6 ff ff 66 90 66 90 e8 a4 86 45 ff e8 bf 85 45 ff fb 0f 1f 44 00 00 <65> 48 8b 04 25 c0 fe 01 00 48 8b 70 08 40 f6 c6 3f 75 19 4c 89 e0
[19214.564998] RSP: 0018:ffffb94a03c27f28 EFLAGS: 00000246
[19214.565192] RAX: 0000000080000000 RBX: 0000000000000000 RCX: 0000000000000000
[19214.565444] RDX: 0000000000000000 RSI: ffffffffa2e53c8c RDI: ffffffffa2e53c91
[19214.565673] RBP: ffffb94a03c27f58 R08: 0000000000000000 R09: 0000000000000000
[19214.565924] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000008
[19214.566145] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[19214.566366]  ? syscall_enter_from_user_mode+0x1c/0x70
[19214.566545]  ? syscall_enter_from_user_mode+0x21/0x70
[19214.566716]  ? syscall_enter_from_user_mode+0x21/0x70
[19214.566885]  do_syscall_64+0x16/0x90
[19214.567068]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[19214.567276] RIP: 0033:0x7fd47e9e941b
[19214.567460] Code: ff ff c3 0f 1f 40 00 48 8b 15 51 1a 0d 00 f7 d8 64 89 02 48 c7 c0 ff ff ff ff eb ba 0f 1f 00 f3 0f 1e fa b8 08 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 05 c3 0f 1f 40 00 48 8b 15 21 1a 0d 00 f7 d8
[19214.568032] RSP: 002b:00007ffd9164ff98 EFLAGS: 00000246 ORIG_RAX: 0000000000000008
[19214.568325] RAX: ffffffffffffffda RBX: 00000000016512c0 RCX: 00007fd47e9e941b
[19214.568560] RDX: 0000000000000001 RSI: 0000000000001000 RDI: 0000000000000003
[19214.568796] RBP: 0000000001651310 R08: 0000000001651310 R09: 00007fd47eabba60
[19214.569036] R10: 00007fd47e90d850 R11: 0000000000000246 R12: 0000000000000000
[19214.569247] R13: 0000000000000000 R14: 000000000000015e R15: 0000000001651310
[19214.569464]  
[19214.634361] BTRFS info (device dm-7): flagging fs with big metadata feature
[19214.634611] BTRFS info (device dm-7): use zlib compression, level 3
[19214.634803] BTRFS info (device dm-7): using free space tree
[19214.634977] BTRFS info (device dm-7): has skinny extents
[19214.728764] BTRFS info (device dm-7): flagging fs with big metadata feature
[19214.729042] BTRFS info (device dm-7): use zlib compression, level 3
[19214.729306] BTRFS info (device dm-7): using free space tree
[19214.729614] BTRFS info (device dm-7): has skinny extents
[19214.741597] BTRFS info (device dm-7): qgroup scan completed (inconsistency flag cleared)
[19214.826232] BTRFS info (device dm-7): flagging fs with big metadata feature
[19214.826547] BTRFS info (device dm-7): use zlib compression, level 3
[19214.826833] BTRFS info (device dm-7): using free space tree
[19214.827071] BTRFS info (device dm-7): has skinny extents
[19214.913401] BTRFS info (device dm-7): flagging fs with big metadata feature
[19214.913743] BTRFS info (device dm-7): use zlib compression, level 3
[19214.914037] BTRFS info (device dm-7): using free space tree
[19214.914285] BTRFS info (device dm-7): has skinny extents
[19214.926802] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19214.927951] BTRFS info (device dm-7): balance: paused
[19215.004089] BTRFS info (device dm-7): flagging fs with big metadata feature
[19215.004302] BTRFS info (device dm-7): use zlib compression, level 3
[19215.004491] BTRFS info (device dm-7): using free space tree
[19215.004685] BTRFS info (device dm-7): has skinny extents
[19215.006830] BTRFS info (device dm-7): checking UUID tree
[19215.018598] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19215.019958] BTRFS info (device dm-7): relocating block group 298844160 flags metadata|dup
[19215.049463] BTRFS info (device dm-7): balance: paused
[19215.146596] BTRFS info (device dm-7): flagging fs with big metadata feature
[19215.146916] BTRFS info (device dm-7): use zlib compression, level 3
[19215.147194] BTRFS info (device dm-7): using free space tree
[19215.147454] BTRFS info (device dm-7): has skinny extents
[19215.168429] BTRFS info (device dm-7): checking UUID tree
[19215.177830] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19215.178107] BTRFS info (device dm-7): balance: canceled
[19215.377524] BTRFS info (device dm-7): flagging fs with big metadata feature
[19215.377786] BTRFS info (device dm-7): use zlib compression, level 3
[19215.377979] BTRFS info (device dm-7): using free space tree
[19215.378155] BTRFS info (device dm-7): has skinny extents
[19215.512395] BTRFS info (device dm-7): checking UUID tree
[19215.557828] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19215.558193] BTRFS info (device dm-7): relocating block group 298844160 flags metadata|dup
[19215.628361] BTRFS info (device dm-7): found 20 extents, stage: move data extents
[19215.653251] BTRFS info (device dm-7): balance: paused
[19215.766370] BTRFS info: devid 1 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (3358586)
[19215.766441] BTRFS info (device dm-7): flagging fs with big metadata feature
[19215.767064] BTRFS info (device dm-7): use zlib compression, level 3
[19215.767252] BTRFS info (device dm-7): using free space tree
[19215.767424] BTRFS info (device dm-7): has skinny extents
[19215.767428] BTRFS info: devid 1 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (3358586)
[19215.769691] BTRFS info (device dm-7): checking UUID tree
[19215.794897] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19215.805666] BTRFS info (device dm-7): relocating block group 298844160 flags metadata|dup
[19215.863410] BTRFS info (device dm-7): found 20 extents, stage: move data extents
[19215.956218] BTRFS info (device dm-7): balance: paused
[19216.044857] BTRFS info (device dm-7): flagging fs with big metadata feature
[19216.045177] BTRFS info (device dm-7): use zlib compression, level 3
[19216.045451] BTRFS info (device dm-7): using free space tree
[19216.045732] BTRFS info (device dm-7): has skinny extents
[19216.047882] BTRFS info (device dm-7): checking UUID tree
[19216.068258] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19216.094439] BTRFS info (device dm-7): relocating block group 298844160 flags metadata|dup
[19216.146697] BTRFS info (device dm-7): found 20 extents, stage: move data extents
[19216.174626] BTRFS info (device dm-7): balance: paused
[19216.349970] BTRFS info (device dm-7): flagging fs with big metadata feature
[19216.350191] BTRFS info (device dm-7): use zlib compression, level 3
[19216.350376] BTRFS info (device dm-7): using free space tree
[19216.350564] BTRFS info (device dm-7): has skinny extents
[19216.352496] BTRFS info (device dm-7): checking UUID tree
[19216.369217] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19216.395564] BTRFS info (device dm-7): relocating block group 298844160 flags metadata|dup
[19216.479588] BTRFS info (device dm-7): found 20 extents, stage: move data extents
[19216.537270] BTRFS info (device dm-7): balance: paused
[19216.640455] BTRFS info (device dm-7): flagging fs with big metadata feature
[19216.640776] BTRFS info (device dm-7): use zlib compression, level 3
[19216.641025] BTRFS info (device dm-7): using free space tree
[19216.641279] BTRFS info (device dm-7): has skinny extents
[19216.643741] BTRFS info (device dm-7): checking UUID tree
[19216.658547] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19216.659016] BTRFS info (device dm-7): relocating block group 567279616 flags system|dup
[19216.695723] BTRFS info (device dm-7): balance: paused
[19216.797319] BTRFS info (device dm-7): flagging fs with big metadata feature
[19216.797593] BTRFS info (device dm-7): use zlib compression, level 3
[19216.797781] BTRFS info (device dm-7): using free space tree
[19216.797950] BTRFS info (device dm-7): has skinny extents
[19216.800020] BTRFS info (device dm-7): checking UUID tree
[19216.810617] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19216.818779] BTRFS info (device dm-7): relocating block group 567279616 flags system|dup
[19216.842375] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[19216.866178] BTRFS info (device dm-7): balance: paused
[19216.961326] BTRFS info (device dm-7): flagging fs with big metadata feature
[19216.961647] BTRFS info (device dm-7): use zlib compression, level 3
[19216.961922] BTRFS info (device dm-7): using free space tree
[19216.962186] BTRFS info (device dm-7): has skinny extents
[19216.967405] BTRFS info (device dm-7): checking UUID tree
[19216.977178] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19216.977584] BTRFS info (device dm-7): balance: canceled
[19217.079482] BTRFS info (device dm-7): flagging fs with big metadata feature
[19217.079716] BTRFS info (device dm-7): use zlib compression, level 3
[19217.079902] BTRFS info (device dm-7): using free space tree
[19217.080069] BTRFS info (device dm-7): has skinny extents
[19217.081960] BTRFS info (device dm-7): checking UUID tree
[19217.108197] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19217.120544] BTRFS info (device dm-7): relocating block group 567279616 flags system|dup
[19217.150821] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[19217.182752] BTRFS info (device dm-7): balance: paused
[19217.276743] BTRFS info (device dm-7): flagging fs with big metadata feature
[19217.277052] BTRFS info (device dm-7): use zlib compression, level 3
[19217.277320] BTRFS info (device dm-7): using free space tree
[19217.277603] BTRFS info (device dm-7): has skinny extents
[19217.280179] BTRFS info (device dm-7): checking UUID tree
[19217.291130] BTRFS info (device dm-7): balance: resume -f -musage=90 -susage=90
[19217.291755] BTRFS info (device dm-7): relocating block group 567279616 flags system|dup
[19217.375329] BTRFS info (device dm-7): found 1 extents, stage: move data extents
[19217.417736] BTRFS info (device dm-7): balance: paused
[19217.524407] BTRFS info (device dm-7): flagging fs with big metadata feature
[19217.524776] BTRFS info (device dm-7): use zlib compression, level 3
[19217.525043] BTRFS info (device dm-7): using free space tree
[19217.525286] BTRFS info (device dm-7): has skinny extents
[19217.527963] BTRFS info (device dm-7): checking UUID tree