INIT: Entering runlevel: 2 [info] Using makefile-style concurrent boot in runlevel 2. [....] Starting enhanced syslogd: rsyslogd[?25l[?1c7[ ok 8[?25h[?0c. [....] Starting periodic command scheduler: cron[?25l[?1c7[ ok 8[?25h[?0c. [....] Starting OpenBSD Secure Shell server: sshd[?25l[?1c7[ ok 8[?25h[?0c. Debian GNU/Linux 7 syzkaller ttyS0 Warning: Permanently added '10.128.0.59' (ECDSA) to the list of known hosts. syzkaller login: [ 24.614270] IPVS: ftp: loaded support on port[0] = 21 [ 24.617459] IPVS: ftp: loaded support on port[0] = 21 [ 24.625634] IPVS: ftp: loaded support on port[0] = 21 [ 24.626582] IPVS: ftp: loaded support on port[0] = 21 [ 24.632529] IPVS: ftp: loaded support on port[0] = 21 [ 24.637927] IPVS: ftp: loaded support on port[0] = 21 [ 24.642703] IPVS: ftp: loaded support on port[0] = 21 [ 24.649580] IPVS: ftp: loaded support on port[0] = 21 executing program executing program executing program [ 24.749331] IPVS: sync thread started: state = BACKUP, mcast_ifn = lo, syncid = 0, id = 0 [ 24.768571] IPVS: stopping backup sync thread 4449 ... executing program executing program executing program executing program executing program executing program [ 24.805498] IPVS: stopping backup sync thread 4455 ... [ 24.819520] IPVS: sync thread started: state = BACKUP, mcast_ifn = lo, syncid = 0, id = 0 [ 24.829399] IPVS: stopping backup sync thread 4458 ... [ 24.844794] IPVS: stopping backup sync thread 4465 ... executing program executing program executing program [ 24.856459] IPVS: stopping backup sync thread 4472 ... [ 24.867611] IPVS: sync thread started: state = BACKUP, mcast_ifn = lo, syncid = 0, id = 0 [ 24.871660] IPVS: sync thread started: state = BACKUP, mcast_ifn = lo, syncid = 0, id = 0 [ 24.880287] IPVS: stopping backup sync thread 4484 ... [ 24.885670] IPVS: stopping backup sync thread 4482 ... [ 24.890603] IPVS: sync thread started: state = BACKUP, mcast_ifn = lo, syncid = 0, id = 0 executing program executing program [ 24.896459] IPVS: stopping backup sync thread 4477 ... [ 24.904433] IPVS: stopping backup sync thread 4485 ... [ 24.914996] IPVS: sync thread started: state = BACKUP, mcast_ifn = lo, syncid = 0, id = 0 [ 24.915325] [ 24.924758] IPVS: stopping backup sync thread 4489 ... [ 24.924929] ============================================ [ 24.935604] WARNING: possible recursive locking detected [ 24.941035] 4.16.0+ #3 Not tainted [ 24.944546] -------------------------------------------- [ 24.949969] syzkaller181348/4481 is trying to acquire lock: [ 24.955654] 000000008a0128a4 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 [ 24.962495] [ 24.962495] but task is already holding lock: [ 24.968442] 000000008a0128a4 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 [ 24.975268] [ 24.975268] other info that might help us debug this: [ 24.981905] Possible unsafe locking scenario: [ 24.981905] [ 24.987938] CPU0 [ 24.990495] ---- [ 24.993051] lock(rtnl_mutex); [ 24.996303] lock(rtnl_mutex); [ 24.999555] [ 24.999555] *** DEADLOCK *** [ 24.999555] [ 25.005587] May be due to missing lock nesting notation [ 25.005587] [ 25.012492] 2 locks held by syzkaller181348/4481: [ 25.017311] #0: 000000008a0128a4 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 [ 25.024574] #1: 00000000eb847473 (ipvs->sync_mutex){+.+.}, at: do_ip_vs_set_ctl+0x562/0x1d30 [ 25.033224] [ 25.033224] stack backtrace: [ 25.037698] CPU: 1 PID: 4481 Comm: syzkaller181348 Not tainted 4.16.0+ #3 [ 25.044602] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 25.053932] Call Trace: [ 25.056502] dump_stack+0x1b9/0x294 [ 25.060113] ? dump_stack_print_info.cold.2+0x52/0x52 [ 25.065303] ? print_lock+0xd1/0xd6 [ 25.068907] ? vprintk_func+0x81/0xe7 [ 25.072687] __lock_acquire.cold.62+0x18c/0x55b [ 25.077343] ? debug_check_no_locks_freed+0x310/0x310 [ 25.082513] ? __enqueue_entity+0x10d/0x1f0 [ 25.086812] ? __lock_is_held+0xb5/0x140 [ 25.090851] ? __lock_acquire+0x7f5/0x5140 [ 25.095074] ? update_curr+0x332/0xbe0 [ 25.098949] ? graph_lock+0x170/0x170 [ 25.102733] ? debug_check_no_locks_freed+0x310/0x310 [ 25.107906] ? __lock_is_held+0xb5/0x140 [ 25.111944] ? x2apic_send_IPI+0xbf/0x110 [ 25.116069] ? graph_lock+0x170/0x170 [ 25.119845] ? graph_lock+0x170/0x170 [ 25.123623] ? resched_curr+0x10f/0x190 [ 25.127572] ? graph_lock+0x170/0x170 [ 25.131347] ? graph_lock+0x170/0x170 [ 25.135123] lock_acquire+0x1dc/0x520 [ 25.138902] ? rtnl_lock+0x17/0x20 [ 25.142425] ? lock_release+0xa10/0xa10 [ 25.146381] ? check_same_owner+0x320/0x320 [ 25.150678] ? graph_lock+0x170/0x170 [ 25.154462] ? rcu_note_context_switch+0x710/0x710 [ 25.159375] ? __might_sleep+0x95/0x190 [ 25.163326] ? rtnl_lock+0x17/0x20 [ 25.166843] __mutex_lock+0x16d/0x17f0 [ 25.170710] ? rtnl_lock+0x17/0x20 [ 25.174233] ? rtnl_lock+0x17/0x20 [ 25.177752] ? mutex_trylock+0x2a0/0x2a0 [ 25.181795] ? mark_held_locks+0xc9/0x160 [ 25.185927] ? do_raw_spin_trylock+0x1b0/0x1b0 [ 25.190487] ? _raw_spin_unlock_irq+0x27/0x70 [ 25.194958] ? trace_hardirqs_on_caller+0x421/0x5c0 [ 25.199949] ? trace_hardirqs_on+0xd/0x10 [ 25.204079] ? _raw_spin_unlock_irq+0x27/0x70 [ 25.208555] ? wait_for_completion_killable+0x56c/0x960 [ 25.213897] ? wait_for_completion_interruptible_timeout+0x960/0x960 [ 25.220371] ? lock_downgrade+0x8e0/0x8e0 [ 25.224497] ? kasan_check_read+0x11/0x20 [ 25.228622] ? do_raw_spin_unlock+0x9e/0x2e0 [ 25.233010] ? do_raw_spin_trylock+0x1b0/0x1b0 [ 25.237576] ? wake_up_q+0x100/0x100 [ 25.241267] ? kasan_check_write+0x14/0x20 [ 25.245478] ? do_raw_spin_lock+0xc1/0x200 [ 25.249702] ? __sanitizer_cov_trace_const_cmp4+0x16/0x20 [ 25.255216] ? __kthread_create_on_node+0x34f/0x4c0 [ 25.260210] ? __kthread_parkme+0x280/0x280 [ 25.264515] ? kasan_check_read+0x11/0x20 [ 25.268637] ? do_raw_spin_unlock+0x9e/0x2e0 [ 25.273029] ? __lock_is_held+0xb5/0x140 [ 25.277066] mutex_lock_nested+0x16/0x20 [ 25.281105] ? mutex_lock_nested+0x16/0x20 [ 25.285314] rtnl_lock+0x17/0x20 [ 25.288658] ip_mc_drop_socket+0x8f/0x270 [ 25.292788] inet_release+0x4e/0x1f0 [ 25.296485] sock_release+0x96/0x1b0 [ 25.300182] start_sync_thread+0xdc3/0x2d40 [ 25.304484] ? __lock_acquire+0x7f5/0x5140 [ 25.308696] ? ip_vs_process_message+0xa0a/0xa0a [ 25.313428] ? ip_vs_sync_conn+0x33a0/0x33a0 [ 25.317827] ? graph_lock+0x170/0x170 [ 25.321613] ? lock_downgrade+0x8e0/0x8e0 [ 25.325734] ? lock_downgrade+0x8e0/0x8e0 [ 25.329866] ? kasan_check_read+0x11/0x20 [ 25.334003] ? do_raw_spin_unlock+0x9e/0x2e0 [ 25.338396] ? __local_bh_enable_ip+0x161/0x230 [ 25.343044] ? find_held_lock+0x36/0x1c0 [ 25.347084] ? lock_downgrade+0x8e0/0x8e0 [ 25.351216] ? lock_release+0xa10/0xa10 [ 25.355171] ? check_same_owner+0x320/0x320 [ 25.359472] ? module_unload_free+0x5b0/0x5b0 [ 25.363947] do_ip_vs_set_ctl+0x59c/0x1d30 [ 25.368166] ? find_held_lock+0x36/0x1c0 [ 25.372205] ? ip_vs_genl_set_cmd+0xe80/0xe80 [ 25.376678] ? lock_downgrade+0x8e0/0x8e0 [ 25.380813] ? kasan_check_read+0x11/0x20 [ 25.384937] ? rcu_is_watching+0x85/0x140 [ 25.389062] ? rcu_bh_force_quiescent_state+0x20/0x20 [ 25.394241] ? kasan_check_write+0x14/0x20 [ 25.398464] ? __mutex_unlock_slowpath+0x180/0x8a0 [ 25.403370] ? wait_for_completion+0x870/0x870 [ 25.407938] ? module_unload_free+0x5b0/0x5b0 [ 25.412412] ? fget_raw+0x20/0x20 [ 25.415845] ? mutex_unlock+0xd/0x10 [ 25.419536] nf_setsockopt+0x7d/0xd0 [ 25.423227] ? nf_setsockopt+0x7d/0xd0 [ 25.427093] ip_setsockopt+0xd8/0xf0 [ 25.430782] tcp_setsockopt+0x93/0xe0 [ 25.434571] sock_common_setsockopt+0x9a/0xe0 [ 25.439052] __sys_setsockopt+0x1bd/0x390 [ 25.443176] ? kernel_accept+0x310/0x310 [ 25.447223] ? __sanitizer_cov_trace_const_cmp4+0x16/0x20 [ 25.452738] ? syscall_slow_exit_work+0x4f0/0x4f0 [ 25.457569] SyS_setsockopt+0x34/0x50 [ 25.461349] ? SyS_recv+0x40/0x40 [ 25.464777] do_syscall_64+0x29e/0x9d0 [ 25.468639] ? vmalloc_sync_all+0x30/0x30 [ 25.472773] ? syscall_slow_exit_work+0x4f0/0x4f0 [ 25.477609] ? syscall_return_slowpath+0x5c0/0x5c0 [ 25.482515] ? syscall_return_slowpath+0x30f/0x5c0 [ 25.487437] ? entry_SYSCALL_64_after_hwframe+0x52/0xb7 [ 25.492793] ? trace_hardirqs_off_thunk+0x1a/0x1c [ 25.497614] entry_SYSCALL_64_after_hwframe+0x42/0xb7 [ 25.502796] RIP: 0033:0x446a99 [ 25.505967] RSP: 002b:00007febef8e0db8 EFLAGS: 00000246 ORIG_RAX: 0000000000000036 [ 25.513652] RAX: ffffffffffffffda RBX: 00000000006e29e4 RCX: 0000000000446a99 [ 25.520899] RDX: 000000000000048b RSI: 0000000000000000 RDI: 0000000000000003 [ 25.528149] RBP: 00000000006e29e0 R08: 0000000000000018 R09: 0000000000000000 [ 25.535393] R10: 0000000020000080 R11: 0000000000000246 R12: 0000000000000000 [ 25.542637] R13: 00007ffc6bc76e4f R14: 00007febef8e19c0 R15: 0000000000000004