syzbot


INFO: task hung in do_ip_vs_set_ctl

Status: closed as invalid on 2018/03/27 11:14
First crash: 2222d, last: 2222d
Similar bugs (4)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in do_ip_vs_set_ctl (2) lvs C done unreliable 3 2196d 2211d 0/26 closed as invalid on 2019/11/27 06:19
android-44 INFO: task hung in do_ip_vs_set_ctl 1 2187d 2187d 0/2 auto-closed as invalid on 2019/02/22 13:09
upstream INFO: task hung in do_ip_vs_set_ctl lvs C 1 2222d 2222d 0/26 closed as invalid on 2018/03/27 11:14
android-49 INFO: task hung in do_ip_vs_set_ctl (2) C 2 2195d 1839d 0/3 public: reported C repro on 2019/04/14 08:51

Sample crash report:
IPVS: sync thread started: state = BACKUP, mcast_ifn = sit0, syncid = 0, id = 0
random: crng init done
INFO: task syzkaller807106:3907 blocked for more than 120 seconds.
      Not tainted 4.9.90-gdd1e37e #66
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syzkaller807106 D27872  3907   3906 0x00000000
 ffff8801d4fab000 0000000000000000 ffff8801d4e04000 ffff8801d8368000
 ffff8801db221b98 ffff8801d481f968 ffffffff838a75cb 0000000000000000
 0000000000000007 00ff8801d4fab000 ffff8801db222468 ffff8801db222490
Call Trace:
 [<ffffffff838a8b6f>] schedule+0x7f/0x1b0 kernel/sched/core.c:3551
 [<ffffffff838a94f3>] schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3584
 [<ffffffff838ae292>] __mutex_lock_common kernel/locking/mutex.c:582 [inline]
 [<ffffffff838ae292>] mutex_lock_nested+0x312/0x870 kernel/locking/mutex.c:621
 [<ffffffff831ad9c0>] do_ip_vs_set_ctl+0x240/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2402
 [<ffffffff830a53e7>] nf_sockopt net/netfilter/nf_sockopt.c:105 [inline]
 [<ffffffff830a53e7>] nf_setsockopt+0x67/0xc0 net/netfilter/nf_sockopt.c:114
 [<ffffffff83215ba7>] ip_setsockopt+0x97/0xa0 net/ipv4/ip_sockglue.c:1247
 [<ffffffff832c37a5>] udp_setsockopt+0x45/0x80 net/ipv4/udp.c:2088
 [<ffffffff82ee1295>] sock_common_setsockopt+0x95/0xd0 net/core/sock.c:2706
 [<ffffffff82ede250>] SYSC_setsockopt net/socket.c:1772 [inline]
 [<ffffffff82ede250>] SyS_setsockopt+0x160/0x250 net/socket.c:1751
 [<ffffffff81006504>] do_syscall_64+0x1a4/0x490 arch/x86/entry/common.c:282
 [<ffffffff838b8493>] entry_SYSCALL_64_after_swapgs+0x5d/0xdb

Showing all locks held in the system:
3 locks held by kworker/0:1/24:
 #0:  ("%s"("ipv6_addrconf")){.+.+..}, at: [<ffffffff8118af42>] work_static include/linux/workqueue.h:186 [inline]
 #0:  ("%s"("ipv6_addrconf")){.+.+..}, at: [<ffffffff8118af42>] set_work_data kernel/workqueue.c:617 [inline]
 #0:  ("%s"("ipv6_addrconf")){.+.+..}, at: [<ffffffff8118af42>] set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline]
 #0:  ("%s"("ipv6_addrconf")){.+.+..}, at: [<ffffffff8118af42>] process_one_work+0x6f2/0x1610 kernel/workqueue.c:2085
 #1:  ((addr_chk_work).work){+.+...}, at: [<ffffffff8118af7c>] process_one_work+0x72c/0x1610 kernel/workqueue.c:2089
 #2:  (rtnl_mutex){+.+.+.}, at: [<ffffffff82f79737>] rtnl_lock+0x17/0x20 net/core/rtnetlink.c:70
2 locks held by khungtaskd/515:
 #0:  (rcu_read_lock){......}, at: [<ffffffff81372185>] check_hung_uninterruptible_tasks kernel/hung_task.c:168 [inline]
 #0:  (rcu_read_lock){......}, at: [<ffffffff81372185>] watchdog+0x125/0xa70 kernel/hung_task.c:239
 #1:  (tasklist_lock){.+.+..}, at: [<ffffffff81236c50>] debug_show_all_locks+0x70/0x280 kernel/locking/lockdep.c:4336
