WARNING in send_hsr_supervision_frame

WARNING in send_hsr_supervision_frame

[Sanan Hasanov]

Good day, dear maintainers,

We found a bug using a modified kernel configuration file used by syzbot.

We enhanced the coverage of the configuration file using our tool, klocalizer.

Kernel Branch: 6.2.0-rc6-next-20230131
Kernel config: https://drive.google.com/file/d/1mvxgbYKz5x6HQqwa_NUGDe0NxUVuZN4W/view?usp=sharing
Unfortunately, we do not have a reproducer yet.

Thank you!

Best regards,
Sanan Hasanov

ieee802154 phy0 wpan0: encryption failed: -22
ieee802154 phy1 wpan1: encryption failed: -22
------------[ cut here ]------------
HSR: Could not send supervision frame
WARNING: CPU: 7 PID: 19728 at net/hsr/hsr_device.c:294 send_hsr_supervision_frame+0x633/0x850
Modules linked in:
CPU: 7 PID: 19728 Comm: kworker/7:13 Not tainted 6.2.0-rc6-next-20230131+ #1
Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.15.0-1 04/01/2014
Workqueue: events fill_page_cache_func
RIP: 0010:send_hsr_supervision_frame+0x633/0x850
Code: 03 31 ff 89 de e8 ed f6 0d f9 84 db 0f 85 f8 fe ff ff e8 00 fc 0d f9 48 c7 c7 e0 19 a6 89 c6 05 d3 e2 06 03 01 e8 dd d6 d4 f8 <0f> 0b e9 d9 fe ff ff e8 e1 fb 0d f9 bb 3c 00 00 00 ba 01 00 00 00
RSP: 0018:ffff88811a589c00 EFLAGS: 00010282
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000100
RDX: ffff88804e384280 RSI: ffffffff816e1977 RDI: ffffffff816d7cb1
RBP: ffff88811a589c40 R08: 0000000000000005 R09: 0000000000000000
R10: 0000000000000101 R11: 0000000000000001 R12: ffff88811a589c70
R13: ffff888117075000 R14: 0000000000000000 R15: 0000000000000017
FS:  0000000000000000(0000) GS:ffff88811a580000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fdbbd596438 CR3: 0000000057318000 CR4: 0000000000350ee0
Call Trace:
 <IRQ>
 hsr_announce+0x122/0x390
 call_timer_fn+0x1fa/0x840
 __run_timers.part.0+0x6bf/0x950
 run_timer_softirq+0xb7/0x1b0
 __do_softirq+0x306/0xb22
 __irq_exit_rcu+0x196/0x230
 irq_exit_rcu+0xd/0x30
 sysvec_apic_timer_interrupt+0xa5/0xc0
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x1f/0x30
RIP: 0010:_raw_spin_unlock_irq+0x52/0x90
Code: c7 c0 a0 4c 77 8a 48 ba 00 00 00 00 00 fc ff df 48 c1 e8 03 80 3c 10 00 75 38 48 83 3d 16 6e e9 01 00 74 25 fb 0f 1f 44 00 00 <bf> 01 00 00 00 e8 34 19 d0 f8 65 8b 05 e5 e8 75 77 85 c0 74 0c 4c
RSP: 0018:ffff888027787310 EFLAGS: 00000282
RAX: 1ffffffff14ee994 RBX: 0000000000000020 RCX: 1ffffffff1a9fcce
RDX: dffffc0000000000 RSI: 0000000000000001 RDI: 0000000000000000
RBP: ffff888027787318 R08: 0000000000000001 R09: ffffffff8d4f64d7
R10: fffffbfff1a9ec9a R11: 0000000000000001 R12: ffff88810083a050
R13: ffff8880277878a0 R14: ffff8880277874d8 R15: 0000000000000000
 shrink_lruvec+0xd19/0x2770
 shrink_node+0x8f2/0x1ed0
 do_try_to_free_pages+0x3ff/0x18c0
 try_to_free_pages+0x348/0xa20
 __alloc_pages_slowpath.constprop.0+0xa0c/0x2590
 __alloc_pages+0x51c/0x6e0
 alloc_pages+0x1a5/0x260
 __get_free_pages+0x10/0x50
 fill_page_cache_func+0xae/0x240
 process_one_work+0xa2d/0x1940
 worker_thread+0x674/0x10b0
 kthread+0x306/0x3d0
 ret_from_fork+0x2c/0x50
 </TASK>
