search

hashicorp / vagrant

Vagrant is a tool for building and distributing development environments.
https://www.vagrantup.com
Other
26.28k stars 4.44k forks source link

vagrant share fails with: Failed to connect to mux server: x509: failed to load system roots and no roots provided; signal: abort trap #8286

Closed ghost closed 7 years ago

ghost commented 7 years ago

vagrant share --ssh is failing with the following error:

The sharing proxy exited with a non-zero exit status! This represents
an erroneous exit and likely a bug. Please report this issue.

The debug output includes the following message, which may be related:

Failed to start sharing: Failed to connect to mux server: x509: failed to load system roots and no roots provided; signal: abort trap

Other similar issues have mentioned that there may be some kind of network restriction--like a firewall--but I don't have a firewall on my network. I am also able to telnet to the mux server at register.vagrantshare.com:8000 with no issue.

Vagrant version

Vagrant 1.9.1

Host operating system

Mac OSX 10.12.3

Guest operating system

Centos 6

Vagrantfile

# -*- mode: ruby -*-
# vi: set ft=ruby :

# All Vagrant configuration is done below. The "2" in Vagrant.configure
# configures the configuration version (we support older styles for
# backwards compatibility). Please don't change it unless you know what
# you're doing.
Vagrant.configure("2") do |config|

  config.vm.box = "centos/6"

end

Debug output

https://gist.github.com/bluetalon-ben/ea1c812d546e406cf9e08ca465402a24

I think the key lines are the following:

proxy:1487110758,log,[DEBUG] proxy: Connecting to mux server at register.vagrantshare.com:8000
DEBUG helper: Proxy message: ["log", "[INFO] Restricting ports to: [2222]"]
DEBUG helper: Proxy message: ["log", "[DEBUG] proxy: Connecting to mux server at register.vagrantshare.com:8000"]
DEBUG subprocess: stdout: proxy:1487110758,log,[ERR] proxy: Failed to start sharing: Failed to connect to mux server: x509: failed to load system roots and no roots provided; signal: abort trap
DEBUG helper: Proxy message: ["log", "[ERR] proxy: Failed to start sharing: Failed to connect to mux server: x509: failed to load system roots and no roots provided; signal: abort trap"]

Expected behavior

vagrant share --ssh should complete successfully, and include a shareable link

Actual behavior

vagrant share --ssh fails with the following message: The sharing proxy exited with a non-zero exit status! This represents an erroneous exit and likely a bug. Please report this issue.

Steps to reproduce

Not sure what exactly is different about my environment. Even after creating a brand new vagrant VM, I still see this issue.

References

ghost commented 7 years ago

Additional datapoint: I've updated to 1.9.2, but still seeing the same error.

kundeng commented 7 years ago

Same here. Here is the debug output. It seems that everything is fine till trying to connect to mux server. Also vagrant connect doesn't work on this host either.
Host version: mac os x sierra.

