ci starts bisection 2023-05-04 18:38:45.127478977 +0000 UTC m=+22910.010082508
bisecting fixing commit since 72a85e2b0a1e1e6fb4ee51ae902730212b2de25c
building syzkaller on 9da18ae8fa827d046ef8da48cc23c97418553c23
ensuring issue is reproducible on original commit 72a85e2b0a1e1e6fb4ee51ae902730212b2de25c
testing commit 72a85e2b0a1e1e6fb4ee51ae902730212b2de25c gcc
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: 2eaa592a6fef2088a203330a8141d17dfe6c2d0bee00ec4aebe4caeb5d921d09
run #0: crashed: INFO: rcu detected stall in corrupted
run #1: crashed: INFO: rcu detected stall in corrupted
run #2: crashed: KASAN: use-after-free Read in net_tx_action
run #3: crashed: INFO: rcu detected stall in corrupted
run #4: crashed: INFO: rcu detected stall in corrupted
run #5: crashed: INFO: rcu detected stall in corrupted
run #6: crashed: INFO: rcu detected stall in corrupted
run #7: crashed: INFO: rcu detected stall in corrupted
run #8: crashed: INFO: rcu detected stall in corrupted
run #9: crashed: INFO: rcu detected stall in corrupted
run #10: crashed: INFO: rcu detected stall in corrupted
run #11: crashed: INFO: rcu detected stall in corrupted
run #12: crashed: KASAN: use-after-free Read in net_tx_action
run #13: crashed: INFO: rcu detected stall in corrupted
run #14: crashed: INFO: rcu detected stall in corrupted
run #15: crashed: INFO: rcu detected stall in corrupted
run #16: crashed: INFO: rcu detected stall in corrupted
run #17: crashed: INFO: rcu detected stall in corrupted
run #18: crashed: KASAN: use-after-free Read in net_tx_action
run #19: crashed: KASAN: use-after-free Read in net_tx_action
testing current HEAD 1a5304fecee523060f26e2778d9d8e33c0562df3
testing commit 1a5304fecee523060f26e2778d9d8e33c0562df3 gcc
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2
kernel signature: a3cac1a741e268abe4a92f065e630803c52373cbeb45de907ad432425c98ac22
run #0: crashed: INFO: rcu detected stall in gc_worker
run #1: crashed: INFO: rcu detected stall in sys_openat
run #2: crashed: INFO: rcu detected stall in newfstatat
run #3: crashed: INFO: rcu detected stall in schedule_tail
run #4: crashed: INFO: rcu detected stall in gc_worker
run #5: crashed: INFO: rcu detected stall in gc_worker
run #6: crashed: INFO: rcu detected stall in gc_worker
run #7: crashed: INFO: rcu detected stall in gc_worker
run #8: crashed: INFO: rcu detected stall in gc_worker
run #9: OK
revisions tested: 2, total time: 34m59.34683806s (build: 18m11.819838786s, test: 16m12.523227832s)
the crash still happens on HEAD
commit msg: Merge tag 'parisc-for-6.4-1' of git://git.kernel.org/pub/scm/linux/kernel/git/deller/parisc-linux
crash: INFO: rcu detected stall in gc_worker
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 0-...!: (2 ticks this GP) idle=1184/1/0x4000000000000000 softirq=20656/20656 fqs=0
rcu: (detected by 1, t=10505 jiffies, g=12133, q=756 ncpus=2)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 4987 Comm: kworker/0:4 Not tainted 6.3.0-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023
Workqueue: events_power_efficient gc_worker
RIP: 0010:__lock_acquire+0x95c/0x5df0 kernel/locking/lockdep.c:5057
Code: 3f 00 00 8b 7c 24 18 4d 8b bd b8 0a 00 00 85 ff 0f 84 32 06 00 00 45 31 f6 48 b8 00 00 00 00 00 fc ff df 4c 89 e2 48 c1 ea 03 <80> 3c 02 00 0f 85 f4 47 00 00 48 8b 14 24 4d 89 3c 24 48 b8 00 00
RSP: 0018:ffffc90000007b28 EFLAGS: 00000802
RAX: dffffc0000000000 RBX: 0000000000000949 RCX: ffffffff815bedc7
RDX: 1ffff1100f910d98 RSI: 0000000000000008 RDI: 0000000000000003
RBP: 0000000000000049 R08: 0000000000000000 R09: ffffffff903b0d6f
R10: fffffbfff20761ad R11: 0000000000000000 R12: ffff88807c886cc0
R13: ffff88807c886180 R14: 0000000000000000 R15: fa4984b461db758a
FS: 0000000000000000(0000) GS:ffff8880b9a00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fdf463ad988 CR3: 000000002b808000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
lock_acquire kernel/locking/lockdep.c:5691 [inline]
lock_acquire+0x1b1/0x520 kernel/locking/lockdep.c:5656
__raw_spin_lock include/linux/spinlock_api_smp.h:133 [inline]
_raw_spin_lock+0x2e/0x40 kernel/locking/spinlock.c:154
spin_lock include/linux/spinlock.h:350 [inline]
advance_sched+0xcd/0xd90 net/sched/sch_taprio.c:929
__run_hrtimer kernel/time/hrtimer.c:1685 [inline]
__hrtimer_run_queues+0x4d7/0x960 kernel/time/hrtimer.c:1749
hrtimer_interrupt+0x2f9/0x7a0 kernel/time/hrtimer.c:1811
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1095 [inline]
__sysvec_apic_timer_interrupt+0x14a/0x430 arch/x86/kernel/apic/apic.c:1112
sysvec_apic_timer_interrupt+0x92/0xc0 arch/x86/kernel/apic/apic.c:1106
asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:645
RIP: 0010:lock_acquire+0x1f5/0x520 kernel/locking/lockdep.c:5659
Code: 37 a6 7e 83 f8 01 0f 85 b9 02 00 00 9c 58 f6 c4 02 0f 85 a4 02 00 00 48 83 7c 24 08 00 74 01 fb 48 b8 00 00 00 00 00 fc ff df <48> 01 c3 48 c7 03 00 00 00 00 48 c7 43 08 00 00 00 00 48 8b 84 24
RSP: 0018:ffffc9000309fb48 EFLAGS: 00000206
RAX: dffffc0000000000 RBX: 1ffff92000613f6b RCX: fa4984b461db758a
RDX: 1ffff1100f910d88 RSI: ffffffff896b92a0 RDI: ffffffff89c26c80
RBP: 0000000000000000 R08: 0000000000000000 R09: ffffffff903b0c47
R10: fffffbfff2076188 R11: 0000000000000000 R12: 0000000000000002
R13: 0000000000000000 R14: ffffffff8b78cf40 R15: 0000000000000000
rcu_lock_acquire include/linux/rcupdate.h:327 [inline]
rcu_read_lock include/linux/rcupdate.h:773 [inline]
gc_worker+0x212/0x1230 net/netfilter/nf_conntrack_core.c:1494
process_one_work+0x86e/0x1410 kernel/workqueue.c:2405
worker_thread+0x5af/0xf00 kernel/workqueue.c:2552
kthread+0x2ea/0x3c0 kernel/kthread.c:379
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
rcu: rcu_preempt kthread timer wakeup didn't happen for 10504 jiffies! g12133 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x402
rcu: Possible timer handling issue on cpu=0 timer-softirq=9686
rcu: rcu_preempt kthread starved for 10505 jiffies! g12133 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x402 ->cpu=0
rcu: Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior.
rcu: RCU grace-period kthread stack dump:
task:rcu_preempt state:I stack:28136 pid:15 ppid:2 flags:0x00004000
Call Trace:
context_switch kernel/sched/core.c:5343 [inline]
__schedule+0xc25/0x57f0 kernel/sched/core.c:6669
schedule+0xde/0x1a0 kernel/sched/core.c:6745
schedule_timeout+0x121/0x270 kernel/time/timer.c:2167
rcu_gp_fqs_loop+0x190/0x910 kernel/rcu/tree.c:1609
rcu_gp_kthread+0x23a/0x360 kernel/rcu/tree.c:1808
kthread+0x2ea/0x3c0 kernel/kthread.c:379
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308
rcu: Stack dump where RCU GP kthread last ran:
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 4987 Comm: kworker/0:4 Not tainted 6.3.0-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 04/14/2023
Workqueue: events_power_efficient gc_worker
RIP: 0010:__lock_acquire+0xdac/0x5df0 kernel/locking/lockdep.c:5101
Code: 09 48 8b 3c 24 e8 f4 99 5f 00 41 8b 85 c0 0a 00 00 83 c0 01 83 f8 2f 41 89 85 c0 0a 00 00 0f 87 80 0e 00 00 3b 05 b4 9d 4b 0e <0f> 87 42 0a 00 00 41 be 01 00 00 00 e9 83 00 00 00 48 b8 00 00 00
RSP: 0018:ffffc90000007bd0 EFLAGS: 00000087
RAX: 0000000000000004 RBX: ffff88807c886ce2 RCX: ffffffff815bf7d6
RDX: 1ffff1100f910d88 RSI: 0000000000000001 RDI: ffffffff8f2723f8
RBP: dffffc0000000000 R08: 0000000000000000 R09: ffffffff903b0c4f
R10: fffffbfff2076189 R11: 0000000000000000 R12: ffff88807c886cc0
R13: ffff88807c886180 R14: 0000000000000001 R15: 49da982df18c1733
FS: 0000000000000000(0000) GS:ffff8880b9a00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fdf463ad988 CR3: 000000002b808000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
lock_acquire kernel/locking/lockdep.c:5691 [inline]
lock_acquire+0x1b1/0x520 kernel/locking/lockdep.c:5656
__raw_spin_lock_irq include/linux/spinlock_api_smp.h:119 [inline]
_raw_spin_lock_irq+0x36/0x50 kernel/locking/spinlock.c:170
__run_hrtimer kernel/time/hrtimer.c:1689 [inline]
__hrtimer_run_queues+0x1dd/0x960 kernel/time/hrtimer.c:1749
hrtimer_interrupt+0x2f9/0x7a0 kernel/time/hrtimer.c:1811
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1095 [inline]
__sysvec_apic_timer_interrupt+0x14a/0x430 arch/x86/kernel/apic/apic.c:1112
sysvec_apic_timer_interrupt+0x92/0xc0 arch/x86/kernel/apic/apic.c:1106
asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:645
RIP: 0010:lock_acquire+0x1f5/0x520 kernel/locking/lockdep.c:5659
Code: 37 a6 7e 83 f8 01 0f 85 b9 02 00 00 9c 58 f6 c4 02 0f 85 a4 02 00 00 48 83 7c 24 08 00 74 01 fb 48 b8 00 00 00 00 00 fc ff df <48> 01 c3 48 c7 03 00 00 00 00 48 c7 43 08 00 00 00 00 48 8b 84 24
RSP: 0018:ffffc9000309fb48 EFLAGS: 00000206
RAX: dffffc0000000000 RBX: 1ffff92000613f6b RCX: fa4984b461db758a
RDX: 1ffff1100f910d88 RSI: ffffffff896b92a0 RDI: ffffffff89c26c80
RBP: 0000000000000000 R08: 0000000000000000 R09: ffffffff903b0c47
R10: fffffbfff2076188 R11: 0000000000000000 R12: 0000000000000002
R13: 0000000000000000 R14: ffffffff8b78cf40 R15: 0000000000000000
rcu_lock_acquire include/linux/rcupdate.h:327 [inline]
rcu_read_lock include/linux/rcupdate.h:773 [inline]
gc_worker+0x212/0x1230 net/netfilter/nf_conntrack_core.c:1494
process_one_work+0x86e/0x1410 kernel/workqueue.c:2405
worker_thread+0x5af/0xf00 kernel/workqueue.c:2552
kthread+0x2ea/0x3c0 kernel/kthread.c:379
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:308