irq event stamp: 727444
hardirqs last  enabled at (727454): [<ffffffff816d7284>] __up_console_sem+0xf4/0x180
hardirqs last disabled at (727463): [<ffffffff816d7269>] __up_console_sem+0xd9/0x180
softirqs last  enabled at (725494): [<ffffffff81534006>] __irq_exit_rcu+0x196/0x230
softirqs last disabled at (726425): [<ffffffff81534006>] __irq_exit_rcu+0x196/0x230
---[ end trace 0000000000000000 ]---
ICMPv6: ndisc: ndisc_alloc_skb failed to allocate an skb
loop6: detected capacity change from 0 to 128
EXT4-fs (loop6): mounted filesystem 76b65be2-f6da-4727-8c75-0525a5b65a09 without journal. Quota mode: none.
ext4 filesystem being mounted at /syzkaller-testdir455853457/syzkaller.BkvIxk/371/mnt supports timestamps until 2038 (0x7fffffff)
----------------
Code disassembly (best guess):
   0:	c7 c0 a0 4c 77 8a    	mov    $0x8a774ca0,%eax
   6:	48 ba 00 00 00 00 00 	movabs $0xdffffc0000000000,%rdx
   d:	fc ff df
  10:	48 c1 e8 03          	shr    $0x3,%rax
  14:	80 3c 10 00          	cmpb   $0x0,(%rax,%rdx,1)
  18:	75 38                	jne    0x52
  1a:	48 83 3d 16 6e e9 01 	cmpq   $0x0,0x1e96e16(%rip)        # 0x1e96e38
  21:	00
  22:	74 25                	je     0x49
  24:	fb                   	sti
  25:	0f 1f 44 00 00       	nopl   0x0(%rax,%rax,1)
* 2a:	bf 01 00 00 00       	mov    $0x1,%edi <-- trapping instruction
  2f:	e8 34 19 d0 f8       	call   0xf8d01968
  34:	65 8b 05 e5 e8 75 77 	mov    %gs:0x7775e8e5(%rip),%eax        # 0x7775e920
  3b:	85 c0                	test   %eax,%eax
  3d:	74 0c                	je     0x4b
  3f:	4c                   	rex.WR

WARNING in send_hsr_supervision_frame

[syzbot]

Hello,

syzbot found the following issue on:

HEAD commit:    449dc8c9 Merge tag 'for-v5.9' of git://git.kernel.org/pub/..
git tree:       upstream
console output: https://syzkaller.appspot.com/x/log.txt?x=11b7d71a900000
kernel config:  https://syzkaller.appspot.com/x/.config?x=bf68a13f867fd1b4
dashboard link: https://syzkaller.appspot.com/bug?extid=306c47d7ca825a3a6589
compiler:       gcc (GCC) 10.1.0-syz 20200507

Unfortunately, I don't have any reproducer for this issue yet.

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+306c47d7ca825a3a6589@syzkaller.appspotmail.com

------------[ cut here ]------------
HSR: Could not send supervision frame
WARNING: CPU: 1 PID: 32657 at net/hsr/hsr_device.c:299 send_hsr_supervision_frame+0x889/0xb40 net/hsr/hsr_device.c:299
Kernel panic - not syncing: panic_on_warn set ...
CPU: 1 PID: 32657 Comm: kworker/u4:1 Not tainted 5.8.0-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue:  0x0 (wg-kex-wg2)
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:77 [inline]
 dump_stack+0x18f/0x20d lib/dump_stack.c:118
 panic+0x2e3/0x75c kernel/panic.c:231
 __warn.cold+0x20/0x45 kernel/panic.c:600
 report_bug+0x1bd/0x210 lib/bug.c:198
 handle_bug+0x38/0x90 arch/x86/kernel/traps.c:234
 exc_invalid_op+0x14/0x40 arch/x86/kernel/traps.c:254
 asm_exc_invalid_op+0x12/0x20 arch/x86/include/asm/idtentry.h:536
