[15035.688916] run fstests btrfs/159 at 2022-04-02 01:01:06
[15035.933110] BTRFS info (device dm-0): flagging fs with big metadata feature
[15035.933324] BTRFS info (device dm-0): using free space tree
[15035.933502] BTRFS info (device dm-0): has skinny extents
[15036.252882] BTRFS: device fsid 34306793-1df8-4f47-870b-99c77bb77b4b devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (3024712)
[15036.315040] BTRFS info (device dm-9): flagging fs with big metadata feature
[15036.315256] BTRFS info (device dm-9): use zlib compression, level 3
[15036.315436] BTRFS info (device dm-9): using free space tree
[15036.315624] BTRFS info (device dm-9): has skinny extents
[15036.317522] BTRFS info (device dm-9): checking UUID tree
[15040.189683] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-9 scanned by systemd-udevd (3026424)
[15040.190519] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3026424)
[15040.286307] BTRFS info (device dm-9): flagging fs with big metadata feature
[15040.286532] BTRFS info (device dm-9): use zlib compression, level 3
[15040.286716] BTRFS info (device dm-9): using free space tree
[15040.286899] BTRFS info (device dm-9): has skinny extents
[15040.289068] BTRFS info (device dm-9): start tree-log replay
[15041.275854] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[15041.276150] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3026424, name: systemd-udevd
[15041.276404] preempt_count: 100, expected: 0
[15041.276620] RCU nest depth: 0, expected: 0
[15041.276779] INFO: lockdep is turned off.
[15041.277013] Preemption disabled at:
[15041.277015] [] __do_softirq+0x5e/0x517
[15041.277352] CPU: 0 PID: 3026424 Comm: systemd-udevd Tainted: G W 5.17.0+ #639
[15041.277636] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[15041.277908] Call Trace:
[15041.278073]
[15041.278199] dump_stack_lvl+0x56/0x6f
[15041.278365] __might_resched.cold+0xff/0x13a
[15041.278527] blk_release_queue+0x24/0x120
[15041.278717] kobject_put+0x7c/0x1d0
[15041.278857] ? rcu_do_batch+0x1ac/0x570
[15041.279000] blkg_free.part.0+0x41/0x60
[15041.279141] rcu_do_batch+0x1e1/0x570
[15041.279278] ? rcu_do_batch+0x1ac/0x570
[15041.279437] rcu_core+0x2cb/0x460
[15041.279573] __do_softirq+0x178/0x517
[15041.279747] __irq_exit_rcu+0xe3/0x160
[15041.279948] irq_exit_rcu+0xa/0x20
[15041.280142] sysvec_apic_timer_interrupt+0xa2/0xd0
[15041.280361]
[15041.280517]
[15041.280679] asm_sysvec_apic_timer_interrupt+0x12/0x20
[15041.280906] RIP: 0010:clear_page_erms+0x7/0x10
[15041.281127] Code: 48 89 47 18 48 89 47 20 48 89 47 28 48 89 47 30 48 89 47 38 48 8d 7f 40 75 d9 90 c3 0f 1f 80 00 00 00 00 b9 00 10 00 00 31 c0 aa c3 cc cc cc cc cc cc 49 89 f1 48 85 ff 0f 84 fa 00 00 00 0f
[15041.281791] RSP: 0018:ffffa59282dcb8c8 EFLAGS: 00010246
[15041.282029] RAX: 0000000000000000 RBX: ffff9360fffd5e00 RCX: 0000000000000600
[15041.282304] RDX: fffff95dc57c4c80 RSI: fffff95dc57c4cc0 RDI: ffff9360df132a00
[15041.282578] RBP: ffff9360fbc2f200 R08: 0000000000100000 R09: 0000000000000000
[15041.282852] R10: 0000000000000000 R11: 0000000000000000 R12: ffff9360fbc3a480
[15041.283044] R13: 0000000000000000 R14: ffff9360fffd5e00 R15: fffff95dc57c4c80
[15041.283240] post_alloc_hook+0x8d/0x110
[15041.283390] get_page_from_freelist+0x126e/0x16d0
[15041.283623] ? rcu_read_lock_sched_held+0x12/0x60
[15041.283858] ? prepare_alloc_pages+0xbc/0x1b0
[15041.284078] __alloc_pages+0xd6/0x290
[15041.284281] alloc_pages_vma+0x8f/0x2e0
[15041.284497] __handle_mm_fault+0xb31/0x1460
[15041.284716] handle_mm_fault+0x11e/0x3a0
[15041.284921] do_user_addr_fault+0x1e9/0x6b0
[15041.285140] exc_page_fault+0x78/0x280
[15041.285348] asm_exc_page_fault+0x1e/0x30
[15041.285564] RIP: 0010:copy_user_enhanced_fast_string+0xe/0x40
[15041.285814] Code: 89 d1 c1 e9 03 83 e2 07 f3 48 a5 89 d1 f3 a4 31 c0 0f 01 ca c3 8d 0c ca 89 ca eb 20 0f 01 cb 83 fa 40 0f 82 60 ff ff ff 89 d1 a4 31 c0 0f 01 ca c3 89 ca eb 06 66 0f 1f 44 00 00 83 f8 12 74
[15041.286502] RSP: 0018:ffffa59282dcbcc8 EFLAGS: 00050206
[15041.286743] RAX: 00007fffffffe000 RBX: 0000000000001000 RCX: 0000000000000ef8
[15041.287019] RDX: 0000000000001000 RSI: ffff936086bda108 RDI: 000055baaf486000
[15041.287298] RBP: ffffa59282dcbe68 R08: 0000000000000001 R09: ffffa59282dcbe58
[15041.287584] R10: 000055baaf485ef8 R11: 0000000000000000 R12: 0000000000001000
[15041.287864] R13: 0000000000001000 R14: 0000000000000000 R15: 0000000000039000
[15041.288150] copyout+0x3d/0x50
[15041.288294] copy_page_to_iter+0x104/0x4a0
[15041.288465] filemap_read+0x18c/0x340
[15041.288609] ? register_handler_proc+0xef/0x130
[15041.288761] blkdev_read_iter+0xac/0x1c0
[15041.288906] new_sync_read+0xf3/0x160
[15041.289047] vfs_read+0x15f/0x1b0
[15041.289179] ksys_read+0x55/0xd0
[15041.289310] do_syscall_64+0x38/0x90
[15041.289462] entry_SYSCALL_64_after_hwframe+0x44/0xae
[15041.289688] RIP: 0033:0x7f79a376d2e2
[15041.289827] Code: c0 e9 b2 fe ff ff 50 48 8d 3d ea 2e 0a 00 e8 95 e9 01 00 0f 1f 44 00 00 f3 0f 1e fa 64 8b 04 25 18 00 00 00 85 c0 75 10 0f 05 <48> 3d 00 f0 ff ff 77 56 c3 0f 1f 44 00 00 48 83 ec 28 48 89 54 24
[15041.290287] RSP: 002b:00007fff1d50c7f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
[15041.290540] RAX: ffffffffffffffda RBX: 000055baaf44cee8 RCX: 00007f79a376d2e2
[15041.290729] RDX: 0000000000040000 RSI: 000055baaf44cef8 RDI: 0000000000000006
[15041.290999] RBP: 000055baaf3b4040 R08: 000055baaf44ced0 R09: 00007f79a383fa60
[15041.291205] R10: fffffffffffff000 R11: 0000000000000246 R12: 0000000000040000
[15041.291437] R13: 0000000000040000 R14: 000055baaf44ced0 R15: 000055baaf3b4090
[15041.291634]
[15041.435475] BTRFS: device fsid f90d62ec-42fd-4959-9f8c-90a4a0b4da73 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (3026466)
[15041.499142] BTRFS info (device dm-9): flagging fs with big metadata feature
[15041.499379] BTRFS info (device dm-9): use zlib compression, level 3
[15041.499565] BTRFS info (device dm-9): using free space tree
[15041.499736] BTRFS info (device dm-9): has skinny extents
[15041.501713] BTRFS info (device dm-9): checking UUID tree
[15045.496301] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-9 scanned by systemd-udevd (3028178)
[15045.497154] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3028178)
[15045.591201] BTRFS info (device dm-9): flagging fs with big metadata feature
[15045.591512] BTRFS info (device dm-9): use zlib compression, level 3
[15045.591698] BTRFS info (device dm-9): using free space tree
[15045.591890] BTRFS info (device dm-9): has skinny extents
[15045.594129] BTRFS info (device dm-9): start tree-log replay
[15046.574803] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[15046.581082] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[15046.581326] preempt_count: 101, expected: 0
[15046.582223] RCU nest depth: 0, expected: 0
[15046.582379] INFO: lockdep is turned off.
[15046.582524] Preemption disabled at:
[15046.582525] [] ___slab_alloc+0x961/0xf50
[15046.582839] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 5.17.0+ #639
[15046.583088] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[15046.583364] Call Trace:
[15046.583484]
[15046.583598] dump_stack_lvl+0x56/0x6f
[15046.583737] __might_resched.cold+0xff/0x13a
[15046.583886] blk_release_queue+0x24/0x120
[15046.584033] kobject_put+0x7c/0x1d0
[15046.584172] ? rcu_do_batch+0x1ac/0x570
[15046.584313] blkg_free.part.0+0x41/0x60
[15046.584460] rcu_do_batch+0x1e1/0x570
[15046.584601] ? rcu_do_batch+0x1ac/0x570
[15046.584743] rcu_core+0x2cb/0x460
[15046.584874] __do_softirq+0x178/0x517
[15046.585017] __irq_exit_rcu+0xe3/0x160
[15046.585155] irq_exit_rcu+0xa/0x20
[15046.585288] sysvec_apic_timer_interrupt+0xa2/0xd0
[15046.585450]
[15046.585566]
[15046.585677] asm_sysvec_apic_timer_interrupt+0x12/0x20
[15046.585843] RIP: 0010:native_safe_halt+0xb/0x10
[15046.586003] Code: 6d 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
[15046.586481] RSP: 0018:ffffa59280093ef8 EFLAGS: 00000246
[15046.586643] RAX: ffffffff92e64a80 RBX: ffff936080340000 RCX: 0000000000000000
[15046.586839] RDX: ffff936080340000 RSI: ffffffff9387e4d9 RDI: ffffffff92e64bf6
[15046.587032] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[15046.587227] R10: 0000000000000000 R11: ffff9360fbd20c88 R12: 0000000000000000
[15046.587424] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[15046.587620] ? mwait_idle+0x80/0x80
[15046.587758] ? default_idle_call+0x26/0xa0
[15046.587902] default_idle+0xa/0x10
[15046.588037] default_idle_call+0x5e/0xa0
[15046.588181] do_idle+0x1e9/0x240
[15046.588313] cpu_startup_entry+0x19/0x20
[15046.588457] secondary_startup_64_no_verify+0xd5/0xdb
[15046.588621]