Warning: Permanently added '[localhost]:17028' (ECDSA) to the list of known hosts.
2019/03/20 05:06:18 parsed 1 programs
2019/03/20 05:06:18 executed programs: 0
[  217.073588] IPVS: Creating netns size=2720 id=2
[  217.074332] IPVS: ftp: loaded support on port[0] = 21
[  217.145619] IPVS: Creating netns size=2720 id=3
[  217.146371] IPVS: ftp: loaded support on port[0] = 21
[  217.230693] IPVS: Creating netns size=2720 id=4
[  217.231429] IPVS: ftp: loaded support on port[0] = 21
[  217.325555] IPVS: Creating netns size=2720 id=5
[  217.327791] IPVS: ftp: loaded support on port[0] = 21
[  217.463804] IPVS: Creating netns size=2720 id=6
[  217.465641] IPVS: ftp: loaded support on port[0] = 21
[  217.675903] IPVS: Creating netns size=2720 id=7
[  217.676492] IPVS: ftp: loaded support on port[0] = 21
[  217.900087] bridge0: port 1(bridge_slave_0) entered blocking state
[  217.900835] bridge0: port 1(bridge_slave_0) entered disabled state
[  217.903271] device bridge_slave_0 entered promiscuous mode
[  217.954019] bridge0: port 2(bridge_slave_1) entered blocking state
[  217.955893] bridge0: port 2(bridge_slave_1) entered disabled state
[  217.959874] device bridge_slave_1 entered promiscuous mode
[  218.025160] bridge0: port 1(bridge_slave_0) entered blocking state
[  218.026056] bridge0: port 1(bridge_slave_0) entered disabled state
[  218.029188] device bridge_slave_0 entered promiscuous mode
[  218.034448] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready
[  218.058320] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready
[  218.062987] bridge0: port 2(bridge_slave_1) entered blocking state
[  218.066724] bridge0: port 2(bridge_slave_1) entered disabled state
[  218.069355] device bridge_slave_1 entered promiscuous mode
[  218.180483] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready
[  218.184298] bridge0: port 1(bridge_slave_0) entered blocking state
[  218.185514] bridge0: port 1(bridge_slave_0) entered disabled state
[  218.188490] device bridge_slave_0 entered promiscuous mode
[  218.241273] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready
[  218.258986] bridge0: port 2(bridge_slave_1) entered blocking state
[  218.259924] bridge0: port 2(bridge_slave_1) entered disabled state
[  218.262910] device bridge_slave_1 entered promiscuous mode
[  218.300343] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready
[  218.346761] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready
[  218.351772] bond0: Enslaving bond_slave_0 as an active interface with an up link
[  218.355378] ip (5484) used greatest stack depth: 23824 bytes left
[  218.451494] bond0: Enslaving bond_slave_0 as an active interface with an up link
[  218.467133] bond0: Enslaving bond_slave_1 as an active interface with an up link
[  218.489663] bond0: Enslaving bond_slave_1 as an active interface with an up link
[  218.491855] bridge0: port 1(bridge_slave_0) entered blocking state
[  218.492748] bridge0: port 1(bridge_slave_0) entered disabled state
[  218.496257] device bridge_slave_0 entered promiscuous mode
[  218.509125] bond0: Enslaving bond_slave_0 as an active interface with an up link
[  218.572543] bridge0: port 2(bridge_slave_1) entered blocking state
[  218.573679] bridge0: port 2(bridge_slave_1) entered disabled state
[  218.577243] device bridge_slave_1 entered promiscuous mode
[  218.582014] bond0: Enslaving bond_slave_1 as an active interface with an up link
[  218.631287] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready
[  218.690795] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready
[  218.789047] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready
[  218.791681] team0: Port device team_slave_0 added
[  218.873651] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready
[  218.875679] team0: Port device team_slave_0 added
[  218.878698] bridge0: port 1(bridge_slave_0) entered blocking state
[  218.882725] bridge0: port 1(bridge_slave_0) entered disabled state
[  218.885736] device bridge_slave_0 entered promiscuous mode
[  218.904994] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready
[  218.907271] team0: Port device team_slave_1 added
[  218.911224] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready
[  218.913253] team0: Port device team_slave_1 added
[  218.937648] bridge0: port 2(bridge_slave_1) entered blocking state
[  218.938552] bridge0: port 2(bridge_slave_1) entered disabled state
[  218.942952] device bridge_slave_1 entered promiscuous mode
[  218.952270] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready
[  218.954140] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready
[  218.975282] bond0: Enslaving bond_slave_0 as an active interface with an up link
[  218.979372] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready
[  218.983975] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready
[  218.988761] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready
[  218.991862] team0: Port device team_slave_0 added
[  219.010844] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready
[  219.015944] bond0: Enslaving bond_slave_1 as an active interface with an up link
[  219.036599] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready
[  219.038851] team0: Port device team_slave_1 added
[  219.042834] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready
[  219.047013] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready
[  219.052863] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready
[  219.055924] bridge0: port 1(bridge_slave_0) entered blocking state
[  219.056842] bridge0: port 1(bridge_slave_0) entered disabled state
[  219.060090] device bridge_slave_0 entered promiscuous mode
[  219.064107] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready
[  219.095999] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready
[  219.100176] bridge0: port 2(bridge_slave_1) entered blocking state
[  219.101145] bridge0: port 2(bridge_slave_1) entered disabled state
[  219.104174] device bridge_slave_1 entered promiscuous mode
[  219.111158] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready
[  219.133141] IPv6: ADDRCONF(NETDEV_UP): veth0_to_bridge: link is not ready
[  219.142707] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready
[  219.165904] IPv6: ADDRCONF(NETDEV_UP): veth1_to_bridge: link is not ready
[  219.173519] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready
[  219.185434] bond0: Enslaving bond_slave_0 as an active interface with an up link
[  219.256695] bond0: Enslaving bond_slave_1 as an active interface with an up link
[  219.265000] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready
[  219.267203] team0: Port device team_slave_0 added
[  219.295075] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready
[  219.297137] team0: Port device team_slave_1 added
[  219.306702] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready
[  219.311980] bond0: Enslaving bond_slave_0 as an active interface with an up link
[  219.341433] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready
[  219.345590] bond0: Enslaving bond_slave_1 as an active interface with an up link
[  219.392953] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready
[  219.420015] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready
[  219.437634] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready
[  219.439748] team0: Port device team_slave_0 added
[  219.461220] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready
[  219.474253] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready
[  219.476272] team0: Port device team_slave_1 added
[  219.495823] bridge0: port 2(bridge_slave_1) entered blocking state
[  219.496581] bridge0: port 2(bridge_slave_1) entered forwarding state
[  219.497641] bridge0: port 1(bridge_slave_0) entered blocking state
[  219.498381] bridge0: port 1(bridge_slave_0) entered forwarding state
[  219.506636] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready
[  219.508589] IPv6: ADDRCONF(NETDEV_UP): team_slave_0: link is not ready
[  219.510928] team0: Port device team_slave_0 added
[  219.523239] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready
[  219.529607] bridge0: port 2(bridge_slave_1) entered blocking state
[  219.530334] bridge0: port 2(bridge_slave_1) entered forwarding state
[  219.531187] bridge0: port 1(bridge_slave_0) entered blocking state
[  219.531903] bridge0: port 1(bridge_slave_0) entered forwarding state
[  219.539824] IPv6: ADDRCONF(NETDEV_UP): team_slave_1: link is not ready
[  219.544290] team0: Port device team_slave_1 added
[  219.552587] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready
[  219.569688] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready
[  219.579684] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready
[  219.607835] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready
[  219.633534] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready
[  219.656366] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready
[  219.683111] bridge0: port 2(bridge_slave_1) entered blocking state
[  219.683891] bridge0: port 2(bridge_slave_1) entered forwarding state
[  219.684778] bridge0: port 1(bridge_slave_0) entered blocking state
[  219.685517] bridge0: port 1(bridge_slave_0) entered forwarding state
[  219.754977] bridge0: port 2(bridge_slave_1) entered blocking state
[  219.755779] bridge0: port 2(bridge_slave_1) entered forwarding state
[  219.756670] bridge0: port 1(bridge_slave_0) entered blocking state
[  219.757449] bridge0: port 1(bridge_slave_0) entered forwarding state
[  219.834594] bridge0: port 2(bridge_slave_1) entered blocking state
[  219.835350] bridge0: port 2(bridge_slave_1) entered forwarding state
[  219.836221] bridge0: port 1(bridge_slave_0) entered blocking state
[  219.836968] bridge0: port 1(bridge_slave_0) entered forwarding state
[  219.931640] bridge0: port 2(bridge_slave_1) entered blocking state
[  219.932650] bridge0: port 2(bridge_slave_1) entered forwarding state
[  219.933776] bridge0: port 1(bridge_slave_0) entered blocking state
[  219.934707] bridge0: port 1(bridge_slave_0) entered forwarding state
[  220.783521] 8021q: adding VLAN 0 to HW filter on device bond0
[  220.792687] 8021q: adding VLAN 0 to HW filter on device bond0
[  220.874172] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready
[  220.891082] 8021q: adding VLAN 0 to HW filter on device bond0
[  220.893874] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready
[  220.901281] 8021q: adding VLAN 0 to HW filter on device bond0
[  220.961956] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready
[  220.999056] 8021q: adding VLAN 0 to HW filter on device bond0
[  221.000735] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready
[  221.006088] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready
[  221.008240] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready
[  221.073000] 8021q: adding VLAN 0 to HW filter on device team0
[  221.098034] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready
[  221.100873] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready
[  221.109880] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready
[  221.114441] 8021q: adding VLAN 0 to HW filter on device team0
[  221.118054] 8021q: adding VLAN 0 to HW filter on device bond0
[  221.201220] 8021q: adding VLAN 0 to HW filter on device team0
[  221.204579] 8021q: adding VLAN 0 to HW filter on device team0
[  221.208451] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready
[  221.212538] IPv6: ADDRCONF(NETDEV_UP): veth0: link is not ready
[  221.319967] 8021q: adding VLAN 0 to HW filter on device team0
[  221.326172] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready
[  221.416693] 8021q: adding VLAN 0 to HW filter on device team0
[  221.743459] 
[  221.743675] =============================================
[  221.744297] [ INFO: possible recursive locking detected ]
[  221.744944] 4.7.0+ #1 Not tainted
[  221.745326] ---------------------------------------------
[  221.746128] syz-executor1/6823 is trying to acquire lock:
[  221.746737]  (&vq->mutex){+.+...}, at: [<ffffffff84484b70>] vhost_process_iotlb_msg+0xe0/0x9e0
[  221.747789] 
[  221.747789] but task is already holding lock:
[  221.748470]  (&vq->mutex){+.+...}, at: [<ffffffff84484b70>] vhost_process_iotlb_msg+0xe0/0x9e0
[  221.749535] 
[  221.749535] other info that might help us debug this:
[  221.750280]  Possible unsafe locking scenario:
[  221.750280] 
[  221.750946]        CPU0
[  221.751232]        ----
[  221.751523]   lock(&vq->mutex);
[  221.751922]   lock(&vq->mutex);
[  221.752339] 
[  221.752339]  *** DEADLOCK ***
[  221.752339] 
[  221.753046]  May be due to missing lock nesting notation
[  221.753046] 
[  221.753850] 1 lock held by syz-executor1/6823:
[  221.754385]  #0:  (&vq->mutex){+.+...}, at: [<ffffffff84484b70>] vhost_process_iotlb_msg+0xe0/0x9e0
[  221.755498] 
[  221.755498] stack backtrace:
[  221.756005] CPU: 0 PID: 6823 Comm: syz-executor1 Not tainted 4.7.0+ #1
[  221.756753] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[  221.757700]  1ffffffff0d55e4a ffff880064f2f830 ffffffff829c1956 ffffffff87e092b0
[  221.758612]  ffff880065b68830 ffffffff87e092b0 0000000000a90548 ffff880064f2f9e0
[  221.759530]  ffffffff81442660 ffffffff858265d0 ffff880065b68000 ffff880064f2f8a8
[  221.760442] Call Trace:
[  221.760740]  [<ffffffff829c1956>] dump_stack+0xe6/0x120
[  221.761341]  [<ffffffff81442660>] __lock_acquire+0x710/0x3cf0
[  221.762014]  [<ffffffff858265d0>] ? _raw_spin_unlock_irq+0x60/0x80
[  221.762722]  [<ffffffff813c637b>] ? finish_task_switch+0x17b/0x630
[  221.763424]  [<ffffffff81441f50>] ? debug_check_no_locks_freed+0x3c0/0x3c0
[  221.764205]  [<ffffffff81489be7>] ? debug_lockdep_rcu_enabled+0x77/0x90
[  221.764962]  [<ffffffff814435c3>] ? __lock_acquire+0x1673/0x3cf0
[  221.765687]  [<ffffffff858189fe>] ? preempt_schedule+0x4e/0x60
[  221.766396]  [<ffffffff8581890b>] ? preempt_schedule_common+0x5b/0x100
[  221.767190]  [<ffffffff858189fe>] ? preempt_schedule+0x4e/0x60
[  221.767906]  [<ffffffff814468a6>] lock_acquire+0x196/0x480
[  221.768578]  [<ffffffff84484b70>] ? vhost_process_iotlb_msg+0xe0/0x9e0
[  221.769380]  [<ffffffff84484b70>] ? vhost_process_iotlb_msg+0xe0/0x9e0
[  221.770173]  [<ffffffff8581d348>] mutex_lock_nested+0xa8/0xb00
[  221.770889]  [<ffffffff84484b70>] ? vhost_process_iotlb_msg+0xe0/0x9e0
[  221.771686]  [<ffffffff81489be7>] ? debug_lockdep_rcu_enabled+0x77/0x90
[  221.772491]  [<ffffffff8581d2a0>] ? mutex_lock_killable_nested+0xce0/0xce0
[  221.773330]  [<ffffffff816bd6c1>] ? __might_fault+0xf1/0x1b0
[  221.774027]  [<ffffffff84484b70>] vhost_process_iotlb_msg+0xe0/0x9e0
[  221.774807]  [<ffffffff82a0043e>] ? copy_from_iter+0x16e/0x920
[  221.775518]  [<ffffffff84485552>] vhost_chr_write_iter+0xe2/0x110
[  221.776262]  [<ffffffff84485470>] ? vhost_process_iotlb_msg+0x9e0/0x9e0
[  221.777072]  [<ffffffff84472cf0>] vhost_net_chr_write_iter+0x50/0x80
[  221.777849]  [<ffffffff8179d893>] __vfs_write+0x303/0x740
[  221.778508]  [<ffffffff813c7031>] ? ___might_sleep+0x331/0x440
[  221.779221]  [<ffffffff8179d590>] ? do_iter_readv_writev+0x630/0x630
[  221.780001]  [<ffffffff8271c9ea>] ? selinux_file_permission+0x32a/0x400
[  221.780808]  [<ffffffff8179e578>] ? rw_verify_area+0xb8/0x2b0
[  221.781514]  [<ffffffff8179eb87>] vfs_write+0x147/0x4a0
[  221.782158]  [<ffffffff817a234b>] SyS_write+0xcb/0x1a0
[  221.782790]  [<ffffffff817a2280>] ? SyS_read+0x1a0/0x1a0
[  221.783449]  [<ffffffff8144144c>] ? trace_hardirqs_on_caller+0x44c/0x5e0
[  221.784268]  [<ffffffff8100501a>] ? trace_hardirqs_on_thunk+0x1a/0x1c
[  221.785053]  [<ffffffff85826d80>] entry_SYSCALL_64_fastpath+0x23/0xc1
[  221.810230] kobject: 'loop2' (ffff8800688cf3a0): kobject_uevent_env
[  221.811005] kobject: 'loop2' (ffff8800688cf3a0): fill_kobj_path: path = '/devices/virtual/block/loop2'
[  221.831128] kobject: 'loop3' (ffff880069fab3e0): kobject_uevent_env
[  221.831903] kobject: 'loop3' (ffff880069fab3e0): fill_kobj_path: path = '/devices/virtual/block/loop3'
[  221.843480] kobject: 'loop4' (ffff88006a0bd420): kobject_uevent_env
[  221.844256] kobject: 'loop4' (ffff88006a0bd420): fill_kobj_path: path = '/devices/virtual/block/loop4'
[  221.954272] kobject: 'loop0' (ffff880069325320): kobject_uevent_env
[  221.955012] kobject: 'loop0' (ffff880069325320): fill_kobj_path: path = '/devices/virtual/block/loop0'
[  221.964492] kobject: 'loop5' (ffff880069b53460): kobject_uevent_env
[  221.965236] kobject: 'loop5' (ffff880069b53460): fill_kobj_path: path = '/devices/virtual/block/loop5'