WARNING in trace_hardirqs

WARNING in trace_hardirqs_on
Status: auto-closed as invalid on 2021/01/28 15:29
Reported-by: syzbot+b5f7b2c028d621a3cbdd@syzkaller.appspotmail.com
First crash: 413d, last: 380d

Sample crash report:
------------[ cut here ]------------
DEBUG_LOCKS_WARN_ON(lockdep_hardirq_context())
WARNING: CPU: 1 PID: 20825 at kernel/locking/lockdep.c:3691 lockdep_hardirqs_on_prepare kernel/locking/lockdep.c:3691 [inline]
WARNING: CPU: 1 PID: 20825 at kernel/locking/lockdep.c:3691 lockdep_hardirqs_on_prepare+0x340/0x530 kernel/locking/lockdep.c:3649
Kernel panic - not syncing: panic_on_warn set ...
CPU: 1 PID: 20825 Comm: syz-executor.0 Not tainted 5.9.0-rc7-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:77 [inline]
 dump_stack+0x198/0x1fd lib/dump_stack.c:118
 panic+0x382/0x7fb kernel/panic.c:231
 __warn.cold+0x20/0x4b 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:lockdep_hardirqs_on_prepare kernel/locking/lockdep.c:3691 [inline]
RIP: 0010:lockdep_hardirqs_on_prepare+0x340/0x530 kernel/locking/lockdep.c:3649
Code: 08 84 d2 0f 85 e5 01 00 00 8b 15 e3 fe fd 09 85 d2 0f 85 fb fe ff ff 48 c7 c6 80 fe 8b 88 48 c7 c7 80 d5 8b 88 e8 22 e3 ea ff <0f> 0b e9 e1 fe ff ff be 06 00 00 00 48 89 ef e8 cc fb ff ff e9 7d
RSP: 0018:ffffc90000da8a60 EFLAGS: 00010082
RAX: 0000000000000000 RBX: 0000000000000003 RCX: 0000000000000000
RDX: ffff88809478c1c0 RSI: ffffffff815f59d5 RDI: fffff520001b513e
RBP: ffffc90000da8b48 R08: 0000000000000000 R09: ffffffff8a05ae03
R10: 0000000000000d13 R11: 0000000000000001 R12: 0000000000000000
R13: ffffffff812959fe R14: 0000000000000000 R15: 0000000000000000
 trace_hardirqs_on+0x5f/0x220 kernel/trace/trace_preemptirq.c:49
 cond_local_irq_enable.isra.0+0xe/0x50 arch/x86/kernel/traps.c:77
 __exc_general_protection arch/x86/kernel/traps.c:532 [inline]
 exc_general_protection+0xb1/0x2e0 arch/x86/kernel/traps.c:524
 asm_exc_general_protection+0x1e/0x30 arch/x86/include/asm/idtentry.h:532
RIP: 0010:instrument_atomic_read include/linux/instrumented.h:56 [inline]
RIP: 0010:atomic_read include/asm-generic/atomic-instrumented.h:27 [inline]
RIP: 0010:pvclock_gtod_notify+0x3f0/0x570 arch/x86/kvm/x86.c:7472
Code: 9b 8b 0b e8 a2 c9 4f 00 8b 1d ac 9a 8b 0b bf 01 00 00 00 83 05 70 9a 8b 0b 01 70 77 77 07 de e8 b6 04 6a 00 83 fb 01 74 29 e8 <4c> 08 6a 00 be 04 00 00 00 48 c7 c7 60 d0 97 8c e8 9b b0 aa 00 8b
RSP: 0018:ffffc90000da8bf0 EFLAGS: 00010282
RAX: 0000000000000000 RBX: 0000000000000001 RCX: 0000000000000000
RDX: dffffc0000000000 RSI: ffffffff8c97d0a8 RDI: 0000000000000001
RBP: ffffffff89f77140 R08: 0000000000000001 R09: ffff88809478caa0
R10: fffffbfff16b2ca9 R11: 0000000000000000 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000000 R15: ffffffff89f02dc0
 notifier_call_chain+0xb5/0x200 kernel/notifier.c:83
 update_pvclock_gtod kernel/time/timekeeping.c:581 [inline]
 timekeeping_update+0x28a/0x4a0 kernel/time/timekeeping.c:675
 timekeeping_advance+0x6ad/0xa40 kernel/time/timekeeping.c:2122
 tick_do_update_jiffies64.part.0+0x1ec/0x330 kernel/time/tick-sched.c:101
 tick_do_update_jiffies64 kernel/time/tick-sched.c:64 [inline]
 tick_sched_do_timer kernel/time/tick-sched.c:147 [inline]
 tick_sched_timer+0x236/0x2a0 kernel/time/tick-sched.c:1321
 __run_hrtimer kernel/time/hrtimer.c:1524 [inline]
 __hrtimer_run_queues+0x1d5/0xfc0 kernel/time/hrtimer.c:1588
 hrtimer_interrupt+0x334/0x940 kernel/time/hrtimer.c:1650
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1080 [inline]
 __sysvec_apic_timer_interrupt+0x147/0x5f0 arch/x86/kernel/apic/apic.c:1097
 asm_call_irq_on_stack+0xf/0x20
 </IRQ>
 __run_sysvec_on_irqstack arch/x86/include/asm/irq_stack.h:37 [inline]
 run_sysvec_on_irqstack_cond arch/x86/include/asm/irq_stack.h:89 [inline]
 sysvec_apic_timer_interrupt+0xb2/0xf0 arch/x86/kernel/apic/apic.c:1091
 asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:581
RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:770 [inline]
RIP: 0010:seqcount_lockdep_reader_access include/linux/seqlock.h:104 [inline]
RIP: 0010:read_seqcount_t_begin.constprop.0+0x10f/0x1e0 include/linux/seqlock.h:311
Code: 00 fc ff df 48 c1 e8 03 80 3c 10 00 0f 85 be 00 00 00 48 83 3d 89 cf 95 08 00 0f 84 98 00 00 00 e8 26 a2 0f 00 48 89 df 57 9d <0f> 1f 44 00 00 44 8b 25 85 ac a1 08 31 ff 44 89 e3 83 e3 01 89 de
RSP: 0018:ffffc90007377da0 EFLAGS: 00000212
RAX: 00000000000016d0 RBX: 0000000000000212 RCX: ffffc90006389000
RDX: 0000000000040000 RSI: ffffffff81669c6a RDI: 0000000000000212
RBP: 0000000000000200 R08: 0000000000000001 R09: 0000000000000001
R10: 0000000000000000 R11: 0000000000000000 R12: 00007f720b020c60
R13: dffffc0000000000 R14: dffffc0000000000 R15: 0000000000000000
 ktime_get_ts64+0x50/0x210 kernel/time/timekeeping.c:893
 posix_get_monotonic_timespec+0x6c/0x250 kernel/time/posix-timers.c:199
 __do_sys_clock_gettime kernel/time/posix-timers.c:1092 [inline]
 __se_sys_clock_gettime kernel/time/posix-timers.c:1082 [inline]
 __x64_sys_clock_gettime+0x153/0x260 kernel/time/posix-timers.c:1082
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
BUG: unable to handle page fault for address: 0000000080010003
#PF: supervisor write access in kernel mode
#PF: error_code(0x0002) - not-present page
PGD 9ee60067 P4D 9ee60067 PUD 0 
Oops: 0002 [#1] PREEMPT SMP KASAN
CPU: 1 PID: 20825 Comm: syz-executor.0 Not tainted 5.9.0-rc7-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:in_gate_area_no_mm+0x3e/0x6a arch/x86/entry/vsyscall/vsyscall_64.c:344
Code: 00 00 00 89 ee e8 52 95 75 00 83 fd 02 74 24 e8 e8 98 75 00 48 81 e3 00 f0 ff ff 48 c7 c7 00 00 60 ff 48 89 de e8 52 95 75 00 <48> 81 00 00 00 00 ff 74 10 e8 c4 98 75 00 45 31 e4 5b 44 89 e0 5d
RSP: 0018:ffffc90000da7fa8 EFLAGS: 00010046
RAX: 0000000080010003 RBX: 0000000000460000 RCX: ffffffff8100a5be
RDX: 0000000000460000 RSI: ffff88809478c1c0 RDI: 0000000000000007
RBP: 0000000000000000 R08: ffffc90000da8170 R09: ffffffff8d3fd0c9
R10: ffffffffff600000 R11: 0000000000000001 R12: ffffc90000da8170
R13: 0000000000000001 R14: 0000000000460bda R15: ffffc90000da8080
FS:  00007f720b021700(0000) GS:ffff8880ae500000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000080010003 CR3: 0000000094a3b000 CR4: 00000000001506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 is_kernel include/linux/kallsyms.h:44 [inline]
 is_ksym_addr include/linux/kallsyms.h:50 [inline]
 kallsyms_lookup+0xc3/0x2e0 kernel/kallsyms.c:291
 __sprint_symbol+0x9c/0x1c0 kernel/kallsyms.c:364
 symbol_string+0x14c/0x370 lib/vsprintf.c:972
 pointer+0x185/0x970 lib/vsprintf.c:2224
 vsnprintf+0x5b2/0x14f0 lib/vsprintf.c:2622
 vscnprintf+0x29/0x80 lib/vsprintf.c:2721
 vprintk_store+0x44/0x4a0 kernel/printk/printk.c:1950
 vprintk_emit+0x14c/0x740 kernel/printk/printk.c:2011
 vprintk_func+0x8d/0x1d4 kernel/printk/printk_safe.c:393
 printk+0xba/0xed kernel/printk/printk.c:2078
 show_ip+0x22/0x30 arch/x86/kernel/dumpstack.c:131
 show_iret_regs+0xd/0x33 arch/x86/kernel/dumpstack.c:138
 __show_regs+0x1f/0x60 arch/x86/kernel/process_64.c:73
 show_trace_log_lvl+0x25b/0x2ba arch/x86/kernel/dumpstack.c:281
 __dump_stack lib/dump_stack.c:77 [inline]
 dump_stack+0x198/0x1fd lib/dump_stack.c:118
 panic+0x382/0x7fb kernel/panic.c:231
 __warn.cold+0x20/0x4b 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:lockdep_hardirqs_on_prepare kernel/locking/lockdep.c:3691 [inline]
RIP: 0010:lockdep_hardirqs_on_prepare+0x340/0x530 kernel/locking/lockdep.c:3649
Code: 08 84 d2 0f 85 e5 01 00 00 8b 15 e3 fe fd 09 85 d2 0f 85 fb fe ff ff 48 c7 c6 80 fe 8b 88 48 c7 c7 80 d5 8b 88 e8 22 e3 ea ff <0f> 0b e9 e1 fe ff ff be 06 00 00 00 48 89 ef e8 cc fb ff ff e9 7d
RSP: 0018:ffffc90000da8a60 EFLAGS: 00010082
RAX: 0000000000000000 RBX: 0000000000000003 RCX: 0000000000000000
RDX: ffff88809478c1c0 RSI: ffffffff815f59d5 RDI: fffff520001b513e
RBP: ffffc90000da8b48 R08: 0000000000000000 R09: ffffffff8a05ae03
R10: 0000000000000d13 R11: 0000000000000001 R12: 0000000000000000
R13: ffffffff812959fe R14: 0000000000000000 R15: 0000000000000000
 trace_hardirqs_on+0x5f/0x220 kernel/trace/trace_preemptirq.c:49
 cond_local_irq_enable.isra.0+0xe/0x50 arch/x86/kernel/traps.c:77
 __exc_general_protection arch/x86/kernel/traps.c:532 [inline]
 exc_general_protection+0xb1/0x2e0 arch/x86/kernel/traps.c:524
 asm_exc_general_protection+0x1e/0x30 arch/x86/include/asm/idtentry.h:532
RIP: 0010:instrument_atomic_read include/linux/instrumented.h:56 [inline]
RIP: 0010:atomic_read include/asm-generic/atomic-instrumented.h:27 [inline]
RIP: 0010:pvclock_gtod_notify+0x3f0/0x570 arch/x86/kvm/x86.c:7472
Code: 9b 8b 0b e8 a2 c9 4f 00 8b 1d ac 9a 8b 0b bf 01 00 00 00 83 05 70 9a 8b 0b 01 70 77 77 07 de e8 b6 04 6a 00 83 fb 01 74 29 e8 <4c> 08 6a 00 be 04 00 00 00 48 c7 c7 60 d0 97 8c e8 9b b0 aa 00 8b
RSP: 0018:ffffc90000da8bf0 EFLAGS: 00010282
RAX: 0000000000000000 RBX: 0000000000000001 RCX: 0000000000000000
RDX: dffffc0000000000 RSI: ffffffff8c97d0a8 RDI: 0000000000000001
RBP: ffffffff89f77140 R08: 0000000000000001 R09: ffff88809478caa0
R10: fffffbfff16b2ca9 R11: 0000000000000000 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000000 R15: ffffffff89f02dc0
 notifier_call_chain+0xb5/0x200 kernel/notifier.c:83
 update_pvclock_gtod kernel/time/timekeeping.c:581 [inline]
 timekeeping_update+0x28a/0x4a0 kernel/time/timekeeping.c:675
 timekeeping_advance+0x6ad/0xa40 kernel/time/timekeeping.c:2122
 tick_do_update_jiffies64.part.0+0x1ec/0x330 kernel/time/tick-sched.c:101
 tick_do_update_jiffies64 kernel/time/tick-sched.c:64 [inline]
 tick_sched_do_timer kernel/time/tick-sched.c:147 [inline]
 tick_sched_timer+0x236/0x2a0 kernel/time/tick-sched.c:1321
 __run_hrtimer kernel/time/hrtimer.c:1524 [inline]
 __hrtimer_run_queues+0x1d5/0xfc0 kernel/time/hrtimer.c:1588
 hrtimer_interrupt+0x334/0x940 kernel/time/hrtimer.c:1650
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1080 [inline]
 __sysvec_apic_timer_interrupt+0x147/0x5f0 arch/x86/kernel/apic/apic.c:1097
 asm_call_irq_on_stack+0xf/0x20
 </IRQ>
 __run_sysvec_on_irqstack arch/x86/include/asm/irq_stack.h:37 [inline]
 run_sysvec_on_irqstack_cond arch/x86/include/asm/irq_stack.h:89 [inline]
 sysvec_apic_timer_interrupt+0xb2/0xf0 arch/x86/kernel/apic/apic.c:1091
 asm_sysvec_apic_timer_interrupt+0x12/0x20 arch/x86/include/asm/idtentry.h:581
RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:770 [inline]
RIP: 0010:seqcount_lockdep_reader_access include/linux/seqlock.h:104 [inline]
RIP: 0010:read_seqcount_t_begin.constprop.0+0x10f/0x1e0 include/linux/seqlock.h:311
Code: 00 fc ff df 48 c1 e8 03 80 3c 10 00 0f 85 be 00 00 00 48 83 3d 89 cf 95 08 00 0f 84 98 00 00 00 e8 26 a2 0f 00 48 89 df 57 9d <0f> 1f 44 00 00 44 8b 25 85 ac a1 08 31 ff 44 89 e3 83 e3 01 89 de
RSP: 0018:ffffc90007377da0 EFLAGS: 00000212
RAX: 00000000000016d0 RBX: 0000000000000212 RCX: ffffc90006389000
RDX: 0000000000040000 RSI: ffffffff81669c6a RDI: 0000000000000212
RBP: 0000000000000200 R08: 0000000000000001 R09: 0000000000000001
R10: 0000000000000000 R11: 0000000000000000 R12: 00007f720b020c60
R13: dffffc0000000000 R14: dffffc0000000000 R15: 0000000000000000
 ktime_get_ts64+0x50/0x210 kernel/time/timekeeping.c:893
 posix_get_monotonic_timespec+0x6c/0x250 kernel/time/posix-timers.c:199
 __do_sys_clock_gettime kernel/time/posix-timers.c:1092 [inline]
 __se_sys_clock_gettime kernel/time/posix-timers.c:1082 [inline]
 __x64_sys_clock_gettime+0x153/0x260 kernel/time/posix-timers.c:1082
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
BUG: unable to handle page fault for address: 0000000080010003
#PF: supervisor write access in kernel mode
#PF: error_code(0x0002) - not-present page
PGD 9ee60067 P4D 9ee60067 PUD 0 
Oops: 0002 [#2] PREEMPT SMP KASAN
CPU: 1 PID: 20825 Comm: syz-executor.0 Not tainted 5.9.0-rc7-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:in_gate_area_no_mm+0x3e/0x6a arch/x86/entry/vsyscall/vsyscall_64.c:344
Code: 00 00 00 89 ee e8 52 95 75 00 83 fd 02 74 24 e8 e8 98 75 00 48 81 e3 00 f0 ff ff 48 c7 c7 00 00 60 ff 48 89 de e8 52 95 75 00 <48> 81 00 00 00 00 ff 74 10 e8 c4 98 75 00 45 31 e4 5b 44 89 e0 5d
RSP: 0018:ffffc90000da7470 EFLAGS: 00010046
RAX: 0000000080010003 RBX: 0000000000460000 RCX: ffffffff8100a5be
RDX: 0000000000460000 RSI: ffff88809478c1c0 RDI: 0000000000000007
RBP: 0000000000000000 R08: ffffc90000da7638 R09: ffff8880ae5247ad
R10: ffffffffff600000 R11: 0000000000000001 R12: ffffc90000da7638
R13: 0000000000000001 R14: 0000000000460bda R15: ffffc90000da7548
FS:  00007f720b021700(0000) GS:ffff8880ae500000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000080010003 CR3: 0000000094a3b000 CR4: 00000000001506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 is_kernel include/linux/kallsyms.h:44 [inline]
 is_ksym_addr include/linux/kallsyms.h:50 [inline]
 kallsyms_lookup+0xc3/0x2e0 kernel/kallsyms.c:291
 __sprint_symbol+0x9c/0x1c0 kernel/kallsyms.c:364
 symbol_string+0x14c/0x370 lib/vsprintf.c:972
 pointer+0x185/0x970 lib/vsprintf.c:2224
 vsnprintf+0x5b2/0x14f0 lib/vsprintf.c:2622
 vscnprintf+0x29/0x80 lib/vsprintf.c:2721
 printk_safe_log_store+0xf5/0x250 kernel/printk/printk_safe.c:94
Lost 180 message(s)!
Crashes (2):
Manager	Time	Kernel	Commit	Syzkaller	Config	Log	Report	Syz repro	C repro	VM info	Title
ci-upstream-kasan-gce-selinux-root	2020/09/30 15:28	upstream	02de58b24d2e	8516f6d3	.config	log	report			info
ci-upstream-kasan-gce-smack-root	2020/08/28 07:10	upstream	15bc20c6af4c	816e0689	.config	log	report