banditpro:ubuntu kundeng$ vagrant share --ssh --debug INFO global: Vagrant version: 1.9.3 INFO global: Ruby version: 2.2.5 INFO global: RubyGems version: 2.4.5.1 INFO global: VAGRANT_EXECUTABLE="/opt/vagrant/embedded/gems/gems/vagrant-1.9.3/bin/vagrant" INFO global: VAGRANT_OLD_ENV_XPC_SERVICE_NAME="0" INFO global: VAGRANT_OLD_ENV_OLDPWD="/Users/kundeng" INFO global: VAGRANT_OLD_ENV_SHELL="/bin/bash" INFO global: VAGRANT_OLD_ENV_USER="kundeng" INFO global: VAGRANT_OLD_ENV_SSH_AUTH_SOCK="/private/tmp/com.apple.launchd.LMsFL9WPoe/Listeners" INFO global: VAGRANT_OLD_ENV_LANG="en_US.UTF-8" INFO global: VAGRANT_OLD_ENV_TERM="xterm-256color" INFO global: VAGRANT_INSTALLER_VERSION="2" INFO global: VAGRANT_OLD_ENV_TMPDIR="/var/folders/yg/cdzrkn9j3x99ktfcd1prsqrm0000gn/T/" INFO global: VAGRANT_OLD_ENV_CF_USER_TEXT_ENCODING="0x1F5:0x0:0x0" INFO global: VAGRANT_OLD_ENV_PATH="/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/Library/TeX/texbin" INFO global: VAGRANT_OLD_ENV_SHLVL="1" INFO global: VAGRANT_INSTALLER_EMBEDDED_DIR="/opt/vagrant/embedded" INFO global: VAGRANT_OLD_ENV_TERM_PROGRAM_VERSION="388" INFO global: VAGRANT_OLD_ENV_XPC_FLAGS="0x0" INFO global: VAGRANT_OLD_ENV_PWD="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" INFO global: VAGRANT_INSTALLER_ENV="1" INFO global: VAGRANT_OLD_ENV_TERM_SESSION_ID="04192173-0C38-4B9A-9CEC-F2E72B37FF35" INFO global: VAGRANT_OLD_ENV_HOME="/Users/kundeng" INFO global: VAGRANT_OLD_ENV_LOGNAME="kundeng" INFO global: VAGRANT_OLD_ENV="/usr/local/bin/vagrant" INFO global: VAGRANT_OLD_ENV_TERM_PROGRAM="Apple_Terminal" INFO global: VAGRANT_OLD_ENV_Apple_PubSub_Socket_Render="/private/tmp/com.apple.launchd.ejLuokEOpZ/Render" INFO global: VAGRANT_LOG="debug" INFO global: Plugins: INFO global: - vagrant-share = [installed: undefined constraint: > 0] DEBUG bundler: Current generated plugin dependency list: [] DEBUG bundler: Generating new builtin set instance. DEBUG bundler: Generating new plugin set instance. Skip gems - [] DEBUG bundler: Activating solution set: ["vagrant-share-1.1.7", "vagrant-1.9.3", "nokogiri-1.6.7.1", "rest-client-2.0.1", "ruby_dep-1.3.1", "winrm-elevated-1.1.0", "winrm-fs-1.0.1", "winrm-2.1.3", "wdm-0.1.1", "rb-kqueue-0.2.4", "net-scp-1.1.2", "net-sftp-2.1.2", "net-ssh-3.0.2", "log4r-1.1.10", "hashicorp-checkpoint-0.1.4", "listen-3.1.5", "i18n-0.8.0", "erubis-2.7.0", "childprocess-0.5.9", "mini_portile2-2.0.0", "netrc-0.11.0", "mime-types-3.1", "http-cookie-1.0.3", "rubyzip-1.2.1", "logging-2.2.0", "builder-3.2.3", "gyoku-1.3.1", "nori-2.6.0", "rubyntlm-0.6.1", "httpclient-2.8.3", "gssapi-1.2.0", "ffi-1.9.18", "rb-inotify-0.9.8", "rb-fsevent-0.9.8", "mime-types-data-3.2016.0521", "domain_name-0.5.20170223", "multi_json-1.12.1", "little-plugger-1.1.4", "unf-0.1.4", "unf_ext-0.0.7.2"] DEBUG bundler: Activating gem vagrant-share-1.1.7 DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/box/plugin.rb INFO manager: Registered plugin: box command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/cap/plugin.rb INFO manager: Registered plugin: cap command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/destroy/plugin.rb INFO manager: Registered plugin: destroy command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/global-status/plugin.rb INFO manager: Registered plugin: global-status command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/halt/plugin.rb INFO manager: Registered plugin: halt command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/help/plugin.rb INFO manager: Registered plugin: help command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/init/plugin.rb INFO manager: Registered plugin: init command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/list-commands/plugin.rb INFO manager: Registered plugin: list-commands command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/login/plugin.rb INFO manager: Registered plugin: vagrant-login DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/package/plugin.rb INFO manager: Registered plugin: package command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/plugin/plugin.rb INFO manager: Registered plugin: plugin command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/port/plugin.rb INFO manager: Registered plugin: port command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/powershell/plugin.rb INFO manager: Registered plugin: powershell command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/provider/plugin.rb INFO manager: Registered plugin: provider command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/provision/plugin.rb INFO manager: Registered plugin: provision command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/push/plugin.rb INFO manager: Registered plugin: push command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/rdp/plugin.rb INFO manager: Registered plugin: rdp command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/reload/plugin.rb INFO manager: Registered plugin: reload command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/resume/plugin.rb INFO manager: Registered plugin: resume command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/snapshot/plugin.rb INFO manager: Registered plugin: snapshot command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/ssh/plugin.rb INFO manager: Registered plugin: ssh command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/ssh_config/plugin.rb INFO manager: Registered plugin: ssh-config command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/status/plugin.rb INFO manager: Registered plugin: status command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/suspend/plugin.rb INFO manager: Registered plugin: suspend command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/up/plugin.rb INFO manager: Registered plugin: up command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/commands/version/plugin.rb INFO manager: Registered plugin: version command DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/communicators/ssh/plugin.rb INFO manager: Registered plugin: ssh communicator DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/communicators/winrm/plugin.rb INFO manager: Registered plugin: winrm communicator DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/amazon/plugin.rb INFO manager: Registered plugin: Amazon Linux guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/arch/plugin.rb INFO manager: Registered plugin: Arch guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/atomic/plugin.rb INFO manager: Registered plugin: Atomic Host guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/bsd/plugin.rb INFO manager: Registered plugin: BSD-based guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/coreos/plugin.rb INFO manager: Registered plugin: CoreOS guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/darwin/plugin.rb INFO manager: Registered plugin: Darwin guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/debian/plugin.rb INFO manager: Registered plugin: Debian guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/dragonflybsd/plugin.rb INFO manager: Registered plugin: DragonFly BSD guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/esxi/plugin.rb INFO manager: Registered plugin: ESXi guest. DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/fedora/plugin.rb INFO manager: Registered plugin: Fedora guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/freebsd/plugin.rb INFO manager: Registered plugin: FreeBSD guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/funtoo/plugin.rb INFO manager: Registered plugin: Funtoo guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/gentoo/plugin.rb INFO manager: Registered plugin: Gentoo guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/linux/plugin.rb INFO manager: Registered plugin: Linux guest. DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/mint/plugin.rb INFO manager: Registered plugin: Mint guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/netbsd/plugin.rb INFO manager: Registered plugin: NetBSD guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/nixos/plugin.rb INFO manager: Registered plugin: NixOS guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/omnios/plugin.rb INFO manager: Registered plugin: OmniOS guest. DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/openbsd/plugin.rb INFO manager: Registered plugin: OpenBSD guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/photon/plugin.rb INFO manager: Registered plugin: VMware Photon guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/pld/plugin.rb INFO manager: Registered plugin: PLD Linux guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/redhat/plugin.rb INFO manager: Registered plugin: Red Hat Enterprise Linux guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/slackware/plugin.rb INFO manager: Registered plugin: Slackware guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/smartos/plugin.rb INFO manager: Registered plugin: SmartOS guest. DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/solaris/plugin.rb INFO manager: Registered plugin: Solaris guest. DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/solaris11/plugin.rb INFO manager: Registered plugin: Solaris 11 guest. DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/suse/plugin.rb INFO manager: Registered plugin: SUSE guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/tinycore/plugin.rb INFO manager: Registered plugin: TinyCore Linux guest. DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/trisquel/plugin.rb INFO manager: Registered plugin: Trisquel guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/ubuntu/plugin.rb INFO manager: Registered plugin: Ubuntu guest DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/guests/windows/plugin.rb INFO manager: Registered plugin: Windows guest. DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/arch/plugin.rb INFO manager: Registered plugin: Arch host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/bsd/plugin.rb INFO manager: Registered plugin: BSD host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/darwin/plugin.rb INFO manager: Registered plugin: Mac OS X host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/freebsd/plugin.rb INFO manager: Registered plugin: FreeBSD host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/gentoo/plugin.rb INFO manager: Registered plugin: Gentoo host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/linux/plugin.rb INFO manager: Registered plugin: Linux host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/null/plugin.rb INFO manager: Registered plugin: null host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/redhat/plugin.rb INFO manager: Registered plugin: Red Hat Enterprise Linux host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/slackware/plugin.rb INFO manager: Registered plugin: Slackware host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/suse/plugin.rb INFO manager: Registered plugin: SUSE host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/hosts/windows/plugin.rb INFO manager: Registered plugin: Windows host DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/kernel_v1/plugin.rb INFO manager: Registered plugin: kernel DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/kernel_v2/plugin.rb INFO manager: Registered plugin: kernel DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/providers/docker/plugin.rb INFO manager: Registered plugin: docker-provider DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/providers/hyperv/plugin.rb INFO manager: Registered plugin: Hyper-V provider DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/providers/virtualbox/plugin.rb INFO manager: Registered plugin: VirtualBox provider DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/provisioners/ansible/plugin.rb INFO manager: Registered plugin: ansible DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/provisioners/cfengine/plugin.rb INFO manager: Registered plugin: CFEngine Provisioner DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/provisioners/chef/plugin.rb INFO manager: Registered plugin: chef DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/provisioners/docker/plugin.rb INFO manager: Registered plugin: docker DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/provisioners/file/plugin.rb INFO manager: Registered plugin: file DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/provisioners/puppet/plugin.rb INFO manager: Registered plugin: puppet DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/provisioners/salt/plugin.rb INFO manager: Registered plugin: salt DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/provisioners/shell/plugin.rb INFO manager: Registered plugin: shell DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/pushes/atlas/plugin.rb INFO manager: Registered plugin: atlas DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/pushes/ftp/plugin.rb INFO manager: Registered plugin: ftp DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/pushes/heroku/plugin.rb INFO manager: Registered plugin: heroku DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/pushes/local-exec/plugin.rb INFO manager: Registered plugin: local-exec DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/pushes/noop/plugin.rb INFO manager: Registered plugin: noop DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/synced_folders/nfs/plugin.rb INFO manager: Registered plugin: NFS synced folders DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/synced_folders/rsync/plugin.rb INFO manager: Registered plugin: RSync synced folders DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/plugins/synced_folders/smb/plugin.rb INFO manager: Registered plugin: SMB synced folders INFO global: Loading plugins! DEBUG global: Loading plugin vagrant-share with default require: vagrant-share INFO manager: Registered plugin: vagrant-share DEBUG global: Successfully loaded plugin vagrant-share. INFO vagrant: vagrant invoked: ["share", "--ssh", "--debug"] DEBUG vagrant: Creating Vagrant environment INFO environment: Environment initialized (#) INFO environment: - cwd: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu INFO environment: Home path: /Users/kundeng/.vagrant.d DEBUG environment: Effective local data path: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant INFO environment: Local data path: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant DEBUG environment: Creating: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant INFO environment: Running hook: environment_plugins_loaded INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: environment_plugins_loaded # INFO environment: Running hook: environment_load INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: environment_load # INFO cli: CLI: [] "share" ["--ssh"] DEBUG cli: Invoking command class: VagrantPlugins::Share::Command::Share ["--ssh"] DEBUG share: Getting target VMs for command. Arguments: DEBUG share: -- names: [] DEBUG share: -- options: {:single_target=>true} DEBUG share: Loading all machines... INFO loader: Set :root = ["#<Pathname:/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/Vagrantfile>"] DEBUG loader: Populating proc cache for #<Pathname:/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/Vagrantfile> DEBUG loader: Load procs for pathname: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/Vagrantfile INFO loader: Loading configuration in order: [:home, :root] DEBUG loader: Loading from: root (evaluating) DEBUG loader: Configuration loaded successfully, finalizing and returning DEBUG push: finalizing INFO share: Active machine found with name default. Using provider: virtualbox INFO environment: Getting machine: default (virtualbox) INFO environment: Uncached load of machine. INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "--version"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: 5.1.12r112440 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG meta: Finding driver for VirtualBox version: 5.1.12 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1 INFO base: VBoxManage path: VBoxManage INFO loader: Set "2161259780_machine_default" = [] INFO loader: Loading configuration in order: [:home, :root, "2161259780_machine_default"] DEBUG loader: Loading from: root (cache) DEBUG loader: Configuration loaded successfully, finalizing and returning DEBUG push: finalizing INFO box_collection: Box found: ubuntu/xenial64 (virtualbox) INFO environment: Running hook: authenticate_box_url INFO host: Autodetecting host type for [#<Vagrant::Environment: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu>] DEBUG host: Trying: arch DEBUG host: Trying: darwin INFO host: Detected: darwin! INFO runner: Preparing hooks for middleware sequence... INFO runner: 2 hooks defined. INFO runner: Running action: authenticate_box_url # INFO warden: Calling IN action: # DEBUG client: Using authentication token from disk at /Users/kundeng/.vagrant.d/data/vagrant_login_token INFO warden: Calling OUT action: # INFO loader: Set :"2161653840_ubuntu/xenial64_virtualbox" = ["#<Pathname:/Users/kundeng/.vagrant.d/boxes/ubuntu-VAGRANTSLASH-xenial64/20170322.0.0/virtualbox/Vagrantfile>"] DEBUG loader: Populating proc cache for #<Pathname:/Users/kundeng/.vagrant.d/boxes/ubuntu-VAGRANTSLASH-xenial64/20170322.0.0/virtualbox/Vagrantfile> DEBUG loader: Load procs for pathname: /Users/kundeng/.vagrant.d/boxes/ubuntu-VAGRANTSLASH-xenial64/20170322.0.0/virtualbox/Vagrantfile INFO loader: Loading configuration in order: [:"2161653840_ubuntu/xenial64_virtualbox", :home, :root, "2161259780_machine_default"] DEBUG loader: Loading from: 2161653840_ubuntu/xenial64_virtualbox (evaluating) DEBUG loader: Loading from: root (cache) DEBUG loader: Configuration loaded successfully, finalizing and returning DEBUG push: finalizing INFO machine: Initializing machine: default INFO machine: - Provider: VagrantPlugins::ProviderVirtualBox::Provider INFO machine: - Box: # INFO machine: - Data dir: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant/machines/default/virtualbox DEBUG virtualbox: Instantiating the driver for machine ID: "9b251954-6a79-4dc3-ab83-d2aefb723159" INFO base: VBoxManage path: VBoxManage DEBUG meta: Finding driver for VirtualBox version: 5.1.12 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1 INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: Name: ubuntu_default_1490245959422_7554 Groups: / Guest OS: Linux 2.6 / 3.x / 4.x (64-bit) UUID: 9b251954-6a79-4dc3-ab83-d2aefb723159 Config file: /Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox Snapshot folder: /Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots Log folder: /Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs Hardware UUID: 9b251954-6a79-4dc3-ab83-d2aefb723159 Memory size: 1024MB Page Fusion: off VRAM size: 16MB CPU exec cap: 100% HPET: off Chipset: piix3 Firmware: BIOS Number of CPUs: 2 PAE: on Long Mode: on Triple Fault Reset: off APIC: on X2APIC: on CPUID Portability Level: 0 CPUID overrides: None Boot menu mode: message and menu Boot Device (1): Floppy Boot Device (2): DVD Boot Device (3): HardDisk Boot Device (4): Not Assigned ACPI: on IOAPIC: on BIOS APIC mode: APIC Time offset: 0ms RTC: UTC Hardw. virt.ext: on Nested Paging: on Large Pages: on VT-x VPID: on VT-x unr. exec.: on Paravirt. Provider: Default Effective Paravirt. Provider: KVM State: running (since 2017-03-23T05:12:40.766000000) Monitor count: 1 3D Acceleration: off 2D Video Acceleration: off Teleporter Enabled: off Teleporter Port: 0 Teleporter Address: Teleporter Password: Tracing Enabled: off Allow Tracing to Access VM: off Tracing Configuration: Autostart Enabled: off Autostart Delay: 0 Default Frontend: Storage Controller Name (0): IDE Storage Controller Type (0): PIIX4 Storage Controller Instance Number (0): 0 Storage Controller Max Port Count (0): 2 Storage Controller Port Count (0): 2 Storage Controller Bootable (0): on Storage Controller Name (1): SCSI Storage Controller Type (1): LsiLogic Storage Controller Instance Number (1): 0 Storage Controller Max Port Count (1): 16 Storage Controller Port Count (1): 16 Storage Controller Bootable (1): on SCSI (0, 0): /Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk (UUID: ade2d229-39a2-4828-913f-633c80bb31b0) SCSI (1, 0): /Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk (UUID: ca3f08c1-1758-4d4b-85b0-cabeca01a381) NIC 1: MAC: 022D8FCFD6CD, Attachment: NAT, Cable connected: on, Trace: off (file: none), Type: 82540EM, Reported speed: 0 Mbps, Boot priority: 0, Promisc Policy: deny, Bandwidth group: none NIC 1 Settings: MTU: 0, Socket (send: 64, receive: 64), TCP Window (send:64, receive: 64) NIC 1 Rule(0): name = ssh, protocol = tcp, host ip = 127.0.0.1, host port = 2222, guest ip = , guest port = 22 NIC 2: disabled NIC 3: disabled NIC 4: disabled NIC 5: disabled NIC 6: disabled NIC 7: disabled NIC 8: disabled Pointing Device: PS/2 Mouse Keyboard Device: PS/2 Keyboard UART 1: I/O base: 0x03f8, IRQ: 4, attached to raw file '/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log' UART 2: disabled UART 3: disabled UART 4: disabled LPT 1: disabled LPT 2: disabled Audio: enabled (Driver: CoreAudio, Controller: AC97, Codec: STAC9700) Clipboard Mode: disabled Drag and drop Mode: disabled Session name: headless Video mode: 720x400x0 at 0,0 enabled VRDE: disabled USB: disabled EHCI: disabled XHCI: disabled

USB Device Filters:

Available remote USB devices: Currently Attached USB Devices: Bandwidth groups: Shared folders: Name: 'vagrant', Host path: '/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu' (machine mapping), writable VRDE Connection: not active Clients so far: 0 Video capturing: not active Capture screens: 0 Capture file: /Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm Capture dimensions: 1024x768 Capture rate: 512 kbps Capture FPS: 25 Guest: Configured memory balloon size: 0 MB OS type: Linux26_64 Additions run level: 2 Additions version: 5.0.18_Ubuntu r106667 Guest Facilities: Facility "VirtualBox Base Driver": active/running (last update: 2017/03/23 05:13:40 UTC) Facility "VirtualBox System Service": active/running (last update: 2017/03/23 05:13:49 UTC) Facility "Seamless Mode": not active (last update: 2017/03/23 05:13:40 UTC) Facility "Graphics Mode": not active (last update: 2017/03/23 05:13:40 UTC) DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999 DEBUG subprocess: Exit status: 0 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO interface: Machine: metadata ["provider", :virtualbox, {:target=>:default}] INFO share: With machine: default (#, @name="stderr", @level=0, @formatter=#, @out=#>>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @machine=#, @driver=#, @name="stderr", @level=0, @formatter=#, @out=#>>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @level=1, @trace=false>, @interrupted=false, @vboxmanage_path="VBoxManage", @uuid="9b251954-6a79-4dc3-ab83-d2aefb723159", @driver=#, @name="stderr", @level=0, @formatter=#, @out=#>>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @interrupted=false, @vboxmanage_path="VBoxManage", @uuid="9b251954-6a79-4dc3-ab83-d2aefb723159">, @version="5.1.12">, @cap_logger=#, @name="stderr", @level=0, @formatter=#, @out=#>>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @cap_host_chain=[[:virtualbox, #<#:0x000001021b3a48>]], @cap_args=[#], @cap_caps={:docker=>##, :proxy_machine=>#}, @results_cache={}>, :hyperv=>##, :snapshot_list=>#}, @results_cache={}>, :virtualbox=>##, :nic_mac_addresses=>#, :public_address=>#, :snapshot_list=>#}, @results_cache={}>}>) INFO interface: output: Detecting network information for machine... INFO interface: output: ==> default: Detecting network information for machine... ==> default: Detecting network information for machine... INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: Searching for SSH port: 22 DEBUG virtualbox_5_1: read_forward_ports: uuid=9b251954-6a79-4dc3-ab83-d2aefb723159 active_only=false INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: - [1, "ssh", 2222, 22, "127.0.0.1"] DEBUG ssh: Checking key permissions: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant/machines/default/virtualbox/private_key DEBUG ssh: Checking whether SSH is ready... INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: Searching for SSH port: 22 DEBUG virtualbox_5_1: read_forward_ports: uuid=9b251954-6a79-4dc3-ab83-d2aefb723159 active_only=false INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: - [1, "ssh", 2222, 22, "127.0.0.1"] DEBUG ssh: Checking key permissions: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant/machines/default/virtualbox/private_key INFO ssh: Attempting SSH connection... INFO ssh: Attempting to connect to SSH... INFO ssh: - Host: 127.0.0.1 INFO ssh: - Port: 2222 INFO ssh: - Username: ubuntu INFO ssh: - Password? true INFO ssh: - Key Path: ["/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant/machines/default/virtualbox/private_key"] DEBUG ssh: - connect_opts: {:auth_methods=>["none", "hostbased", "publickey", "password"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>"4173cea90d86f568396ab0bf", :port=>2222, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :logger=>#, @formatter=nil, @logdev=#, @mutex=#>>>, :keys=>["/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant/machines/default/virtualbox/private_key"]} DEBUG ssh: == Net-SSH connection debug-level log START == DEBUG ssh: D, [2017-03-23T01:27:08.494227 #1795] DEBUG -- net.ssh.transport.session[80e0434c]: establishing connection to 127.0.0.1:2222 D, [2017-03-23T01:27:08.495185 #1795] DEBUG -- net.ssh.transport.session[80e0434c]: connection established I, [2017-03-23T01:27:08.495277 #1795] INFO -- net.ssh.transport.server_version[80e01570]: negotiating protocol version D, [2017-03-23T01:27:08.500001 #1795] DEBUG -- net.ssh.transport.server_version[80e01570]: remote is `SSH-2.0-OpenSSH_7.2p2 Ubuntu-4ubuntu2.1' D, [2017-03-23T01:27:08.500084 #1795] DEBUG -- net.ssh.transport.server_version[80e01570]: local is `SSH-2.0-Ruby/Net::SSH_3.0.2 x86_64-darwin13' D, [2017-03-23T01:27:08.500862 #1795] DEBUG -- socket[80e01ef8]: read 976 bytes D, [2017-03-23T01:27:08.500979 #1795] DEBUG -- socket[80e01ef8]: received packet nr 0 type 20 len 972 I, [2017-03-23T01:27:08.501054 #1795] INFO -- net.ssh.transport.algorithms[80e00058]: got KEXINIT from server I, [2017-03-23T01:27:08.501257 #1795] INFO -- net.ssh.transport.algorithms[80e00058]: sending KEXINIT D, [2017-03-23T01:27:08.501431 #1795] DEBUG -- socket[80e01ef8]: queueing packet nr 0 type 20 len 1684 D, [2017-03-23T01:27:08.501532 #1795] DEBUG -- socket[80e01ef8]: sent 1688 bytes I, [2017-03-23T01:27:08.501556 #1795] INFO -- net.ssh.transport.algorithms[80e00058]: negotiating algorithms D, [2017-03-23T01:27:08.501674 #1795] DEBUG -- net.ssh.transport.algorithms[80e00058]: negotiated: * kex: diffie-hellman-group14-sha1 * host_key: ssh-rsa * encryption_server: aes128-ctr * encryption_client: aes128-ctr * hmac_client: hmac-sha1 * hmac_server: hmac-sha1 * compression_client: none * compression_server: none * language_client: * language_server: D, [2017-03-23T01:27:08.501707 #1795] DEBUG -- net.ssh.transport.algorithms[80e00058]: exchanging keys D, [2017-03-23T01:27:08.504032 #1795] DEBUG -- socket[80e01ef8]: queueing packet nr 1 type 30 len 268 D, [2017-03-23T01:27:08.504130 #1795] DEBUG -- socket[80e01ef8]: sent 272 bytes D, [2017-03-23T01:27:08.506013 #1795] DEBUG -- socket[80e01ef8]: read 848 bytes D, [2017-03-23T01:27:08.506107 #1795] DEBUG -- socket[80e01ef8]: received packet nr 1 type 31 len 828 D, [2017-03-23T01:27:08.507039 #1795] DEBUG -- socket[80e01ef8]: queueing packet nr 2 type 21 len 20 D, [2017-03-23T01:27:08.507120 #1795] DEBUG -- socket[80e01ef8]: sent 24 bytes D, [2017-03-23T01:27:08.507245 #1795] DEBUG -- socket[80e01ef8]: received packet nr 2 type 21 len 12 D, [2017-03-23T01:27:08.507782 #1795] DEBUG -- net.ssh.authentication.session[80d8e32c]: beginning authentication of `ubuntu' D, [2017-03-23T01:27:08.507948 #1795] DEBUG -- socket[80e01ef8]: queueing packet nr 3 type 5 len 28 D, [2017-03-23T01:27:08.508007 #1795] DEBUG -- socket[80e01ef8]: sent 52 bytes D, [2017-03-23T01:27:08.508355 #1795] DEBUG -- socket[80e01ef8]: read 52 bytes D, [2017-03-23T01:27:08.508479 #1795] DEBUG -- socket[80e01ef8]: received packet nr 3 type 6 len 28 D, [2017-03-23T01:27:08.508580 #1795] DEBUG -- net.ssh.authentication.session[80d8e32c]: trying none D, [2017-03-23T01:27:08.508767 #1795] DEBUG -- socket[80e01ef8]: queueing packet nr 4 type 50 len 44 D, [2017-03-23T01:27:08.508822 #1795] DEBUG -- socket[80e01ef8]: sent 68 bytes D, [2017-03-23T01:27:08.509421 #1795] DEBUG -- socket[80e01ef8]: read 68 bytes D, [2017-03-23T01:27:08.509603 #1795] DEBUG -- socket[80e01ef8]: received packet nr 4 type 51 len 44 D, [2017-03-23T01:27:08.509675 #1795] DEBUG -- net.ssh.authentication.session[80d8e32c]: allowed methods: publickey,password D, [2017-03-23T01:27:08.509728 #1795] DEBUG -- net.ssh.authentication.methods.none[80d829b4]: none failed D, [2017-03-23T01:27:08.509789 #1795] DEBUG -- net.ssh.authentication.session[80d8e32c]: trying publickey D, [2017-03-23T01:27:08.510102 #1795] DEBUG -- net.ssh.authentication.agent[80d7a214]: connecting to ssh-agent D, [2017-03-23T01:27:08.510216 #1795] DEBUG -- net.ssh.authentication.agent[80d7a214]: sending agent request 1 len 47 D, [2017-03-23T01:27:08.510349 #1795] DEBUG -- net.ssh.authentication.agent[80d7a214]: received agent packet 5 len 1 D, [2017-03-23T01:27:08.510396 #1795] DEBUG -- net.ssh.authentication.agent[80d7a214]: sending agent request 11 len 0 D, [2017-03-23T01:27:08.510521 #1795] DEBUG -- net.ssh.authentication.agent[80d7a214]: received agent packet 12 len 5 D, [2017-03-23T01:27:08.510671 #1795] DEBUG -- net.ssh.authentication.methods.publickey[80d7a714]: trying publickey (72:0c:14:e3:b4:b2:cc:51:02:83:53:b0:89:b5:9f:c5) D, [2017-03-23T01:27:08.511055 #1795] DEBUG -- socket[80e01ef8]: queueing packet nr 5 type 50 len 348 D, [2017-03-23T01:27:08.511107 #1795] DEBUG -- socket[80e01ef8]: sent 372 bytes D, [2017-03-23T01:27:08.511694 #1795] DEBUG -- socket[80e01ef8]: read 324 bytes D, [2017-03-23T01:27:08.511972 #1795] DEBUG -- socket[80e01ef8]: received packet nr 5 type 60 len 300 D, [2017-03-23T01:27:08.513696 #1795] DEBUG -- socket[80e01ef8]: queueing packet nr 6 type 50 len 620 D, [2017-03-23T01:27:08.513742 #1795] DEBUG -- socket[80e01ef8]: sent 644 bytes D, [2017-03-23T01:27:08.514879 #1795] DEBUG -- socket[80e01ef8]: read 36 bytes D, [2017-03-23T01:27:08.514977 #1795] DEBUG -- socket[80e01ef8]: received packet nr 6 type 52 len 12 D, [2017-03-23T01:27:08.515027 #1795] DEBUG -- net.ssh.authentication.methods.publickey[80d7a714]: publickey succeeded (72:0c:14:e3:b4:b2:cc:51:02:83:53:b0:89:b5:9f:c5) DEBUG ssh: == Net-SSH connection debug-level log END == INFO ssh: SSH is ready! DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: Exit status: 0 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: Searching for SSH port: 22 DEBUG virtualbox_5_1: read_forward_ports: uuid=9b251954-6a79-4dc3-ab83-d2aefb723159 active_only=false INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: - [1, "ssh", 2222, 22, "127.0.0.1"] DEBUG ssh: Checking key permissions: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant/machines/default/virtualbox/private_key INFO guest: Autodetecting host type for [#] DEBUG guest: Trying: atomic DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: grep 'ostree=' /proc/cmdline (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: Exit status: 1 DEBUG guest: Trying: mint DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: if test -r /etc/os-release; then source /etc/os-release && test 'xLinux Mint' = "x$ID" && exit fi if test -x /usr/bin/lsb_release; then /usr/bin/lsb_release -i 2>/dev/null | grep -qi 'Linux Mint' && exit fi if test -r /etc/issue; then cat /etc/issue | grep -qi 'Linux Mint' && exit fi exit 1 (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: Exit status: 1 DEBUG guest: Trying: trisquel DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: [ -x /usr/bin/lsb_release ] && /usr/bin/lsb_release -i 2>/dev/null | grep Trisquel (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: Exit status: 1 DEBUG guest: Trying: amazon DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: grep 'Amazon Linux AMI' /etc/os-release (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: Exit status: 1 DEBUG guest: Trying: fedora DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: grep 'Fedora release' /etc/redhat-release (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: stderr: grep: /etc/redhat-release DEBUG ssh: stderr: : No such file or directory DEBUG ssh: Exit status: 2 DEBUG guest: Trying: funtoo DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: grep Funtoo /etc/gentoo-release (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: stderr: grep: DEBUG ssh: stderr: /etc/gentoo-release DEBUG ssh: stderr: : No such file or directory DEBUG ssh: stderr: DEBUG ssh: Exit status: 2 DEBUG guest: Trying: pld DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: cat /etc/pld-release (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: stderr: cat: /etc/pld-release DEBUG ssh: stderr: : No such file or directory DEBUG ssh: Exit status: 1 DEBUG guest: Trying: ubuntu DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: if test -r /etc/os-release; then source /etc/os-release && test 'xubuntu' = "x$ID" && exit fi if test -x /usr/bin/lsb_release; then /usr/bin/lsb_release -i 2>/dev/null | grep -qi 'ubuntu' && exit fi if test -r /etc/issue; then cat /etc/issue | grep -qi 'ubuntu' && exit fi exit 1 (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: Exit status: 0 INFO guest: Detected: ubuntu! DEBUG guest: Searching for cap: insert_public_key DEBUG guest: Checking in: ubuntu DEBUG guest: Checking in: debian DEBUG guest: Checking in: linux DEBUG guest: Found cap: insert_public_key in linux DEBUG provider: Searching for cap: public_address DEBUG provider: Checking in: virtualbox DEBUG provider: Found cap: public_address in virtualbox DEBUG provider: Searching for cap: public_address DEBUG provider: Checking in: virtualbox DEBUG provider: Found cap: public_address in virtualbox INFO provider: Execute capability: public_address [#] (virtualbox) INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: Searching for SSH port: 22 DEBUG virtualbox_5_1: read_forward_ports: uuid=9b251954-6a79-4dc3-ab83-d2aefb723159 active_only=false INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: - [1, "ssh", 2222, 22, "127.0.0.1"] DEBUG ssh: Checking key permissions: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant/machines/default/virtualbox/private_key INFO interface: detail: Local machine address: 127.0.0.1 INFO interface: detail: default: Local machine address: 127.0.0.1 default: Local machine address: 127.0.0.1 INFO interface: detail: Note: With the local address (127.0.0.1), Vagrant Share can only share any ports you have forwarded. Assign an IP or address to your machine to expose all TCP ports. Consult the documentation for your provider ('virtualbox') for more information. INFO interface: detail: default: default: Note: With the local address (127.0.0.1), Vagrant Share can only default: share any ports you have forwarded. Assign an IP or address to your default: machine to expose all TCP ports. Consult the documentation default: for your provider ('virtualbox') for more information. default: default: default: Note: With the local address (127.0.0.1), Vagrant Share can only default: share any ports you have forwarded. Assign an IP or address to your default: machine to expose all TCP ports. Consult the documentation default: for your provider ('virtualbox') for more information. default: DEBUG provider: Searching for cap: forwarded_ports DEBUG provider: Checking in: virtualbox DEBUG provider: Found cap: forwarded_ports in virtualbox DEBUG provider: Searching for cap: forwarded_ports DEBUG provider: Checking in: virtualbox DEBUG provider: Found cap: forwarded_ports in virtualbox INFO provider: Execute capability: forwarded_ports [#] (virtualbox) INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: read_forward_ports: uuid=9b251954-6a79-4dc3-ab83-d2aefb723159 active_only=false INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: - [1, "ssh", 2222, 22, "127.0.0.1"] DEBUG share: No HTTP port set. Auto-detection will be attempted. DEBUG helper: Trying: http://127.0.0.1:2222/ INFO retryable: Retryable exception raised: # DEBUG helper: Not an HTTP URL: http://127.0.0.1:2222/ INFO interface: detail: An HTTP port couldn't be detected! Since SSH is enabled, this is not an error. If you want to share both SSH and HTTP, please set an HTTP port with `--http`. INFO interface: detail: default: An HTTP port couldn't be detected! Since SSH is enabled, this is default: not an error. If you want to share both SSH and HTTP, please set default: an HTTP port with `--http`. default: default: An HTTP port couldn't be detected! Since SSH is enabled, this is default: not an error. If you want to share both SSH and HTTP, please set default: an HTTP port with `--http`. default: INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: Searching for SSH port: 22 DEBUG virtualbox_5_1: read_forward_ports: uuid=9b251954-6a79-4dc3-ab83-d2aefb723159 active_only=false INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "9b251954-6a79-4dc3-ab83-d2aefb723159", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. INFO subprocess: Command not in installer, restoring original environment... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ubuntu_default_1490245959422_7554" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="9b251954-6a79-4dc3-ab83-d2aefb723159" CfgFile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.vbox" SnapFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Snapshots" LogFldr="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/Logs" hardwareuuid="9b251954-6a79-4dc3-ab83-d2aefb723159" memory=1024 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="floppy" boot2="dvd" boot3="disk" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="running" VMStateChangeTime="2017-03-23T05:12:40.766000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="SCSI" storagecontrollertype1="LsiLogic" storagecontrollerinstance1="0" storagecontrollermaxportcount1="16" storagecontrollerportcount1="16" storagecontrollerbootable1="on" "IDE-0-0"="none" "IDE-0-1"="none" "IDE-1-0"="none" "IDE-1-1"="none" "SCSI-0-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg.vmdk" "SCSI-ImageUUID-0-0"="ade2d229-39a2-4828-913f-633c80bb31b0" "SCSI-1-0"="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu-xenial-16.04-cloudimg-configdrive.vmdk" "SCSI-ImageUUID-1-0"="ca3f08c1-1758-4d4b-85b0-cabeca01a381" "SCSI-2-0"="none" "SCSI-3-0"="none" "SCSI-4-0"="none" "SCSI-5-0"="none" "SCSI-6-0"="none" "SCSI-7-0"="none" "SCSI-8-0"="none" "SCSI-9-0"="none" "SCSI-10-0"="none" "SCSI-11-0"="none" "SCSI-12-0"="none" "SCSI-13-0"="none" "SCSI-14-0"="none" "SCSI-15-0"="none" natnet1="nat" macaddress1="022D8FCFD6CD" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="0x03f8,4" uartmode1="file,/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/ubuntu-xenial-16.04-cloudimg-console.log" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="coreaudio" clipboard="disabled" draganddrop="disabled" SessionName="headless" VideoMode="720,400,0"@0,0 1 vrde="off" usb="off" ehci="off" xhci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/kundeng/VirtualBox VMs/ubuntu_default_1490245959422_7554/ubuntu_default_1490245959422_7554.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Linux26_64" GuestAdditionsRunLevel=2 GuestAdditionsVersion="5.0.18_Ubuntu r106667" GuestAdditionsFacility_VirtualBox Base Driver=50,1490246020147 GuestAdditionsFacility_VirtualBox System Service=50,1490246029761 GuestAdditionsFacility_Seamless Mode=0,1490246020147 GuestAdditionsFacility_Graphics Mode=0,1490246020147 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG virtualbox_5_1: - [1, "ssh", 2222, 22, "127.0.0.1"] DEBUG ssh: Checking key permissions: /Users/kundeng/Dropbox/share/work/projects/vagrant/ubuntu/.vagrant/machines/default/virtualbox/private_key INFO interface: detail: Local HTTP port: disabled INFO interface: detail: default: Local HTTP port: disabled default: Local HTTP port: disabled INFO interface: detail: Local HTTPS port: disabled INFO interface: detail: default: Local HTTPS port: disabled default: Local HTTPS port: disabled INFO interface: detail: SSH Port: 2222 INFO interface: detail: default: SSH Port: 2222 default: SSH Port: 2222 INFO interface: detail: Port: 2222 INFO interface: detail: default: Port: 2222 default: Port: 2222 INFO interface: output: Generating new SSH key... INFO interface: output: ==> default: Generating new SSH key... ==> default: Generating new SSH key... INFO interface: ask: Please enter a password to encrypt the key: INFO interface: ask: default: Please enter a password to encrypt the key: default: Please enter a password to encrypt the key: INFO interface: ask: Repeat the password to confirm: INFO interface: ask: default: Repeat the password to confirm: default: Repeat the password to confirm: INFO interface: detail: Inserting generated SSH key into machine... INFO interface: detail: default: Inserting generated SSH key into machine... default: Inserting generated SSH key into machine... DEBUG ssh: Checking whether SSH is ready... DEBUG ssh: Re-using SSH connection. INFO ssh: SSH is ready! DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: Exit status: 0 DEBUG guest: Searching for cap: insert_public_key DEBUG guest: Checking in: ubuntu DEBUG guest: Checking in: debian DEBUG guest: Checking in: linux DEBUG guest: Found cap: insert_public_key in linux INFO guest: Execute capability: insert_public_key [#, "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDkEngiCU3JZhU9E+cc37/sU3lQ1kLv2GPIqqhqcRgbKUsBcFNiY+j5PDdTVAc87e537VhjtzY7g6SsCfcP5abLRQm9ufBoEM7HrQCqesF46Dccz4wdBsUK/OuSOhZ3sztCDGIjFBlcq8SoSVOtKLXBEqA31YzSVDQVK31I5HP/1ih0dsmzHE/oBpHG+DK+B784zfcXuYsoOMeIW6rwRn4GFlHkBnvjokQO3kWVgYBpaEUXxoRY8vatfKnwY0NFgsfLG32Mx4yFd9mSsV9GGb9XBOi5hpNW5P+uCCmg8PQCvgRN43XZmHTS/YwplkbX/BiGwkEYvoZA1rbz3NaV5KBN vagrant-share"] (ubuntu) DEBUG ssh: Uploading: /var/folders/yg/cdzrkn9j3x99ktfcd1prsqrm0000gn/T/vagrant-linux-insert-public-key20170323-1795-12tkkot to /tmp/vagrant-insert-pubkey-1490246835 DEBUG ssh: Re-using SSH connection. DEBUG ssh: Re-using SSH connection. INFO ssh: Execute: mkdir -p ~/.ssh chmod 0700 ~/.ssh cat '/tmp/vagrant-insert-pubkey-1490246835' >> ~/.ssh/authorized_keys && chmod 0600 ~/.ssh/authorized_keys result=$? rm -f '/tmp/vagrant-insert-pubkey-1490246835' exit $result (sudo=false) DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh DEBUG ssh: Exit status: 0 INFO interface: output: Checking authentication and authorization... INFO interface: output: ==> default: Checking authentication and authorization... ==> default: Checking authentication and authorization... DEBUG client: Using authentication token from disk at /Users/kundeng/.vagrant.d/data/vagrant_login_token DEBUG client: Using authentication token from disk at /Users/kundeng/.vagrant.d/data/vagrant_login_token INFO interface: output: Creating Vagrant Share session... INFO interface: output: ==> default: Creating Vagrant Share session... ==> default: Creating Vagrant Share session... INFO api: /api/v1/shares DEBUG api: API payload: {"share":{"http_port":null,"https_port":null,"ports":[2222],"private_key":"-----BEGIN RSA PRIVATE KEY-----\nProc-Type: 4,ENCRYPTED\nDEK-Info: DES-EDE3-CBC,05B1EC6C6D40449D\n\n/yqOGCV6q8E/g6l2HbHCHVBHyQ1Fgtg0kSsLPsdvXp165dgAO/n9wHJIQMLMdThI\nwYGrBwx0bcTNmWKrCP7oXOHUL46OBthbt/qP9twzkdoR89nBeWECKRFzi68Hko28\nygnGRMh1xzfa6dPppczcj93h8hXMPi9gMI7oZh1oGhiUdeB1EA47FYS6g0fakTPD\nckAJdhDgMWzI+VwbVAu7wUbmVUzl0Qw7Cm+EwkEcBI/KbyAvAJuuSNUlvaQtC++a\noL9T/rMjf4dKCk51Bl0ry1CEcmoHneyTZVzsWlSSIokGp4c5o33vDuCBHnCzADAU\no/pgl6D8sGgrslq6m6+jqxQ1onVOpUfamJoU/ZsiKxtGXkv2xwzPiqdNCbuJ2GfG\nmayFRNnaEWQRMGjtTZl7XA0woDPAyOpbqB7eYLEuEcYUHukU0Cqmf44/P3+XlcO/\nDPhmi00SjmsHzU1bCDCWL1N+B6XfdOfbJRClS3ImZg/Xg4bB24syWZYiQrlW677M\nz/pCduUDY26aYmhl+15Y2VxAtRDAspry1Tjv+qYtsNUSL3kFymtRO3/0dMG2LhjI\n9gM1kZd5tUuNDe0KqZGHi01S9rQNlpPEWteIs814NOEMdPR1UHhx/doqBCbxUOfO\ngIHGbAEbpJoS3cH+QWxhZSdAobjnd+EacCgjNJ7uexK5snpJW6rEyOm1Fl5klOF9\nG9wr0LXr+MkOWiu2RabHJcHGfxUWAvS+jYFO72u/9CPM5Xwq3OXWC9rxbe210A06\nMdP3YTwWtb7WmeTCErhVm0F+iwViO07cLUPpxPVXCdm1rNDZ59CaXOQXDGi+UowI\nldnSoFvRZgwAYMX91Ufe3wXt8YOy6Gm5JME6qsVxT1cSyrmUl0t0abd6WzUQrrXz\nmyk8+KO5Sql7fr2/SFq4R9fp4mz1VkpfQjfs7zYdJatgjhz+f2q2HQ62v/O6euiv\nPkY/4jJ9ujLPQSbfDBMZJZWMA+fatQ5R3mEhY3NIQ+1uZB0yOTn2uab0bOCP8pHX\npsYBkoawf3PiyO/xHfzrUvwyI2ByFV7Vt11zjMfcQDlBT9mpVW8uvvwvmHydqE/6\n6oLTByi3v/uk/c0Sdr5f2T7P4pzd3gy8/wjIc1TDyCXlE/RzcXB9RmGfzPRnNnCW\nxOwlAIVDasD+b94uMIn3AwKRJEIWf6TWcEGc2BAqmE7+/32Y1x0w3pea4127abZv\nU5ZB7V6o9lU+i7nLeXbLrTjj9eQ7jsPtd2zffpBbDcSwiqrhrGXYGuGpYOBfuVea\n8i0pv1b/1UF+JYsbU+YVcUO+6E0tFANKt4IFHnwi7YgqvQHfm+UYQoteDoeNurXa\nztf5KsyRFD+HAbTwtlE0K8FgfZ7A3tg89y5SyGjPDipyLg84hOkHEggDtu2qrkql\nmAcaHCJOxJESK9cicncoZG7xiiciw3U+YzS/79YCh2GSc49fu7tMSNH7AN3c2k/y\n6WPusxa1z2RsQYQNg+bdHDV/bjwseFS+wkCGzDmW38i9HWsxuO/5SShktNHrMLyT\nIGviIhmiwN46C1Q1HU8wikEmhXokAEmeX8u5HeW5MZ/pluBGNVnjHEtzaB3SGDp0\n-----END RSA PRIVATE KEY-----\n","private_key_password":true,"ssh_port":2222,"ssh_username":"ubuntu","use_key_once":false}} DEBUG api: Response: {"custom_domain":false,"expired":false,"has_private_key":true,"name":"joyful-eland-3708","http_port":null,"https_port":null,"ssh_port":2222,"ssh_username":"ubuntu","ports":[2222],"expired_at":null,"created_at":"2017-03-23T05:27:16.572Z","private_key_password":true,"token":null,"use_key_once":false,"domain":"vagrantshare.com","full_domain":"joyful-eland-3708.vagrantshare.com","mux_insecure":false,"mux_client_addr":"register.vagrantshare.com:8001","mux_server_addr":"register.vagrantshare.com:8000"} INFO interface: detail: Share will be at: joyful-eland-3708 INFO interface: detail: default: Share will be at: joyful-eland-3708 default: Share will be at: joyful-eland-3708 INFO interface: Machine: share-name ["joyful-eland-3708", {:target=>:default}] INFO helper: Executing proxy: ["-share", "-name", "joyful-eland-3708", "-target", "127.0.0.1", "-server", "register.vagrantshare.com:8000", "-port", "2222"] INFO subprocess: Starting process: ["/opt/vagrant/embedded/gems/gems/vagrant-share-1.1.7/localbin/proxy_darwin_amd64", "-share", "-name", "joyful-eland-3708", "-target", "127.0.0.1", "-server", "register.vagrantshare.com:8000", "-port", "2222"] INFO subprocess: Command in the installer. Specifying DYLD_LIBRARY_PATH... DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: proxy:1490246836,log,[INFO] Restricting ports to: [2222] proxy:1490246836,log,[DEBUG] proxy: Connecting to mux server at register.vagrantshare.com:8000 DEBUG helper: Proxy message: ["log", "[INFO] Restricting ports to: [2222]"] DEBUG helper: Proxy message: ["log", "[DEBUG] proxy: Connecting to mux server at register.vagrantshare.com:8000"] DEBUG subprocess: stdout: proxy:1490246836,log,[ERR] proxy: Failed to start sharing: Failed to connect to mux server: x509: failed to load system roots and no roots provided; signal: abort trap DEBUG helper: Proxy message: ["log", "[ERR] proxy: Failed to start sharing: Failed to connect to mux server: x509: failed to load system roots and no roots provided; signal: abort trap"] DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 1 INFO environment: Running hook: environment_unload INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: environment_unload # ERROR vagrant: Vagrant experienced an error! Details: ERROR vagrant: # ERROR vagrant: The sharing proxy exited with a non-zero exit status! This represents an erroneous exit and likely a bug. Please report this issue. ERROR vagrant: /opt/vagrant/embedded/gems/gems/vagrant-share-1.1.7/lib/vagrant-share/activate.rb:1988:in `block in start_share' /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/lib/vagrant/plugin/v2/command.rb:235:in `block in with_target_vms' /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/lib/vagrant/plugin/v2/command.rb:229:in `each' /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/lib/vagrant/plugin/v2/command.rb:229:in `with_target_vms' /opt/vagrant/embedded/gems/gems/vagrant-share-1.1.7/lib/vagrant-share/activate.rb:1757:in `start_share' /opt/vagrant/embedded/gems/gems/vagrant-share-1.1.7/lib/vagrant-share/activate.rb:2941:in `execute' /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/lib/vagrant/cli.rb:42:in `execute' /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/lib/vagrant/environment.rb:308:in `cli' /opt/vagrant/embedded/gems/gems/vagrant-1.9.3/bin/vagrant:127:in `
' INFO interface: error: The sharing proxy exited with a non-zero exit status! This represents an erroneous exit and likely a bug. Please report this issue. The sharing proxy exited with a non-zero exit status! This represents an erroneous exit and likely a bug. Please report this issue. INFO interface: Machine: error-exit ["VagrantPlugins::Share::Errors::ProxyExit", "The sharing proxy exited with a non-zero exit status! This represents\nan erroneous exit and likely a bug. Please report this issue."] banditpro:ubuntu kundeng$
kundeng commented 7 years ago

Can someone please take a look at this issue?

kundeng commented 7 years ago

Ok, the only way to fix this is to revert to older version of vagrant. I used 1.8.7.

Other solutions such as using homebrew's openssl and a new cacert.pem by linking, or replacing cert.pem by setting SSL_CERT_FILE would not work.

I think it is likely a bug in the binary file of the proxy itself.

chrisroberts commented 7 years ago

Hi there,

Thanks for reporting this bug. I'm sure this was a real issue when originally reported (our fault for not looking sooner!) but there have been multiple Vagrant releases since the original report. I'm going to close this issue now and request you reopen the issue if you're still experiencing this problem. I'm sorry this wasn't looked at earlier :frowning_face:

Cheers!

github-actions[bot] commented 3 years ago

I'm going to lock this issue because it has been closed for 30 days ⏳. This helps our maintainers find and focus on the active issues. If you have found a problem that seems similar to this, please open a new issue and complete the issue template so we can capture all the details necessary to investigate further.