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.4' (ECDSA) to the list of known hosts.
2018/03/25 22:03:43 parsed 1 programs
2018/03/25 22:03:43 executed programs: 0
syzkaller login: [   25.170218] IPVS: ftp: loaded support on port[0] = 21
[   25.407822] IPv6: ADDRCONF(NETDEV_UP): bridge0: link is not ready
[   25.792876] IPv6: ADDRCONF(NETDEV_UP): bond0: link is not ready
[   25.798986] 8021q: adding VLAN 0 to HW filter on device bond0
[   25.834425] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready
[   25.871744] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready
2018/03/25 22:03:48 executed programs: 75
[   31.655395] 
[   31.657032] ============================================
[   31.662448] WARNING: possible recursive locking detected
[   31.667864] 4.16.0-rc6+ #276 Not tainted
[   31.671891] --------------------------------------------
[   31.677308] vhost-4751/4752 is trying to acquire lock:
[   31.682549]  (&vq->mutex){+.+.}, at: [<00000000b7a8dd70>] handle_rx+0xeb1/0x19c0
[   31.690149] 
[   31.690149] but task is already holding lock:
[   31.696083]  (&vq->mutex){+.+.}, at: [<00000000c1d426ef>] handle_rx+0x1f5/0x19c0
[   31.703598] 
[   31.703598] other info that might help us debug this:
[   31.710227]  Possible unsafe locking scenario:
[   31.710227] 
[   31.716250]        CPU0
[   31.718801]        ----
[   31.721350]   lock(&vq->mutex);
[   31.724596]   lock(&vq->mutex);
[   31.727843] 
[   31.727843]  *** DEADLOCK ***
[   31.727843] 
[   31.733869]  May be due to missing lock nesting notation
[   31.733869] 
[   31.740765] 1 lock held by vhost-4751/4752:
[   31.745057]  #0:  (&vq->mutex){+.+.}, at: [<00000000c1d426ef>] handle_rx+0x1f5/0x19c0
[   31.752997] 
[   31.752997] stack backtrace:
[   31.757462] CPU: 1 PID: 4752 Comm: vhost-4751 Not tainted 4.16.0-rc6+ #276
[   31.764440] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
[   31.773761] Call Trace:
[   31.776322]  dump_stack+0x194/0x24d
[   31.779919]  ? arch_local_irq_restore+0x53/0x53
[   31.784560]  __lock_acquire+0xe8f/0x3e00
[   31.788591]  ? trace_hardirqs_off+0x10/0x10
[   31.792884]  ? debug_check_no_locks_freed+0x3c0/0x3c0
[   31.798044]  ? __lock_is_held+0xb6/0x140
[   31.802079]  ? update_cfs_rq_load_avg.part.68+0x2d0/0x2d0
[   31.807583]  ? reweight_entity+0x11b0/0x11b0
[   31.811962]  ? print_irqtrace_events+0x270/0x270
[   31.816688]  ? dequeue_task_fair+0x105a/0x42b0
[   31.821240]  ? trace_hardirqs_off+0x10/0x10
[   31.825535]  ? __lock_acquire+0x664/0x3e00
[   31.829741]  lock_acquire+0x1d5/0x580
[   31.833508]  ? lock_acquire+0x1d5/0x580
[   31.837450]  ? handle_rx+0xeb1/0x19c0
[   31.841220]  ? lock_release+0xa40/0xa40
[   31.845164]  ? check_same_owner+0x320/0x320
[   31.849469]  ? rcu_note_context_switch+0x710/0x710
[   31.854368]  ? __might_sleep+0x95/0x190
[   31.858311]  ? handle_rx+0xeb1/0x19c0
[   31.862080]  __mutex_lock+0x16f/0x1a80
[   31.865952]  ? handle_rx+0xeb1/0x19c0
[   31.869721]  ? __lock_is_held+0xb6/0x140
[   31.873749]  ? handle_rx+0xeb1/0x19c0
[   31.877518]  ? trace_hardirqs_off+0x10/0x10
[   31.881823]  ? mutex_lock_io_nested+0x1900/0x1900
[   31.886644]  ? trace_hardirqs_off+0x10/0x10
[   31.890950]  ? nohz_balance_exit_idle.part.95+0x70/0x70
[   31.896288]  ? __lock_is_held+0xb6/0x140
[   31.900325]  ? trace_hardirqs_off+0x10/0x10
[   31.904623]  ? print_irqtrace_events+0x270/0x270
[   31.909348]  ? remove_wait_queue+0x1b4/0x350
[   31.913820]  ? lock_downgrade+0x980/0x980
[   31.917939]  ? print_irqtrace_events+0x270/0x270
[   31.922680]  ? peek_head_len.part.15+0xdf/0x110
[   31.927325]  ? lock_downgrade+0x980/0x980
[   31.931442]  ? lock_release+0xa40/0xa40
[   31.935385]  ? mark_held_locks+0xaf/0x100
[   31.939502]  ? _raw_spin_unlock_irqrestore+0x31/0xc0
[   31.944574]  ? trace_hardirqs_on_caller+0x421/0x5c0
[   31.949558]  ? trace_hardirqs_on+0xd/0x10
[   31.953762]  mutex_lock_nested+0x16/0x20
[   31.957791]  ? mutex_lock_nested+0x16/0x20
[   31.961994]  handle_rx+0xeb1/0x19c0
[   31.965598]  ? vhost_net_release+0x190/0x190
[   31.969976]  ? __sched_text_start+0x8/0x8
[   31.974093]  ? trace_hardirqs_off+0x10/0x10
[   31.978390]  ? rcu_sync_exit+0xeb/0x130
[   31.982333]  ? lock_downgrade+0x980/0x980
[   31.986455]  ? complete+0x62/0x80
[   31.989876]  ? schedule+0xf5/0x430
[   31.993385]  ? __schedule+0x1ec0/0x1ec0
[   31.997326]  ? do_raw_spin_trylock+0x190/0x190
[   32.001896]  ? trace_hardirqs_on+0xd/0x10
[   32.006011]  ? vhost_worker+0x1f0/0x470
[   32.009953]  handle_rx_net+0x19/0x20
[   32.013635]  vhost_worker+0x268/0x470
[   32.017404]  ? lockdep_init_map+0x9/0x10
[   32.021450]  ? vhost_flush_work+0x20/0x20
[   32.025566]  ? trace_hardirqs_on_caller+0x421/0x5c0
[   32.030552]  ? trace_hardirqs_on+0xd/0x10
[   32.034668]  ? __kthread_parkme+0x176/0x240
[   32.038957]  kthread+0x33c/0x400
[   32.042292]  ? vhost_flush_work+0x20/0x20
[   32.046405]  ? kthread_stop+0x7a0/0x7a0
[   32.050349]  ret_from_fork+0x3a/0x50
2018/03/25 22:03:53 executed programs: 155