1 lock held by rsyslogd/3657:
 #0:  (&f->f_pos_lock){+.+.+.}, at: [<ffffffff815d2f5f>] __fdget_pos+0x9f/0xc0 fs/file.c:781
2 locks held by getty/3784:
 #0:  (&tty->ldisc_sem){++++++}, at: [<ffffffff838b66a2>] ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:367
 #1:  (&ldata->atomic_read_lock){+.+...}, at: [<ffffffff8200a6a4>] n_tty_read+0x1f4/0x16c0 drivers/tty/n_tty.c:2133
1 lock held by syzkaller807106/3907:
 #0:  (ipvs->sync_mutex){+.+.+.}, at: [<ffffffff831ad9c0>] do_ip_vs_set_ctl+0x240/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2402
1 lock held by syzkaller807106/3908:
 #0:  (ipvs->sync_mutex){+.+.+.}, at: [<ffffffff831ad9c0>] do_ip_vs_set_ctl+0x240/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2402
1 lock held by syzkaller807106/3909:
 #0:  (ipvs->sync_mutex){+.+.+.}, at: [<ffffffff831ad9c0>] do_ip_vs_set_ctl+0x240/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2402
1 lock held by syzkaller807106/3910:
 #0:  (ipvs->sync_mutex){+.+.+.}, at: [<ffffffff831ad9c0>] do_ip_vs_set_ctl+0x240/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2402
1 lock held by syzkaller807106/3911:
 #0:  (ipvs->sync_mutex){+.+.+.}, at: [<ffffffff831ad9c0>] do_ip_vs_set_ctl+0x240/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2402
1 lock held by syzkaller807106/3912:
 #0:  (ipvs->sync_mutex){+.+.+.}, at: [<ffffffff831ad9c0>] do_ip_vs_set_ctl+0x240/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2402
1 lock held by syzkaller807106/3913:
 #0:  (ipvs->sync_mutex){+.+.+.}, at: [<ffffffff831ad9c0>] do_ip_vs_set_ctl+0x240/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2402
2 locks held by syzkaller807106/3914:
 #0:  (rtnl_mutex){+.+.+.}, at: [<ffffffff82f79737>] rtnl_lock+0x17/0x20 net/core/rtnetlink.c:70
 #1:  (ipvs->sync_mutex){+.+.+.}, at: [<ffffffff831ae067>] do_ip_vs_set_ctl+0x8e7/0xc00 net/netfilter/ipvs/ip_vs_ctl.c:2397
1 lock held by ipvs-b:0:0/3916:
 #0:  (rtnl_mutex){+.+.+.}, at: [<ffffffff82f79737>] rtnl_lock+0x17/0x20 net/core/rtnetlink.c:70

=============================================

NMI backtrace for cpu 1
CPU: 1 PID: 515 Comm: khungtaskd Not tainted 4.9.90-gdd1e37e #66
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
 ffff8801d877fd00 ffffffff81d94ee9 0000000000000000 0000000000000001
 0000000000000001 0000000000000001 ffffffff810bb920 ffff8801d877fd38
 ffffffff81da000d 0000000000000001 0000000000000000 ffff8801d4fab418
