syzbot


INFO: rcu detected stall in _get_random_bytes

Status: closed as invalid on 2022/02/08 10:10
Subsystems: kernel
[Documentation on labels]
First crash: 846d, last: 846d

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	1-...0: (1 GPs behind) idle=8c5/1/0x4000000000000000 softirq=210229/210234 fqs=5249 
	(detected by 0, t=10502 jiffies, g=233241, q=4548)
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 7927 Comm: kworker/1:20 Not tainted 5.16.0-rc7-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: events nsim_dev_trap_report_work
RIP: 0010:strlen+0x54/0x90 lib/string.c:487
Code: 75 48 80 7d 00 00 74 39 48 bb 00 00 00 00 00 fc ff df 48 89 e8 48 83 c0 01 48 89 c2 48 89 c1 48 c1 ea 03 83 e1 07 0f b6 14 1a <38> ca 7f 04 84 d2 75 1f 80 38 00 75 de 48 83 c4 08 48 29 e8 5b 5d
RSP: 0018:ffffc90000fd8bf0 EFLAGS: 00000002
RAX: ffffffff8ab22574 RBX: dffffc0000000000 RCX: 0000000000000004
RDX: 0000000000000007 RSI: ffff8880771f7b00 RDI: ffffffff8ab22560
RBP: ffffffff8ab22560 R08: 0000000000000000 R09: ffffffff8d911f97
R10: fffffbfff1b223f2 R11: 0000000000000001 R12: ffff8880771f7b00
R13: ffffffff8ba7e5a0 R14: ffff8880771f7b00 R15: ffffc90000fd8cc0
FS:  0000000000000000(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007ffc0afb2a10 CR3: 0000000019b31000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 strlen include/linux/fortify-string.h:102 [inline]
 trace_event_get_offsets_lock include/trace/events/lock.h:39 [inline]
 perf_trace_lock+0xb1/0x4d0 include/trace/events/lock.h:39
 trace_lock_release include/trace/events/lock.h:58 [inline]
 lock_release+0x4a8/0x720 kernel/locking/lockdep.c:5648
 __raw_spin_unlock include/linux/spinlock_api_smp.h:141 [inline]
 _raw_spin_unlock+0x12/0x40 kernel/locking/spinlock.c:186
 spin_unlock include/linux/spinlock.h:389 [inline]
 advance_sched+0x435/0x9a0 net/sched/sch_taprio.c:763
 __run_hrtimer kernel/time/hrtimer.c:1685 [inline]
 __hrtimer_run_queues+0x609/0xe50 kernel/time/hrtimer.c:1749
 hrtimer_interrupt+0x31c/0x790 kernel/time/hrtimer.c:1811
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1086 [inline]
 __sysvec_apic_timer_interrupt+0x146/0x530 arch/x86/kernel/apic/apic.c:1103
 sysvec_apic_timer_interrupt+0x8e/0xc0 arch/x86/kernel/apic/apic.c:1097
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:638
RIP: 0010:__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:152 [inline]
RIP: 0010:_raw_spin_unlock_irqrestore+0x38/0x70 kernel/locking/spinlock.c:194
Code: 74 24 10 e8 ea f5 14 f8 48 89 ef e8 a2 6b 15 f8 81 e3 00 02 00 00 75 25 9c 58 f6 c4 02 75 2d 48 85 db 74 01 fb bf 01 00 00 00 <e8> 33 36 08 f8 65 8b 05 2c 8a bb 76 85 c0 74 0a 5b 5d c3 e8 a0 22
RSP: 0018:ffffc9000f65fb48 EFLAGS: 00000206
RAX: 0000000000000002 RBX: 0000000000000200 RCX: 1ffffffff1ffa8f6
RDX: 0000000000000000 RSI: 0000000000000002 RDI: 0000000000000001
RBP: ffff888011c27848 R08: 0000000000000001 R09: ffffffff8ff7aaef
R10: 0000000000000001 R11: 0000000000000001 R12: 0000000000000006
R13: ffffc9000f65fba8 R14: 1ffff92001ecbf71 R15: ffff8880195fc000
 crng_backtrack_protect drivers/char/random.c:1053 [inline]
 _get_random_bytes+0x295/0x670 drivers/char/random.c:1540
 eth_random_addr include/linux/etherdevice.h:232 [inline]
 nsim_dev_trap_skb_build drivers/net/netdevsim/dev.c:752 [inline]
 nsim_dev_trap_report drivers/net/netdevsim/dev.c:802 [inline]
 nsim_dev_trap_report_work+0x33a/0xbc0 drivers/net/netdevsim/dev.c:843
 process_one_work+0x9b2/0x1660 kernel/workqueue.c:2298
 worker_thread+0x65d/0x1130 kernel/workqueue.c:2445
 kthread+0x405/0x4f0 kernel/kthread.c:327
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
 </TASK>
----------------
Code disassembly (best guess):
   0:	75 48                	jne    0x4a
   2:	80 7d 00 00          	cmpb   $0x0,0x0(%rbp)
   6:	74 39                	je     0x41
   8:	48 bb 00 00 00 00 00 	movabs $0xdffffc0000000000,%rbx
   f:	fc ff df
  12:	48 89 e8             	mov    %rbp,%rax
  15:	48 83 c0 01          	add    $0x1,%rax
  19:	48 89 c2             	mov    %rax,%rdx
  1c:	48 89 c1             	mov    %rax,%rcx
  1f:	48 c1 ea 03          	shr    $0x3,%rdx
  23:	83 e1 07             	and    $0x7,%ecx
  26:	0f b6 14 1a          	movzbl (%rdx,%rbx,1),%edx
* 2a:	38 ca                	cmp    %cl,%dl <-- trapping instruction
  2c:	7f 04                	jg     0x32
  2e:	84 d2                	test   %dl,%dl
  30:	75 1f                	jne    0x51
  32:	80 38 00             	cmpb   $0x0,(%rax)
  35:	75 de                	jne    0x15
  37:	48 83 c4 08          	add    $0x8,%rsp
  3b:	48 29 e8             	sub    %rbp,%rax
  3e:	5b                   	pop    %rbx
  3f:	5d                   	pop    %rbp

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2022/01/01 10:09 upstream 800829388818 e1768e9c .config console log report info ci-upstream-kasan-gce-selinux-root INFO: rcu detected stall in _get_random_bytes
* Struck through repros no longer work on HEAD.