[ 3400.178804] run fstests btrfs/146 at 2022-04-02 21:59:06
[ 3401.404696] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 1 transid 6 /dev/dm-11 scanned by systemd-udevd (527736)
[ 3401.415301] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 2 transid 6 /dev/dm-8 scanned by systemd-udevd (527788)
[ 3401.422282] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 4 transid 6 /dev/dm-6 scanned by systemd-udevd (530226)
[ 3401.428161] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 3 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (530219)
[ 3401.429153] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 5 transid 6 /dev/mapper/vg0-lv5 scanned by mkfs.btrfs (530219)
[ 3401.430302] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 6 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (530219)
[ 3401.431283] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 7 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (530219)
[ 3401.432439] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 8 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (530219)
[ 3401.433616] BTRFS: device fsid 6cb565e4-d05b-408f-82f7-d8265a346bfb devid 9 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (530219)
[ 3401.450250] BTRFS info: devid 6 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (527805)
[ 3401.451156] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 3401.451888] BTRFS info (device dm-11): disk space caching is enabled
[ 3401.452718] BTRFS info (device dm-11): has skinny extents
[ 3401.454535] BTRFS info: devid 7 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (527798)
[ 3401.455678] BTRFS info: devid 9 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (530226)
[ 3401.457672] BTRFS info: devid 9 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (530226)
[ 3401.458439] BTRFS info: devid 7 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (527798)
[ 3401.462199] BTRFS info: devid 8 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (527788)
[ 3401.464523] BTRFS info: devid 8 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (527788)
[ 3401.482685] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (527807)
[ 3401.485750] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (527807)
[ 3401.499521] BTRFS info (device dm-11): checking UUID tree
[ 3401.517534] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (530225)
[ 3401.519731] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (530225)
[ 3401.522828] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (530263)
[ 3401.535019] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (530263)
[ 3401.562233] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (527736)
[ 3401.564448] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (527736)
[ 3401.590105] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (530263)
[ 3401.592337] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (530263)
[ 3401.599993] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (527788)
[ 3401.602392] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (527788)
[ 3401.634687] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (527736)
[ 3401.636899] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (527736)
[ 3401.641663] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (527788)
[ 3401.643891] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (527788)
[ 3401.679155] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (527736)
[ 3401.682000] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (527736)
[ 3401.687617] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (527788)
[ 3401.691322] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (527788)
[ 3401.731761] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (527736)
[ 3401.734402] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (527736)
[ 3401.739656] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (527788)
[ 3401.742455] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (527788)
[ 3401.772522] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (527736)
[ 3402.564293] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (527736)
[ 3402.672489] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (527736)
[ 3402.674776] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (527736)
[ 3402.748216] btrfs_dev_stat_print_on_error: 7 callbacks suppressed
[ 3402.748220] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[ 3402.749536] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[ 3402.750398] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[ 3402.751253] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[ 3402.752282] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[ 3402.753466] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[ 3402.754329] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[ 3402.755182] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[ 3402.756146] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[ 3402.757338] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[ 3403.514476] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 3403.515441] BTRFS error (device dm-11): error writing primary super block to device 1
[ 3403.636085] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (527736)
[ 3403.639270] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (527736)
[ 3403.673196] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (527736)
[ 3403.675311] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (527736)
[ 3403.816577] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 3403.817107] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 529806, name: 146
[ 3403.817626] preempt_count: 100, expected: 0
[ 3403.817901] RCU nest depth: 1, expected: 0
[ 3403.818166] INFO: lockdep is turned off.
[ 3403.818430] Preemption disabled at:
[ 3403.818431] [] __do_softirq+0x5e/0x517
[ 3403.819023] CPU: 1 PID: 529806 Comm: 146 Tainted: G        W         5.17.0+ #640
[ 3403.819517] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 3403.820068] Call Trace:
[ 3403.820234]  
[ 3403.820385]  dump_stack_lvl+0x56/0x6f
[ 3403.820632]  __might_resched.cold+0xff/0x13a
[ 3403.820912]  blk_release_queue+0x24/0x120
[ 3403.821177]  kobject_put+0x7c/0x1d0
[ 3403.821419]  ? rcu_do_batch+0x1ac/0x570
[ 3403.821671]  blkg_free.part.0+0x41/0x60
[ 3403.821923]  rcu_do_batch+0x1e1/0x570
[ 3403.822166]  ? rcu_do_batch+0x1ac/0x570
[ 3403.822427]  rcu_core+0x2cb/0x460
[ 3403.822648]  __do_softirq+0x178/0x517
[ 3403.822891]  __irq_exit_rcu+0xe3/0x160
[ 3403.823138]  irq_exit_rcu+0xa/0x20
[ 3403.823367]  sysvec_apic_timer_interrupt+0xa2/0xd0
[ 3403.823679]  
[ 3403.823821]  
[ 3403.823962]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 3403.824296] RIP: 0010:__rcu_read_unlock+0x32/0x1b0
[ 3403.824612] Code: 55 41 54 55 65 48 8b 2c 25 c0 fe 01 00 53 83 ad f4 07 00 00 01 75 0a 8b 85 f8 07 00 00 85 c0 75 23 65 48 8b 04 25 c0 fe 01 00 <8b> 80 f4 07 00 00 3d ff ff ff 3f 0f 87 ba 00 00 00 5b 5d 41 5c 41
[ 3403.825797] RSP: 0018:ffffa8c182cafc50 EFLAGS: 00000202
[ 3403.826136] RAX: ffff9da113ee0000 RBX: ffff9da103c78000 RCX: 0000000000000000
[ 3403.826595] RDX: ffffffffab42dcf4 RSI: ffffffffac87e4d9 RDI: ffffffffac83354b
[ 3403.827051] RBP: ffff9da113ee0000 R08: 0000000000000000 R09: 0000000000000000
[ 3403.827508] R10: ffff9da104ad4178 R11: ffff9da10d2a8f60 R12: ffff9da10427f140
[ 3403.827964] R13: 0000000000000cc0 R14: ffffffffab3c0295 R15: 0000000000000cc0
[ 3403.828424]  ? anon_vma_fork+0xa5/0x180
[ 3403.828679]  ? get_obj_cgroup_from_current+0xd4/0x310
[ 3403.829010]  ? anon_vma_fork+0xa5/0x180
[ 3403.829260]  get_obj_cgroup_from_current+0x12e/0x310
[ 3403.829598]  kmem_cache_alloc+0x75/0x3f0
[ 3403.829856]  anon_vma_fork+0xa5/0x180
[ 3403.830095]  dup_mm+0x461/0x610
[ 3403.830307]  copy_process+0x134f/0x1e90
[ 3403.830566]  ? wp_page_reuse+0x60/0x70
[ 3403.830842]  kernel_clone+0x8b/0x3c0
[ 3403.831079]  ? rcu_read_lock_sched_held+0x12/0x60
[ 3403.831519]  ? rcu_read_lock_sched_held+0x12/0x60
[ 3403.831829]  ? lock_acquire+0x176/0x2d0
[ 3403.832083]  __do_sys_clone+0x52/0x60
[ 3403.832326]  do_syscall_64+0x38/0x90
[ 3403.832573]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 3403.832902] RIP: 0033:0x7fd8bd08d0d9
[ 3403.833137] Code: ed 0f 85 1a 01 00 00 64 48 8b 04 25 10 00 00 00 45 31 c0 31 d2 31 f6 bf 11 00 20 01 4c 8d 90 d0 02 00 00 b8 38 00 00 00 0f 05 <48> 3d 00 f0 ff ff 0f 87 93 00 00 00 41 89 c5 85 c0 0f 85 a0 00 00
[ 3403.834360] RSP: 002b:00007ffcbf340270 EFLAGS: 00000246 ORIG_RAX: 0000000000000038
[ 3403.834842] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007fd8bd08d0d9
[ 3403.835294] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011
[ 3403.835753] RBP: 0000000000000000 R08: 0000000000000000 R09: 000000000000005f
[ 3403.836206] R10: 00007fd8bcfbda10 R11: 0000000000000246 R12: 0000000000000000
[ 3403.836667] R13: 00007ffcbf340360 R14: 00005611919d41b0 R15: 00005611908abd31
[ 3403.837123]