[24518.220828] run fstests generic/281 at 2022-01-01 03:38:46
[24518.656779] BTRFS: device fsid 8887c7d0-0458-4ecf-9686-dded95d56355 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (872972)
[24518.674721] BTRFS info (device dm-7): flagging fs with big metadata feature
[24518.675033] BTRFS info (device dm-7): use zlib compression, level 3
[24518.675296] BTRFS info (device dm-7): using free space tree
[24518.675532] BTRFS info (device dm-7): has skinny extents
[24518.678331] BTRFS info (device dm-7): checking UUID tree
[24518.866951] BTRFS: device fsid 70242ab0-8c28-4531-8bf2-73b32c62fea3 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (873046)
[24518.975850] BTRFS info (device dm-9): flagging fs with big metadata feature
[24518.976069] BTRFS info (device dm-9): use zlib compression, level 3
[24518.976273] BTRFS info (device dm-9): using free space tree
[24518.976447] BTRFS info (device dm-9): has skinny extents
[24518.979070] BTRFS info (device dm-9): checking UUID tree
[24519.167948] BTRFS info (device dm-9): flagging fs with big metadata feature
[24519.168196] BTRFS info (device dm-9): use zlib compression, level 3
[24519.168402] BTRFS info (device dm-9): using free space tree
[24519.168590] BTRFS info (device dm-9): has skinny extents
[24519.465754] Buffer I/O error on dev dm-9, logical block 2621424, async page read
[24519.655669] ------------[ cut here ]------------
[24519.655669] BTRFS: error (device dm-9) in btrfs_commit_transaction:2310: errno=-5 IO failure (Error while writing out transaction)
[24519.655891] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.656328] BTRFS info (device dm-9): forced readonly
[24519.656644] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes
[24519.656864] BTRFS warning (device dm-9): Skipping commit of aborted transaction.
[24519.656865] dm_dust
[24519.656867] BTRFS: error (device dm-9) in cleanup_transaction:1913: errno=-5 IO failure
[24519.657150] dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.659110] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.659383] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.659646] Workqueue: btrfs-cache btrfs_work_helper
[24519.659839] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.660015] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.660490] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.660657] RAX: 0017ffffc000a112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.660871] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.661075] RBP: 0000000000000d5e R08: ffff90589188c000 R09: 0000000000000000
[24519.661287] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007f6
[24519.661489] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cf6000
[24519.661691] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.661965] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.662150] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.662369] Call Trace:
[24519.662503]
[24519.662620] extent_buffer_test_bit+0x3f/0x70
[24519.662796] free_space_test_bit+0xa6/0xc0
[24519.662957] load_free_space_tree+0x1d6/0x430
[24519.663114] caching_thread+0x454/0x630
[24519.663266] ? rcu_read_lock_sched_held+0x12/0x60
[24519.663436] ? rcu_read_lock_sched_held+0x12/0x60
[24519.663643] ? rcu_read_lock_sched_held+0x12/0x60
[24519.663842] ? lock_release+0x1f0/0x2d0
[24519.664003] btrfs_work_helper+0xf2/0x3e0
[24519.664159] ? lock_release+0x1f0/0x2d0
[24519.664319] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.664489] process_one_work+0x270/0x5a0
[24519.664648] worker_thread+0x55/0x3c0
[24519.664825] ? process_one_work+0x5a0/0x5a0
[24519.664994] kthread+0x174/0x1a0
[24519.665132] ? set_kthread_struct+0x40/0x40
[24519.665313] ret_from_fork+0x1f/0x30
[24519.665469]
[24519.665597] irq event stamp: 0
[24519.665733] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.665941] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.666213] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.666483] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.666675] ---[ end trace 08d0ff1eb437f0ed ]---
[24519.666861] ------------[ cut here ]------------
[24519.667039] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.667342] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.669889] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.670233] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.670974] BTRFS: error (device dm-9) in btrfs_remove_chunk:3234: errno=-5 IO failure
[24519.676635] Workqueue: btrfs-cache btrfs_work_helper
[24519.676642] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.677289] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.677782] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.677955] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.678167] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.678383] RBP: 0000000000000d5e R08: ffff90589188c000 R09: 0000000000000000
[24519.678591] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007f7
[24519.678814] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cf7000
[24519.679028] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.679313] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.679512] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.679721] Call Trace:
[24519.679863]
[24519.679984] extent_buffer_test_bit+0x3f/0x70
[24519.680146] free_space_test_bit+0xa6/0xc0
[24519.680310] load_free_space_tree+0x1d6/0x430
[24519.680475] caching_thread+0x454/0x630
[24519.680647] ? rcu_read_lock_sched_held+0x12/0x60
[24519.680829] ? rcu_read_lock_sched_held+0x12/0x60
[24519.681016] ? rcu_read_lock_sched_held+0x12/0x60
[24519.681188] ? lock_release+0x1f0/0x2d0
[24519.681358] btrfs_work_helper+0xf2/0x3e0
[24519.681512] ? lock_release+0x1f0/0x2d0
[24519.681671] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.681864] process_one_work+0x270/0x5a0
[24519.682019] worker_thread+0x55/0x3c0
[24519.682166] ? process_one_work+0x5a0/0x5a0
[24519.682334] kthread+0x174/0x1a0
[24519.682473] ? set_kthread_struct+0x40/0x40
[24519.682626] ret_from_fork+0x1f/0x30
[24519.682792]
[24519.682916] irq event stamp: 0
[24519.683050] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.683249] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.683529] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.683809] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.684009] ---[ end trace 08d0ff1eb437f0ee ]---
[24519.684186] ------------[ cut here ]------------
[24519.684357] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.684638] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.686186] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.686474] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.686774] Workqueue: btrfs-cache btrfs_work_helper
[24519.686951] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.687128] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.687633] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.687825] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.688031] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.688236] RBP: 0000000000000d5f R08: ffff90589188c000 R09: 0000000000000000
[24519.688453] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007f8
[24519.688658] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cf8000
[24519.688882] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.689150] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.689339] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.689549] Call Trace:
[24519.689681]
[24519.689817] extent_buffer_test_bit+0x3f/0x70
[24519.690003] free_space_test_bit+0xa6/0xc0
[24519.690180] load_free_space_tree+0x1d6/0x430
[24519.690356] caching_thread+0x454/0x630
[24519.690505] ? rcu_read_lock_sched_held+0x12/0x60
[24519.690670] ? rcu_read_lock_sched_held+0x12/0x60
[24519.690850] ? rcu_read_lock_sched_held+0x12/0x60
[24519.691019] ? lock_release+0x1f0/0x2d0
[24519.691176] btrfs_work_helper+0xf2/0x3e0
[24519.691344] ? lock_release+0x1f0/0x2d0
[24519.691498] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.691669] process_one_work+0x270/0x5a0
[24519.691836] worker_thread+0x55/0x3c0
[24519.691984] ? process_one_work+0x5a0/0x5a0
[24519.692142] kthread+0x174/0x1a0
[24519.692290] ? set_kthread_struct+0x40/0x40
[24519.692444] ret_from_fork+0x1f/0x30
[24519.692611]
[24519.692761] irq event stamp: 0
[24519.692910] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.693097] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.693363] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.693635] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.693833] ---[ end trace 08d0ff1eb437f0ef ]---
[24519.694024] ------------[ cut here ]------------
[24519.694182] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.694466] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.695964] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.696242] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.696530] Workqueue: btrfs-cache btrfs_work_helper
[24519.696705] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.696896] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.697387] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.697558] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.697797] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.698021] RBP: 0000000000000d5f R08: ffff90589188c000 R09: 0000000000000000
[24519.698234] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007f9
[24519.698449] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cf9000
[24519.698672] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.698946] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.699129] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.700174] Call Trace:
[24519.700322]
[24519.700443] extent_buffer_test_bit+0x3f/0x70
[24519.700603] free_space_test_bit+0xa6/0xc0
[24519.700776] load_free_space_tree+0x1d6/0x430
[24519.700940] caching_thread+0x454/0x630
[24519.701099] ? rcu_read_lock_sched_held+0x12/0x60
[24519.701266] ? rcu_read_lock_sched_held+0x12/0x60
[24519.701436] ? rcu_read_lock_sched_held+0x12/0x60
[24519.701623] ? lock_release+0x1f0/0x2d0
[24519.701782] btrfs_work_helper+0xf2/0x3e0
[24519.701926] ? lock_release+0x1f0/0x2d0
[24519.702100] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.702272] process_one_work+0x270/0x5a0
[24519.702432] worker_thread+0x55/0x3c0
[24519.702578] ? process_one_work+0x5a0/0x5a0
[24519.702750] kthread+0x174/0x1a0
[24519.702897] ? set_kthread_struct+0x40/0x40
[24519.703080] ret_from_fork+0x1f/0x30
[24519.703257]
[24519.703393] irq event stamp: 0
[24519.703549] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.703764] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.704045] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.704321] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.704518] ---[ end trace 08d0ff1eb437f0f0 ]---
[24519.704699] ------------[ cut here ]------------
[24519.704874] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.705163] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.706633] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.706938] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.713243] Workqueue: btrfs-cache btrfs_work_helper
[24519.713431] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.713615] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.714125] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.714312] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.714555] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.714782] RBP: 0000000000000d5f R08: ffff90589188c000 R09: 0000000000000000
[24519.714991] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007fa
[24519.715195] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cfa000
[24519.715410] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.715664] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.715862] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.716071] Call Trace:
[24519.716202]
[24519.716333] extent_buffer_test_bit+0x3f/0x70
[24519.716500] free_space_test_bit+0xa6/0xc0
[24519.716658] load_free_space_tree+0x1d6/0x430
[24519.716834] caching_thread+0x454/0x630
[24519.716984] ? rcu_read_lock_sched_held+0x12/0x60
[24519.717153] ? rcu_read_lock_sched_held+0x12/0x60
[24519.717347] ? rcu_read_lock_sched_held+0x12/0x60
[24519.717518] ? lock_release+0x1f0/0x2d0
[24519.717672] btrfs_work_helper+0xf2/0x3e0
[24519.717844] ? lock_release+0x1f0/0x2d0
[24519.718002] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.718171] process_one_work+0x270/0x5a0
[24519.718335] worker_thread+0x55/0x3c0
[24519.718484] ? process_one_work+0x5a0/0x5a0
[24519.718636] kthread+0x174/0x1a0
[24519.718790] ? set_kthread_struct+0x40/0x40
[24519.718949] ret_from_fork+0x1f/0x30
[24519.719105]
[24519.719232] irq event stamp: 0
[24519.719385] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.719597] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.719872] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.720147] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.720350] ---[ end trace 08d0ff1eb437f0f1 ]---
[24519.720540] ------------[ cut here ]------------
[24519.720706] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.721010] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.722505] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.722792] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.723103] Workqueue: btrfs-cache btrfs_work_helper
[24519.723292] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.723470] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.723961] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.724165] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.724388] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.724613] RBP: 0000000000000d5f R08: ffff90589188c000 R09: 0000000000000000
[24519.724881] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007fb
[24519.725102] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cfb000
[24519.725356] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.725614] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.725813] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.726055] Call Trace:
[24519.726186]
[24519.726317] extent_buffer_test_bit+0x3f/0x70
[24519.726493] free_space_test_bit+0xa6/0xc0
[24519.726666] load_free_space_tree+0x1d6/0x430
[24519.726861] caching_thread+0x454/0x630
[24519.727011] ? rcu_read_lock_sched_held+0x12/0x60
[24519.727179] ? rcu_read_lock_sched_held+0x12/0x60
[24519.727349] ? rcu_read_lock_sched_held+0x12/0x60
[24519.727511] ? lock_release+0x1f0/0x2d0
[24519.727677] btrfs_work_helper+0xf2/0x3e0
[24519.727855] ? lock_release+0x1f0/0x2d0
[24519.728026] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.728204] process_one_work+0x270/0x5a0
[24519.728369] worker_thread+0x55/0x3c0
[24519.728522] ? process_one_work+0x5a0/0x5a0
[24519.728678] kthread+0x174/0x1a0
[24519.728830] ? set_kthread_struct+0x40/0x40
[24519.728991] ret_from_fork+0x1f/0x30
[24519.729142]
[24519.729260] irq event stamp: 0
[24519.730268] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.730481] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.730875] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.731171] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.731401] ---[ end trace 08d0ff1eb437f0f2 ]---
[24519.731581] ------------[ cut here ]------------
[24519.731754] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.732067] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.733734] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.734018] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.734293] Workqueue: btrfs-cache btrfs_work_helper
[24519.734478] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.734725] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.735437] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.735686] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.735931] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.736213] RBP: 0000000000000d5f R08: ffff90589188c000 R09: 0000000000000000
[24519.736429] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007fc
[24519.736641] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cfc000
[24519.736860] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.737128] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.737375] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.737612] Call Trace:
[24519.737815]
[24519.737935] extent_buffer_test_bit+0x3f/0x70
[24519.738160] free_space_test_bit+0xa6/0xc0
[24519.738329] load_free_space_tree+0x1d6/0x430
[24519.738546] caching_thread+0x454/0x630
[24519.738697] ? rcu_read_lock_sched_held+0x12/0x60
[24519.738888] ? rcu_read_lock_sched_held+0x12/0x60
[24519.739061] ? rcu_read_lock_sched_held+0x12/0x60
[24519.739224] ? lock_release+0x1f0/0x2d0
[24519.739379] btrfs_work_helper+0xf2/0x3e0
[24519.739540] ? lock_release+0x1f0/0x2d0
[24519.739769] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.739940] process_one_work+0x270/0x5a0
[24519.740155] worker_thread+0x55/0x3c0
[24519.740313] ? process_one_work+0x5a0/0x5a0
[24519.740530] kthread+0x174/0x1a0
[24519.740670] ? set_kthread_struct+0x40/0x40
[24519.740837] ret_from_fork+0x1f/0x30
[24519.740993]
[24519.741166] irq event stamp: 0
[24519.741359] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.741554] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.741836] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.742104] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.742302] ---[ end trace 08d0ff1eb437f0f3 ]---
[24519.742534] ------------[ cut here ]------------
[24519.742701] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.743000] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.744609] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.744963] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.745231] Workqueue: btrfs-cache btrfs_work_helper
[24519.745410] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.745604] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.752585] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.752780] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.752983] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.753187] RBP: 0000000000000d5f R08: ffff90589188c000 R09: 0000000000000000
[24519.753443] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007fd
[24519.753726] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cfd000
[24519.753987] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.754252] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.754443] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.754647] Call Trace:
[24519.754808]
[24519.754924] extent_buffer_test_bit+0x3f/0x70
[24519.755084] free_space_test_bit+0xa6/0xc0
[24519.755233] load_free_space_tree+0x1d6/0x430
[24519.755398] caching_thread+0x454/0x630
[24519.755551] ? rcu_read_lock_sched_held+0x12/0x60
[24519.755714] ? rcu_read_lock_sched_held+0x12/0x60
[24519.755884] ? rcu_read_lock_sched_held+0x12/0x60
[24519.756044] ? lock_release+0x1f0/0x2d0
[24519.756192] btrfs_work_helper+0xf2/0x3e0
[24519.756355] ? lock_release+0x1f0/0x2d0
[24519.756500] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.756662] process_one_work+0x270/0x5a0
[24519.756842] worker_thread+0x55/0x3c0
[24519.757045] ? process_one_work+0x5a0/0x5a0
[24519.757242] kthread+0x174/0x1a0
[24519.757397] ? set_kthread_struct+0x40/0x40
[24519.757549] ret_from_fork+0x1f/0x30
[24519.757692]
[24519.757821] irq event stamp: 0
[24519.757956] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.758140] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.758413] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.758716] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.758997] ---[ end trace 08d0ff1eb437f0f4 ]---
[24519.759197] ------------[ cut here ]------------
[24519.760016] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.760320] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.761837] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.762113] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.762402] Workqueue: btrfs-cache btrfs_work_helper
[24519.762571] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.762761] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.763243] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.763433] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.763644] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.763861] RBP: 0000000000000d5f R08: ffff90589188c000 R09: 0000000000000000
[24519.764068] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007fe
[24519.764283] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cfe000
[24519.764492] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.764767] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.764961] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.765237] Call Trace:
[24519.765418]
[24519.765572] extent_buffer_test_bit+0x3f/0x70
[24519.765804] free_space_test_bit+0xa6/0xc0
[24519.765978] load_free_space_tree+0x1d6/0x430
[24519.766185] caching_thread+0x454/0x630
[24519.766343] ? rcu_read_lock_sched_held+0x12/0x60
[24519.766513] ? rcu_read_lock_sched_held+0x12/0x60
[24519.766684] ? rcu_read_lock_sched_held+0x12/0x60
[24519.766862] ? lock_release+0x1f0/0x2d0
[24519.767016] btrfs_work_helper+0xf2/0x3e0
[24519.767171] ? lock_release+0x1f0/0x2d0
[24519.767324] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.767492] process_one_work+0x270/0x5a0
[24519.767647] worker_thread+0x55/0x3c0
[24519.767809] ? process_one_work+0x5a0/0x5a0
[24519.767966] kthread+0x174/0x1a0
[24519.768111] ? set_kthread_struct+0x40/0x40
[24519.768269] ret_from_fork+0x1f/0x30
[24519.768427]
[24519.768550] irq event stamp: 0
[24519.768689] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.768893] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.769154] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.769427] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.769616] ---[ end trace 08d0ff1eb437f0f5 ]---
[24519.769804] ------------[ cut here ]------------
[24519.769970] WARNING: CPU: 1 PID: 856208 at fs/btrfs/extent_io.c:6857 assert_eb_page_uptodate+0x3f/0x50
[24519.770258] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 rfkill nf_defrag_ipv4 ip6_tables nft_compat ip_set nf_tables nfnetlink xfs snd_hda_codec_generic intel_rapl_msr snd_hda_intel iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep intel_rapl_common snd_hda_core joydev snd_pcm i2c_i801 i2c_smbus snd_timer virtio_balloon snd lpc_ich soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw virtio_blk qemu_fw_cfg
[24519.771830] CPU: 1 PID: 856208 Comm: kworker/u4:10 Tainted: G W 5.16.0-rc4+ #524
[24519.772111] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24519.772451] Workqueue: btrfs-cache btrfs_work_helper
[24519.772619] RIP: 0010:assert_eb_page_uptodate+0x3f/0x50
[24519.772803] Code: 13 8b 4f 08 48 8b 17 4c 89 c7 e8 2c 2e 08 00 84 c0 74 1a c3 48 8b 46 08 48 8d 50 ff a8 01 48 0f 45 f2 48 8b 06 a8 04 74 01 c3 <0f> 0b c3 0f 0b c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[24519.773363] RSP: 0018:ffffb60ac4bf7c60 EFLAGS: 00010246
[24519.773533] RAX: 0017ffffc0002112 RBX: ffffefe684112680 RCX: 0000000000001000
[24519.773765] RDX: ffffefe684b4fb07 RSI: ffffefe684112680 RDI: ffff9058c6069180
[24519.773961] RBP: 0000000000000d5f R08: ffff90589188c000 R09: 0000000000000000
[24519.774157] R10: 00014ef627054710 R11: 000000000000000c R12: 00000000000007ff
[24519.774359] R13: ffff9058c6069180 R14: 0000000001500000 R15: 0000000001cff000
[24519.774553] FS: 0000000000000000(0000) GS:ffff9058fbd00000(0000) knlGS:0000000000000000
[24519.774812] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[24519.774989] CR2: 00007f71faea33e0 CR3: 0000000102294004 CR4: 0000000000370ee0
[24519.775191] Call Trace:
[24519.775325]
[24519.775436] extent_buffer_test_bit+0x3f/0x70
[24519.775631] free_space_test_bit+0xa6/0xc0
[24519.775830] load_free_space_tree+0x1d6/0x430
[24519.776046] caching_thread+0x454/0x630
[24519.776187] ? rcu_read_lock_sched_held+0x12/0x60
[24519.776356] ? rcu_read_lock_sched_held+0x12/0x60
[24519.776574] ? rcu_read_lock_sched_held+0x12/0x60
[24519.776814] ? lock_release+0x1f0/0x2d0
[24519.776969] btrfs_work_helper+0xf2/0x3e0
[24519.777152] ? lock_release+0x1f0/0x2d0
[24519.777330] ? finish_task_switch.isra.0+0xf9/0x3a0
[24519.777511] process_one_work+0x270/0x5a0
[24519.777722] worker_thread+0x55/0x3c0
[24519.777890] ? process_one_work+0x5a0/0x5a0
[24519.778089] kthread+0x174/0x1a0
[24519.778299] ? set_kthread_struct+0x40/0x40
[24519.778508] ret_from_fork+0x1f/0x30
[24519.778669]
[24519.778858] irq event stamp: 0
[24519.779051] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[24519.779269] hardirqs last disabled at (0): [] copy_process+0x862/0x20e0
[24519.779573] softirqs last enabled at (0): [] copy_process+0x862/0x20e0
[24519.779874] softirqs last disabled at (0): [<0000000000000000>] 0x0
[24519.780117] ---[ end trace 08d0ff1eb437f0f6 ]---
[24519.820772] BTRFS info (device dm-7): flagging fs with big metadata feature
[24519.821013] BTRFS info (device dm-7): use zlib compression, level 3
[24519.821222] BTRFS info (device dm-7): using free space tree
[24519.821424] BTRFS info (device dm-7): has skinny extents