Call Trace:
 [<ffffffff81d94ee9>] __dump_stack lib/dump_stack.c:15 [inline]
 [<ffffffff81d94ee9>] dump_stack+0xc1/0x128 lib/dump_stack.c:51
 [<ffffffff81da000d>] nmi_cpu_backtrace+0xfd/0x120 lib/nmi_backtrace.c:99
 [<ffffffff81da0147>] nmi_trigger_cpumask_backtrace+0x117/0x190 lib/nmi_backtrace.c:60
 [<ffffffff810bba14>] arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:37
 [<ffffffff81372750>] trigger_all_cpu_backtrace include/linux/nmi.h:58 [inline]
 [<ffffffff81372750>] check_hung_task kernel/hung_task.c:125 [inline]
 [<ffffffff81372750>] check_hung_uninterruptible_tasks kernel/hung_task.c:182 [inline]
 [<ffffffff81372750>] watchdog+0x6f0/0xa70 kernel/hung_task.c:239
 [<ffffffff8119bf4d>] kthread+0x26d/0x300 kernel/kthread.c:211
 [<ffffffff838b865c>] ret_from_fork+0x5c/0x70 arch/x86/entry/entry_64.S:373
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.9.90-gdd1e37e #66
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffffffff84429880 task.stack: ffffffff84400000
RIP: 0010:[<ffffffff81201901>] c [<ffffffff81201901>] load_balance+0x171/0x2e90 kernel/sched/fair.c:9443
RSP: 0018:ffff8801db207c18  EFLAGS: 00000282
RAX: ffff8801d9acd400 RBX: ffff8801db221b80 RCX: 0000000000000000
RDX: 0000000000000000 RSI: ffffffff83c18d80 RDI: ffff8801db207d40
RBP: ffff8801db207da8 R08: ffff8801db207e48 R09: 0000000000000000
R10: dffffc0000000000 R11: ffffffff84429880 R12: 0000000000000000
R13: ffff8801db218558 R14: ffff8801db207d80 R15: ffff8801d9acd400
FS:  0000000000000000(0000) GS:ffff8801db200000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fdb5cd0f000 CR3: 00000001d97dc000 CR4: 0000000000160670
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Stack:
 0000000000000000c 0000000041b58ab3c ffffffff84193d90c ffffffff8123aaf0c
 0000000000000000c ffff8801db207e48c ffffffff8442a108c 1ffff1003b640f98c
 0000000000000000c 0000000000000000c ffff8801db221b80c ffff8801db221b80c
Call Trace:
 [<ffffffff81206bf8>] rebalance_domains+0x5f8/0xb00 kernel/sched/fair.c:10113
 [<ffffffff812073f8>] run_rebalance_domains+0x2f8/0x540 kernel/sched/fair.c:10331
 [<ffffffff838bef96>] __do_softirq+0x206/0x951 kernel/softirq.c:284
 [<ffffffff81148315>] invoke_softirq kernel/softirq.c:364 [inline]
 [<ffffffff81148315>] irq_exit+0x165/0x190 kernel/softirq.c:405
 [<ffffffff838bcbbb>] smp_reschedule_interrupt+0x6b/0x80 arch/x86/kernel/smp.c:270
 [<ffffffff838ba7d0>] reschedule_interrupt+0xa0/0xb0 arch/x86/entry/entry_64.S:671
 <EOI> d [<ffffffff838b7116>] ? native_safe_halt+0x6/0x10 arch/x86/include/asm/irqflags.h:53
 [<ffffffff838b6745>] arch_safe_halt arch/x86/include/asm/paravirt.h:104 [inline]
 [<ffffffff838b6745>] default_idle+0x55/0x360 arch/x86/kernel/process.c:295
 [<ffffffff8106be0a>] arch_cpu_idle+0xa/0x10 arch/x86/kernel/process.c:286
 [<ffffffff838b7556>] default_idle_call+0x36/0x60 kernel/sched/idle.c:97
 [<ffffffff81225520>] cpuidle_idle_call kernel/sched/idle.c:155 [inline]
 [<ffffffff81225520>] cpu_idle_loop kernel/sched/idle.c:248 [inline]
 [<ffffffff81225520>] cpu_startup_entry+0x2b0/0x380 kernel/sched/idle.c:303
 [<ffffffff838a4214>] rest_init+0x184/0x190 init/main.c:408
 [<ffffffff84a6f8b2>] start_kernel+0x684/0x6b9 init/main.c:663
 [<ffffffff84a6e29d>] x86_64_start_reservations+0x2a/0x2c arch/x86/kernel/head64.c:196
 [<ffffffff84a6e3df>] x86_64_start_kernel+0x140/0x163 arch/x86/kernel/head64.c:177
Code: c85 cfd c2b c00 c00 c31 cc0 cb9 c0b c00 c00 c00 c8b c95 cb0 cfe cff cff c49 c8d cbe c68 cff cff cff c4e c03 c2c ce5 ce0 c03 c20 c84 cf3 c48 cab c48 c8b c85 cd8 cfe cff cff c<49> c89 c9e c78 cff cff cff c41 c89 c96 c74 cff cff cff c4c c89 cad cc0 cfe cff cff c

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2018/03/26 23:23 https://android.googlesource.com/kernel/common android-4.9 dd1e37e64645 0ca7878b .config console log report syz C ci-android-49-kasan-gce
* Struck through repros no longer work on HEAD.