5.14.0-rc1 KASAN use after free
From: jim . cromie
Date: Thu Jul 15 2021 - 10:32:59 EST
hi all,
I noticed this report this morning, from 3 days ago,
about 10 minutes after boot.
Its easiest to ignore it, and I dont want to make a fuss,
but it looks useful to someone
[ 33.663464] Bluetooth: RFCOMM ver 1.11
[ 646.343628] ==================================================================
[ 646.343649] BUG: KASAN: use-after-free in bfq_get_queue+0x47d/0x900
[ 646.343680] Read of size 8 at addr ffff88810d864a00 by task
journal-offline/1639
[ 646.343708] CPU: 2 PID: 1639 Comm: journal-offline Not tainted
5.14.0-rc1-lm1 #66
[ 646.343730] Hardware name: TOSHIBA Satellite L55-C/06F4
, BIOS 1.20 10/08/2015
[ 646.343745] Call Trace:
[ 646.343757] dump_stack_lvl+0x46/0x5a
[ 646.343781] print_address_description.constprop.0+0x1f/0x140
[ 646.343808] ? bfq_get_queue+0x47d/0x900
[ 646.343829] kasan_report.cold+0x7f/0x11b
[ 646.343854] ? bfq_init_bfqq+0x2a0/0x330
[ 646.343873] ? bfq_get_queue+0x47d/0x900
[ 646.343895] bfq_get_queue+0x47d/0x900
[ 646.343918] ? bfq_merge_bfqqs+0x7a0/0x7a0
[ 646.343939] ? _raw_write_unlock_bh+0x30/0x30
[ 646.343965] bfq_get_bfqq_handle_split+0xa1/0x240
[ 646.343991] bfq_init_rq+0x1e0/0x15e0
[ 646.344013] ? submit_bio_noacct+0x7f0/0x7f0
[ 646.344036] ? percpu_counter_add_batch+0x1f/0x90
[ 646.344059] ? bfq_get_bfqq_handle_split+0x240/0x240
[ 646.344082] ? btrfs_map_bio+0x404/0x830
[ 646.344100] ? elv_rqhash_find+0x42/0x180
[ 646.344121] ? _raw_spin_lock_irq+0x71/0xb0
[ 646.344142] ? _raw_write_lock_irq+0xb0/0xb0
[ 646.344164] bfq_insert_requests+0xe2/0x2a10
[ 646.344190] ? btrfs_submit_data_bio+0x186/0x340
[ 646.344215] ? submit_one_bio+0x81/0xc0
[ 646.344235] ? bfq_request_merged+0x110/0x110
[ 646.344256] ? blk_status_to_errno+0x20/0x30
[ 646.344279] ? extent_write_locked_range+0x360/0x360
[ 646.344302] ? btrfs_use_block_rsv+0x320/0x320
[ 646.344324] blk_mq_sched_insert_requests+0xa6/0x1a0
[ 646.344347] blk_mq_flush_plug_list+0x1fa/0x2f0
[ 646.344374] ? blk_mq_insert_requests+0x1a0/0x1a0
[ 646.344399] ? __filemap_fdatawrite_range+0x176/0x1c0
[ 646.344423] blk_flush_plug_list+0x1d4/0x200
[ 646.344449] ? blk_insert_cloned_request+0x170/0x170
[ 646.344476] blk_finish_plug+0x3c/0x60
[ 646.344500] start_ordered_ops.constprop.0+0xc3/0xf0
[ 646.344525] ? btrfs_file_write_iter+0x5b0/0x5b0
[ 646.344554] btrfs_sync_file+0x135/0x880
[ 646.344578] ? rwsem_mark_wake+0x460/0x460
[ 646.344601] ? start_ordered_ops.constprop.0+0xf0/0xf0
[ 646.344628] ? vfs_fsync_range+0x86/0x100
[ 646.344650] __x64_sys_fsync+0x3f/0x70
[ 646.344672] do_syscall_64+0x3b/0x90
[ 646.344696] entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 646.344720] RIP: 0033:0x7f6eedeecebb
[ 646.344738] Code: 4a 00 00 00 0f 05 48 3d 00 f0 ff ff 77 41 c3 48
83 ec 18 89 7c 24 0c e8 53 f7 ff ff 8b 7c 24 0c 41 89 c0 b8 4a 00 00
00 0f 05 <48> 3d 00 f0 ff ff 77 35 44 89 c7 89 44 24 0c e8 b1 f7 ff ff
8b 44
[ 646.344760] RSP: 002b:00007f6ee919ca10 EFLAGS: 00000293 ORIG_RAX:
000000000000004a
[ 646.344784] RAX: ffffffffffffffda RBX: 00005614c6093620 RCX: 00007f6eedeecebb
[ 646.344801] RDX: 0000000000000002 RSI: 00007f6eee1cb9e2 RDI: 0000000000000017
[ 646.344815] RBP: 00007f6eee1cd610 R08: 0000000000000000 R09: 00007f6ee919d640
[ 646.344830] R10: 0000000000000002 R11: 0000000000000293 R12: 0000000000000002
[ 646.344843] R13: 00007ffec2aede3f R14: 0000000000000000 R15: 00007f6ee919d640
[ 646.344874] Allocated by task 1626:
[ 646.344886] kasan_save_stack+0x1b/0x40
[ 646.344906] __kasan_slab_alloc+0x61/0x80
[ 646.344924] kmem_cache_alloc_node+0x151/0x2d0
[ 646.344942] bfq_get_queue+0x209/0x900
[ 646.344961] bfq_get_bfqq_handle_split+0xa1/0x240
[ 646.344982] bfq_init_rq+0x1e0/0x15e0
[ 646.345001] bfq_insert_requests+0xe2/0x2a10
[ 646.345020] blk_mq_sched_insert_requests+0xa6/0x1a0
[ 646.345039] blk_mq_flush_plug_list+0x1fa/0x2f0
[ 646.345060] blk_flush_plug_list+0x1d4/0x200
[ 646.345082] blk_finish_plug+0x3c/0x60
[ 646.345103] start_ordered_ops.constprop.0+0xc3/0xf0
[ 646.345124] btrfs_sync_file+0x135/0x880
[ 646.345144] __x64_sys_fsync+0x3f/0x70
[ 646.345163] do_syscall_64+0x3b/0x90
[ 646.345183] entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 646.345212] The buggy address belongs to the object at ffff88810d864810
which belongs to the cache bfq_queue of size 560
[ 646.345229] The buggy address is located 496 bytes inside of
560-byte region [ffff88810d864810, ffff88810d864a40)
[ 646.345248] The buggy address belongs to the page:
[ 646.345258] page:0000000040e75441 refcount:1 mapcount:0
mapping:0000000000000000 index:0xffff88810d864810 pfn:0x10d864
[ 646.345280] head:0000000040e75441 order:2 compound_mapcount:0
compound_pincount:0
[ 646.345296] flags:
0x17ffffc0010200(slab|head|node=0|zone=2|lastcpupid=0x1fffff)
[ 646.345326] raw: 0017ffffc0010200 0000000000000000 dead000000000122
ffff88810145b400
[ 646.345345] raw: ffff88810d864810 000000008017000f 00000001ffffffff
0000000000000000
[ 646.345357] page dumped because: kasan: bad access detected
[ 646.345375] Memory state around the buggy address:
[ 646.345387] ffff88810d864900: fb fb fb fb fb fb fb fb fb fb fb fb
fb fb fb fb
[ 646.345403] ffff88810d864980: fb fb fb fb fb fb fb fb fb fb fb fb
fb fb fb fb
[ 646.345417] >ffff88810d864a00: fb fb fb fb fb fb fb fb fc fc fc fc
fc fc fc fc
[ 646.345428] ^
[ 646.345441] ffff88810d864a80: fc fc fc fc fc fc fc fc fb fb fb fb
fb fb fb fb
[ 646.345455] ffff88810d864b00: fb fb fb fb fb fb fb fb fb fb fb fb
fb fb fb fb
[ 646.345467] ==================================================================
[ 646.345476] Disabling lock debugging due to kernel taint
[20632.749805] rfkill: input handler enabled
[20636.319701] rfkill: input handler disabled
[22201.638710] perf: interrupt took too long (2514 > 2500), lowering
kernel.perf_event_max_sample_rate to 79000
[22539.009414] perf: interrupt took too long (3145 > 3142), lowering
kernel.perf_event_max_sample_rate to 63000
[23091.879235] perf: interrupt took too long (3960 > 3931), lowering
kernel.perf_event_max_sample_rate to 50000
[24206.193740] perf: interrupt took too long (4972 > 4950), lowering
kernel.perf_event_max_sample_rate to 40000
[25306.264832] L1TF CPU bug present and SMT on, data leak possible.
See CVE-2018-3646 and
https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/l1tf.html
for details.
[38172.611967] nf_conntrack: default automatic helper assignment has
been turned off for security reasons and CT-based firewall rule not
found. Use the iptables CT target to attach helpers instead.
[123082.553154] psmouse serio2: bad data from KBC - timeout
[211716.941601] ------------[ cut here ]------------
[211716.941610] cfs_rq->avg.load_avg || cfs_rq->avg.util_avg ||
cfs_rq->avg.runnable_avg
[211716.941619] WARNING: CPU: 4 PID: 33 at kernel/sched/fair.c:3307
update_blocked_averages+0xb7c/0xbf0
[211716.941641] Modules linked in: uinput rfcomm xt_CHECKSUM
xt_MASQUERADE xt_conntrack ipt_REJECT nf_nat_tftp nf_conntrack_tftp
bridge stp llc ccm nft_objref nf_conntrack_netbios_ns
nf_conntrack_broadcast 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 ip6table_nat ip6table_mangle ip6table_raw
ip6table_security iptable_nat nf_nat nf_conntrack nf_defrag_ipv6
nf_defrag_ipv4 iptable_mangle iptable_raw iptable_security ip_set
nf_tables nfnetlink ip6table_filter ip6_tables iptable_filter cmac
bnep sunrpc vfat iwlmvm fat snd_hda_codec_hdmi intel_rapl_msr mac80211
snd_hda_codec_conexant at24 snd_hda_codec_generic ledtrig_audio
iTCO_wdt intel_pmc_bxt mei_hdcp iTCO_vendor_support libarc4
intel_wmi_thunderbolt wmi_bmof uvcvideo btusb snd_hda_intel btrtl
btbcm snd_intel_dspcfg videobuf2_vmalloc videobuf2_memops btintel
videobuf2_v4l2 videobuf2_common intel_rapl_common snd_hda_codec
x86_pkg_temp_thermal iwlwifi
[211716.941813] intel_powerclamp videodev coretemp snd_hwdep rapl
snd_hda_core bluetooth intel_cstate snd_seq mc intel_uncore joydev
snd_seq_device ecdh_generic cfg80211 ecc pcspkr snd_pcm snd_timer
mei_me snd toshiba_acpi i2c_i801 mei sparse_keymap soundcore
industrialio i2c_smbus toshiba_bluetooth rfkill wmi acpi_pad ip_tables
rtsx_pci_sdmmc mmc_core crct10dif_pclmul crc32_pclmul i915
crc32c_intel i2c_algo_bit ttm ghash_clmulni_intel serio_raw r8169
drm_kms_helper cec rtsx_pci drm video fuse
[211716.941897] CPU: 4 PID: 33 Comm: ksoftirqd/4 Tainted: G B
5.14.0-rc1-lm1 #66
[211716.941903] Hardware name: TOSHIBA Satellite L55-C/06F4
, BIOS 1.20 10/08/2015
[211716.941907] RIP: 0010:update_blocked_averages+0xb7c/0xbf0
[211716.941916] Code: c0 5e ab 90 c6 05 98 15 a7 02 01 e8 21 48 14 01
0f 0b e9 13 f6 ff ff 48 c7 c7 20 5f ab 90 c6 05 7a 15 a7 02 01 e8 07
48 14 01 <0f> 0b 48 8b 7c 24 20 e8 38 61 31 00 45 8b af 38 01 00 00 e9
e3 f9
[211716.941921] RSP: 0018:ffff888100fefc58 EFLAGS: 00010082
[211716.941926] RAX: 0000000000000000 RBX: ffff88821bb334c0 RCX:
0000000000000000
[211716.941930] RDX: 0000000000000027 RSI: 0000000000000004 RDI:
ffffed10201fdf81
[211716.941934] RBP: ffff88821bb32de0 R08: ffffffff8f3f445e R09:
ffff88821bb20a8b
[211716.941937] R10: ffffed1043764151 R11: 0000000000000001 R12:
ffffffff927d77c0
[211716.941941] R13: 0000000000000001 R14: ffff88821bb33728 R15:
ffff88821bb32d40
[211716.941945] FS: 0000000000000000(0000) GS:ffff88821bb00000(0000)
knlGS:0000000000000000
[211716.941949] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[211716.941952] CR2: 0000556174b0d040 CR3: 0000000140414001 CR4:
00000000003726e0
[211716.941956] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
0000000000000000
[211716.941959] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7:
0000000000000400
[211716.941963] Call Trace:
[211716.941968] newidle_balance+0x34d/0x6b0
[211716.941974] ? update_cfs_group+0x1e/0x150
[211716.941980] ? load_balance+0x1290/0x1290
[211716.941985] ? update_min_vruntime+0x44/0xc0
[211716.941991] pick_next_task_fair+0x59/0x660
[211716.941997] __schedule+0x225/0xeb0
[211716.942005] ? io_schedule_timeout+0xb0/0xb0
[211716.942011] ? __do_softirq+0x209/0x373
[211716.942017] schedule+0x6d/0x120
[211716.942023] smpboot_thread_fn+0x1b7/0x250
[211716.942030] ? smpboot_register_percpu_thread+0x190/0x190
[211716.942036] kthread+0x1d2/0x200
[211716.942041] ? set_kthread_struct+0x80/0x80
[211716.942046] ret_from_fork+0x22/0x30
[211716.942055] ---[ end trace ee8f02e72a76fda7 ]---
[256577.295169] show_signal_msg: 4 callbacks suppressed
[256577.295176] gnome-shell[2236]: segfault at 18 ip 00007f16ab0563ee
sp 00007ffcd6601570 error 4 in libgjs.so.0.0.0[7f16ab025000+92000]
[256577.295205] Code: ec 30 64 48 8b 04 25 28 00 00 00 48 89 44 24 28
31 c0 e8 05 32 00 00 48 89 c3 e8 8d 36 fd ff 48 89 c7 e8 c5 30 fd ff
48 89 c5 <48> 8b 43 18 48 85 c0 0f 84 85 00 00 00 48 8b 50 18 48 8d 45
18 49
[256588.051436] rfkill: input handler enabled