RIP: 0010:send_hsr_supervision_frame+0x889/0xb40 net/hsr/hsr_device.c:299
Code: 02 31 ff 89 de e8 07 db 8c f9 84 db 0f 85 8b fd ff ff e8 ba de 8c f9 48 c7 c7 00 de 20 89 c6 05 e5 61 c5 02 01 e8 59 ea 5d f9 <0f> 0b e9 6c fd ff ff e8 9b de 8c f9 41 be 42 00 00 00 ba 01 00 00
RSP: 0000:ffffc90000da8c48 EFLAGS: 00010286
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffff888095cc8280 RSI: ffffffff815db887 RDI: fffff520001b517b
RBP: 00000000000088fb R08: 0000000000000001 R09: ffff8880ae731927
R10: 0000000000000000 R11: 0000000000003143 R12: ffff8880a62c1400
R13: 0000000000000000 R14: ffff8880510aece8 R15: ffff8880ae725600
 hsr_announce+0x122/0x320 net/hsr/hsr_device.c:404
 call_timer_fn+0x1ac/0x760 kernel/time/timer.c:1413
 expire_timers kernel/time/timer.c:1458 [inline]
 __run_timers.part.0+0x67c/0xaa0 kernel/time/timer.c:1755
 __run_timers kernel/time/timer.c:1736 [inline]
 run_timer_softirq+0xae/0x1a0 kernel/time/timer.c:1768
 __do_softirq+0x2de/0xa24 kernel/softirq.c:298
 asm_call_on_stack+0xf/0x20 arch/x86/entry/entry_64.S:706
 </IRQ>
 __run_on_irqstack arch/x86/include/asm/irq_stack.h:22 [inline]
 run_on_irqstack_cond arch/x86/include/asm/irq_stack.h:48 [inline]
 do_softirq_own_stack+0x9d/0xd0 arch/x86/kernel/irq_64.c:77
 invoke_softirq kernel/softirq.c:393 [inline]
 __irq_exit_rcu kernel/softirq.c:423 [inline]
 irq_exit_rcu+0x1f3/0x230 kernel/softirq.c:435
 sysvec_apic_timer_interrupt+0x51/0xf0 arch/x86/kernel/apic/apic.c:1090
 asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:581
RIP: 0010:__raw_spin_unlock_irq include/linux/spinlock_api_smp.h:169 [inline]
RIP: 0010:_raw_spin_unlock_irq+0x4b/0x80 kernel/locking/spinlock.c:199
Code: c0 58 34 b6 89 48 ba 00 00 00 00 00 fc ff df 48 c1 e8 03 80 3c 10 00 75 31 48 83 3d 06 70 c3 01 00 74 25 fb 66 0f 1f 44 00 00 <bf> 01 00 00 00 e8 bb fc 5c f9 65 8b 05 54 3a 0f 78 85 c0 74 02 5d
RSP: 0000:ffffc90005787e40 EFLAGS: 00000286
RAX: 1ffffffff136c68b RBX: ffff888095cc8280 RCX: 1ffffffff1562d79
RDX: dffffc0000000000 RSI: 0000000000000000 RDI: ffffffff87f2c42f
RBP: ffff8880aa071800 R08: 0000000000000001 R09: 0000000000000001
R10: 0000000000000000 R11: 0000000000000000 R12: ffff88803930bf00
R13: ffff8880a0a49d00 R14: 0000000000000000 R15: ffff8880aa071800
 worker_thread+0x147/0x1120 kernel/workqueue.c:2435
 kthread+0x3b5/0x4a0 kernel/kthread.c:292
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:294
Kernel Offset: disabled
Rebooting in 86400 seconds..


---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzkaller@googlegroups.com.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.