Test output


[33766.390259] run fstests btrfs/160 at 2022-04-04 06:14:10
[33766.585936] BTRFS info (device dm-0): flagging fs with big metadata feature
[33766.586161] BTRFS info (device dm-0): using free space tree
[33766.586336] BTRFS info (device dm-0): has skinny extents
[33767.726276] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 1 transid 6 /dev/dm-11 scanned by systemd-udevd (2804730)
[33767.737007] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 2 transid 6 /dev/dm-8 scanned by systemd-udevd (2804730)
[33767.744272] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 3 transid 6 /dev/dm-7 scanned by systemd-udevd (2804189)
[33767.749662] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 4 transid 6 /dev/dm-6 scanned by systemd-udevd (2804730)
[33767.755865] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 5 transid 6 /dev/dm-5 scanned by systemd-udevd (2804189)
[33767.762280] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 6 transid 6 /dev/dm-4 scanned by systemd-udevd (2804730)
[33767.764080] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 7 transid 6 /dev/dm-3 scanned by systemd-udevd (2804189)
[33767.769786] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 8 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (2804725)
[33767.770280] BTRFS: device fsid 8915aed8-624e-43fc-8ab2-78aeaef0abc2 devid 9 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (2804725)
[33767.778744] BTRFS info (device dm-11): flagging fs with big metadata feature
[33767.778991] BTRFS info (device dm-11): turning on sync discard
[33767.779193] BTRFS info (device dm-11): enabling free space tree
[33767.779412] BTRFS info (device dm-11): using free space tree
[33767.779653] BTRFS info (device dm-11): has skinny extents
[33767.781637] BTRFS info: devid 9 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (2804730)
[33767.783941] BTRFS info: devid 9 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (2804730)
[33767.796617] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2804189)
[33767.798127] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2804189)
[33767.806875] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (2804731)
[33767.808435] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (2804733)
[33767.808801] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (2804731)
[33767.810118] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (2804733)
[33767.813759] BTRFS info: devid 3 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (2804287)
[33767.815624] BTRFS info: devid 3 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (2804287)
[33767.816196] BTRFS info: devid 7 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (2804729)
[33767.818253] BTRFS info: devid 7 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (2804729)
[33767.819694] BTRFS info (device dm-11): creating free space tree
[33767.819950] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[33767.820213] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[33767.832038] BTRFS info: devid 6 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (2804727)
[33767.832408] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2804732)
[33767.832807] BTRFS info (device dm-11): cleaning free space cache v1
[33767.844518] BTRFS info (device dm-11): checking UUID tree
[33767.844728] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2804732)
[33767.845762] BTRFS info: devid 6 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (2804727)
[33767.849578] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2804189)
[33767.852015] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2804189)
[33767.867481] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (2804726)
[33767.869212] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (2804726)
[33767.880503] BTRFS info: devid 7 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (2804730)
[33767.884770] BTRFS info: devid 7 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (2804730)
[33767.896729] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (2804729)
[33767.898521] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (2804729)
[33768.019277] BTRFS info: devid 3 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (2804733)
[33768.027030] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2804731)
[33768.028718] BTRFS info: devid 6 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (2804727)
[33768.035781] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2804731)
[33768.045607] BTRFS info: devid 3 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (2804733)
[33768.048603] BTRFS info: devid 6 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (2804727)
[33768.064043] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2804730)
[33768.066813] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2804730)
[33768.090945] BTRFS info: devid 6 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (2804189)
[33768.092518] BTRFS info: devid 6 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (2804189)
[33768.095270] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2804726)
[33768.096879] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2804726)
[33768.125197] btrfs_dev_stat_print_on_error: 38 callbacks suppressed
[33768.125200] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[33768.126383] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[33768.127175] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[33768.128818] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[33768.129921] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[33768.130295] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[33768.130948] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[33768.131332] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[33768.131892] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[33768.132374] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[33768.242727] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[33768.243141] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[33768.243951] BTRFS error (device dm-11): error writing primary super block to device 1
[33768.293156] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2804730)
[33768.295108] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2804730)
[33768.364489] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[33768.364757] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[33768.365010] preempt_count: 101, expected: 0
[33768.365155] RCU nest depth: 0, expected: 0
[33768.365301] INFO: lockdep is turned off.
[33768.365445] Preemption disabled at:
[33768.365445] [] ___slab_alloc+0x961/0xf50
[33768.365775] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G        W         5.17.0+ #641
[33768.366016] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[33768.366265] Call Trace:
[33768.366388]  
[33768.366500]  dump_stack_lvl+0x56/0x6f
[33768.366644]  __might_resched.cold+0xff/0x13a
[33768.366801]  blk_release_queue+0x24/0x120
[33768.366944]  kobject_put+0x7c/0x1d0
[33768.367081]  ? rcu_do_batch+0x1ac/0x570
[33768.367226]  blkg_free.part.0+0x41/0x60
[33768.367372]  rcu_do_batch+0x1e1/0x570
[33768.367510]  ? rcu_do_batch+0x1ac/0x570
[33768.367653]  rcu_core+0x2cb/0x460
[33768.367789]  __do_softirq+0x178/0x517
[33768.367933]  __irq_exit_rcu+0xe3/0x160
[33768.368074]  irq_exit_rcu+0xa/0x20
[33768.368210]  sysvec_apic_timer_interrupt+0xa2/0xd0
[33768.368365]  
[33768.368476]  
[33768.368590]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[33768.368753] RIP: 0010:native_safe_halt+0xb/0x10
[33768.368909] Code: 5d 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
[33768.369366] RSP: 0018:ffffb12640093ef8 EFLAGS: 00000246
[33768.369531] RAX: ffffffffa2e64a80 RBX: ffff9be280378000 RCX: 0000000000000000
[33768.369725] RDX: ffff9be280378000 RSI: ffffffffa387e4d9 RDI: ffffffffa2e64bf6
[33768.369919] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[33768.370111] R10: 0000000000000000 R11: ffff9be2fbd20c88 R12: 0000000000000000
[33768.370303] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[33768.370495]  ? mwait_idle+0x80/0x80
[33768.370629]  ? default_idle_call+0x26/0xa0
[33768.370778]  default_idle+0xa/0x10
[33768.370926]  default_idle_call+0x5e/0xa0
[33768.371069]  do_idle+0x1e9/0x240
[33768.371201]  cpu_startup_entry+0x19/0x20
[33768.371346]  secondary_startup_64_no_verify+0xd5/0xdb
[33768.371508]