Vagrant Provisioning Failure

 vagrant-test (master) [01:12:16] $ vagrant up --provision --debug
 INFO global: Vagrant version: 1.9.1
 INFO global: Ruby version: 2.2.5
 INFO global: RubyGems version: 2.4.5.1
 INFO global: VAGRANT_OLD_ENV_PAGER="less"
 INFO global: VAGRANT_OLD_ENV_SSH_AUTH_SOCK="/private/tmp/com.apple.launchd.L7XEQWRcjV/Listeners"
 INFO global: VAGRANT_OLD_ENV_TMPDIR="/var/folders/x4/0nr28wjx1591t4hs6qycfm3r0000gn/T/"
 INFO global: VAGRANT_OLD_ENV___CF_USER_TEXT_ENCODING="0x1F5:0x0:0x0"
 INFO global: VAGRANT_OLD_ENV_NVM_RC_VERSION=""
 INFO global: VAGRANT_OLD_ENV_TERM="xterm-256color"
 INFO global: VAGRANT_OLD_ENV_ITERM_PROFILE="Light"
 INFO global: VAGRANT_OLD_ENV_TERM_PROGRAM="iTerm.app"
 INFO global: VAGRANT_OLD_ENV_GHC_DOT_APP="/Applications/ghc-7.8.4.app"
 INFO global: VAGRANT_INSTALLER_ENV="1"
 INFO global: VAGRANT_INSTALLER_EMBEDDED_DIR="/opt/vagrant/embedded"
 INFO global: VAGRANT_OLD_ENV_AUTOJUMP_SOURCED="1"
 INFO global: VAGRANT_OLD_ENV_AUTOJUMP_ERROR_PATH="/Users/alextan/Library/autojump/errors.log"
 INFO global: VAGRANT_OLD_ENV_ITERM_SESSION_ID="w0t1p0:D0670634-2486-401D-8D2B-71BE28AC669D"
 INFO global: VAGRANT_OLD_ENV_NVM_NODEJS_ORG_MIRROR="https://nodejs.org/dist"
 INFO global: VAGRANT_OLD_ENV_ZSH="/Users/alextan/.oh-my-zsh"
 INFO global: VAGRANT_OLD_ENV_LESS="-R"
 INFO global: VAGRANT_OLD_ENV_EDITOR="mvim"
 INFO global: VAGRANT_OLD_ENV_KEYTIMEOUT="1"
 INFO global: VAGRANT_OLD_ENV_LSCOLORS="Gxfxcxdxbxegedabagacad"
 INFO global: VAGRANT_OLD_ENV_COLORFGBG="0;15"
 INFO global: VAGRANT_OLD_ENV_XPC_FLAGS="0x0"
 INFO global: VAGRANT_OLD_ENV_TERM_PROGRAM_VERSION="3.0.14"
 INFO global: VAGRANT_OLD_ENV_PATH="/usr/local/mysql/bin:/usr/local/sbin:/usr/local/heroku/bin:/Users/alextan/.rbenv/shims:/Users/alextan/.rbenv/bin:/Users/alextan/.cabal/bin:/Users/alextan/bin:/Users/alextan/.node/bin:/Users/alextan/Downloads/params-0.4.0/bin:/Users/alextan/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/go/bin:/Applications/Postgres.app/Contents/Versions/latest/bin:/Applications/VirtualBox.app/Contents/MacOS/:/Users/alextan/workspace/gocode/bin"
 INFO global: VAGRANT_OLD_ENV_SHLVL="1"
 INFO global: VAGRANT_OLD_ENV_USER="alextan"
 INFO global: VAGRANT_OLD_ENV_NVM_DIR="/Users/alextan/.nvm"
 INFO global: VAGRANT_OLD_ENV_GOPATH="/Users/alextan/workspace/gocode"
 INFO global: VAGRANT_OLD_ENV_LANG="en_US.UTF-8"
 INFO global: VAGRANT_OLD_ENV_LC_CTYPE="en_US.UTF-8"
 INFO global: VAGRANT_OLD_ENV_OLDPWD="/Users/alextan/Desktop"
 INFO global: VAGRANT_INSTALLER_VERSION="2"
 INFO global: VAGRANT_OLD_ENV_SHELL="/bin/zsh"
 INFO global: VAGRANT_OLD_ENV_HOME="/Users/alextan"
 INFO global: VAGRANT_OLD_ENV_RBENV_SHELL="zsh"
 INFO global: VAGRANT_OLD_ENV_SECURITYSESSIONID="186a7"
 INFO global: VAGRANT_OLD_ENV_TERM_SESSION_ID="w0t1p0:D0670634-2486-401D-8D2B-71BE28AC669D"
 INFO global: VAGRANT_OLD_ENV_Apple_PubSub_Socket_Render="/private/tmp/com.apple.launchd.qR6wGBWnWk/Render"
 INFO global: VAGRANT_OLD_ENV_DYLD_LIBRARY_PATH="/usr/local/mysql-5.5.46-osx10.8-x86_64:/usr/local/mysql/lib:"
 INFO global: VAGRANT_OLD_ENV_PWD="/Users/alextan/Desktop/vagrant-test"
 INFO global: VAGRANT_EXECUTABLE="/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/bin/vagrant"
 INFO global: VAGRANT_OLD_ENV_XPC_SERVICE_NAME="0"
 INFO global: VAGRANT_OLD_ENV_LOGNAME="alextan"
 INFO global: VAGRANT_OLD_ENV__="/usr/local/bin/vagrant"
 INFO global: VAGRANT_LOG="debug"
 INFO global: Plugins:
 INFO global:   - vagrant-fsnotify = [installed: 0.3.0 constraint: > 0]
 INFO global:   - vagrant-share = [installed: undefined constraint: > 0]
DEBUG bundler: Current generated plugin dependency list: [<Gem::Dependency type=:runtime name="vagrant-fsnotify" requirements="> 0">, <Gem::Dependency type=:runtime name="vagrant-share" requirements="> 0">]
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.6", "vagrant-fsnotify-0.3.0", "rest-client-2.0.0", "netrc-0.11.0", "mime-types-3.1", "http-cookie-1.0.3", "mime-types-data-3.2016.0521", "domain_name-0.5.20161129", "unf-0.1.4", "unf_ext-0.0.7.2"]
DEBUG bundler: Activating gem vagrant-share-1.1.6
DEBUG bundler: Activating gem vagrant-fsnotify-0.3.0
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/box/plugin.rb
 INFO manager: Registered plugin: box command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/cap/plugin.rb
 INFO manager: Registered plugin: cap command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/destroy/plugin.rb
 INFO manager: Registered plugin: destroy command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/commands/halt/plugin.rb
 INFO manager: Registered plugin: halt command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/help/plugin.rb
 INFO manager: Registered plugin: help command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/init/plugin.rb
 INFO manager: Registered plugin: init command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/commands/login/plugin.rb
 INFO manager: Registered plugin: vagrant-login
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/package/plugin.rb
 INFO manager: Registered plugin: package command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/plugin/plugin.rb
 INFO manager: Registered plugin: plugin command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/port/plugin.rb
 INFO manager: Registered plugin: port command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/powershell/plugin.rb
 INFO manager: Registered plugin: powershell command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/provider/plugin.rb
 INFO manager: Registered plugin: provider command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/provision/plugin.rb
 INFO manager: Registered plugin: provision command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/push/plugin.rb
 INFO manager: Registered plugin: push command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/rdp/plugin.rb
 INFO manager: Registered plugin: rdp command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/reload/plugin.rb
 INFO manager: Registered plugin: reload command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/resume/plugin.rb
 INFO manager: Registered plugin: resume command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/snapshot/plugin.rb
 INFO manager: Registered plugin: snapshot command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/ssh/plugin.rb
 INFO manager: Registered plugin: ssh command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/commands/status/plugin.rb
 INFO manager: Registered plugin: status command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/suspend/plugin.rb
 INFO manager: Registered plugin: suspend command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/up/plugin.rb
 INFO manager: Registered plugin: up command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/commands/version/plugin.rb
 INFO manager: Registered plugin: version command
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/communicators/ssh/plugin.rb
 INFO manager: Registered plugin: ssh communicator
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/communicators/winrm/plugin.rb
 INFO manager: Registered plugin: winrm communicator
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/guests/arch/plugin.rb
 INFO manager: Registered plugin: Arch guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/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.1/plugins/guests/coreos/plugin.rb
 INFO manager: Registered plugin: CoreOS guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/darwin/plugin.rb
 INFO manager: Registered plugin: Darwin guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/debian/plugin.rb
 INFO manager: Registered plugin: Debian guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/guests/esxi/plugin.rb
 INFO manager: Registered plugin: ESXi guest.
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/fedora/plugin.rb
 INFO manager: Registered plugin: Fedora guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/freebsd/plugin.rb
 INFO manager: Registered plugin: FreeBSD guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/funtoo/plugin.rb
 INFO manager: Registered plugin: Funtoo guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/gentoo/plugin.rb
 INFO manager: Registered plugin: Gentoo guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/linux/plugin.rb
 INFO manager: Registered plugin: Linux guest.
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/mint/plugin.rb
 INFO manager: Registered plugin: Mint guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/netbsd/plugin.rb
 INFO manager: Registered plugin: NetBSD guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/nixos/plugin.rb
 INFO manager: Registered plugin: NixOS guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/omnios/plugin.rb
 INFO manager: Registered plugin: OmniOS guest.
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/openbsd/plugin.rb
 INFO manager: Registered plugin: OpenBSD guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/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.1/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.1/plugins/guests/slackware/plugin.rb
 INFO manager: Registered plugin: Slackware guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/smartos/plugin.rb
 INFO manager: Registered plugin: SmartOS guest.
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/solaris/plugin.rb
 INFO manager: Registered plugin: Solaris guest.
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/guests/suse/plugin.rb
 INFO manager: Registered plugin: SUSE guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/guests/trisquel/plugin.rb
 INFO manager: Registered plugin: Trisquel guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/ubuntu/plugin.rb
 INFO manager: Registered plugin: Ubuntu guest
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/guests/windows/plugin.rb
 INFO manager: Registered plugin: Windows guest.
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/hosts/arch/plugin.rb
 INFO manager: Registered plugin: Arch host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/hosts/bsd/plugin.rb
 INFO manager: Registered plugin: BSD host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/hosts/freebsd/plugin.rb
 INFO manager: Registered plugin: FreeBSD host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/hosts/gentoo/plugin.rb
 INFO manager: Registered plugin: Gentoo host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/hosts/linux/plugin.rb
 INFO manager: Registered plugin: Linux host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/hosts/null/plugin.rb
 INFO manager: Registered plugin: null host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/hosts/slackware/plugin.rb
 INFO manager: Registered plugin: Slackware host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/hosts/suse/plugin.rb
 INFO manager: Registered plugin: SUSE host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/hosts/windows/plugin.rb
 INFO manager: Registered plugin: Windows host
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/kernel_v1/plugin.rb
 INFO manager: Registered plugin: kernel
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/kernel_v2/plugin.rb
 INFO manager: Registered plugin: kernel
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/docker/plugin.rb
 INFO manager: Registered plugin: docker-provider
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/providers/virtualbox/plugin.rb
 INFO manager: Registered plugin: VirtualBox provider
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/ansible/plugin.rb
 INFO manager: Registered plugin: ansible
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/cfengine/plugin.rb
 INFO manager: Registered plugin: CFEngine Provisioner
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/chef/plugin.rb
 INFO manager: Registered plugin: chef
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/docker/plugin.rb
 INFO manager: Registered plugin: docker
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/file/plugin.rb
 INFO manager: Registered plugin: file
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/puppet/plugin.rb
 INFO manager: Registered plugin: puppet
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/salt/plugin.rb
 INFO manager: Registered plugin: salt
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/shell/plugin.rb
 INFO manager: Registered plugin: shell
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/pushes/atlas/plugin.rb
 INFO manager: Registered plugin: atlas
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/pushes/ftp/plugin.rb
 INFO manager: Registered plugin: ftp
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/pushes/heroku/plugin.rb
 INFO manager: Registered plugin: heroku
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/plugins/pushes/noop/plugin.rb
 INFO manager: Registered plugin: noop
DEBUG global: Loading core plugin: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/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.1/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.1/plugins/synced_folders/smb/plugin.rb
 INFO manager: Registered plugin: SMB synced folders
 INFO global: Loading plugins!
DEBUG global: Loading plugin `vagrant-fsnotify` with default require: `vagrant-fsnotify`
 INFO manager: Registered plugin: vagrant-fsnotify
DEBUG global: Successfully loaded plugin `vagrant-fsnotify`.
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: ["up", "--provision", "--debug"]
DEBUG vagrant: Creating Vagrant environment
 INFO environment: Environment initialized (#<Vagrant::Environment:0x000001011d6a30>)
 INFO environment:   - cwd: /Users/alextan/Desktop/vagrant-test
 INFO environment: Home path: /Users/alextan/.vagrant.d
DEBUG environment: Effective local data path: /Users/alextan/Desktop/vagrant-test/.vagrant
 INFO environment: Local data path: /Users/alextan/Desktop/vagrant-test/.vagrant
DEBUG environment: Creating: /Users/alextan/Desktop/vagrant-test/.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 #<Vagrant::Action::Builder:0x00000101205d30>
 INFO environment: Running hook: environment_load
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: environment_load #<Vagrant::Action::Builder:0x000001030bdf98>
 INFO cli: CLI: [] "up" ["--provision"]
DEBUG cli: Invoking command class: VagrantPlugins::CommandUp::Command ["--provision"]
DEBUG command: 'Up' each target VM...
 INFO loader: Set :root = ["#<Pathname:/Users/alextan/Desktop/vagrant-test/Vagrantfile>"]
DEBUG loader: Populating proc cache for #<Pathname:/Users/alextan/Desktop/vagrant-test/Vagrantfile>
DEBUG loader: Load procs for pathname: /Users/alextan/Desktop/vagrant-test/Vagrantfile
 INFO loader: Loading configuration in order: [:home, :root]
DEBUG loader: Loading from: root (evaluating)
DEBUG provisioner: Provisioner defined:
DEBUG loader: Configuration loaded successfully, finalizing and returning
DEBUG push: finalizing
DEBUG command: Getting target VMs for command. Arguments:
DEBUG command:  -- names: ["default"]
DEBUG command:  -- options: nil
DEBUG command: Finding machine that match name: default
 INFO command: 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.10r112026
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.10
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1
 INFO base: VBoxManage path: VBoxManage
 INFO loader: Set "2152257480_machine_default" = []
 INFO loader: Loading configuration in order: [:home, :root, "2152257480_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/trusty64 (virtualbox)
 INFO environment: Running hook: authenticate_box_url
 INFO host: Autodetecting host type for [#<Vagrant::Environment: /Users/alextan/Desktop/vagrant-test>]
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 #<Vagrant::Action::Builder:0x00000102940f40>
 INFO warden: Calling IN action: #<VagrantPlugins::LoginCommand::AddAuthentication:0x000001029c26d0>
DEBUG client: No authentication token in environment or /Users/alextan/.vagrant.d/data/vagrant_login_token
 INFO warden: Calling OUT action: #<VagrantPlugins::LoginCommand::AddAuthentication:0x000001029c26d0>
 INFO loader: Set :"2168741460_ubuntu/trusty64_virtualbox" = ["#<Pathname:/Users/alextan/.vagrant.d/boxes/ubuntu-VAGRANTSLASH-trusty64/20170213.0.0/virtualbox/Vagrantfile>"]
DEBUG loader: Populating proc cache for #<Pathname:/Users/alextan/.vagrant.d/boxes/ubuntu-VAGRANTSLASH-trusty64/20170213.0.0/virtualbox/Vagrantfile>
DEBUG loader: Load procs for pathname: /Users/alextan/.vagrant.d/boxes/ubuntu-VAGRANTSLASH-trusty64/20170213.0.0/virtualbox/Vagrantfile
 INFO loader: Loading configuration in order: [:"2168741460_ubuntu/trusty64_virtualbox", :home, :root, "2152257480_machine_default"]
DEBUG loader: Loading from: 2168741460_ubuntu/trusty64_virtualbox (evaluating)
DEBUG loader: Upgrading config from version 1 to 2
DEBUG loader: Upgrading config to version 2
DEBUG loader: Upgraded to version 2 with 0 warnings and 0 errors
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: #<Vagrant::Box:0x00000100b43420>
 INFO machine:   - Data dir: /Users/alextan/Desktop/vagrant-test/.vagrant/machines/default/virtualbox
DEBUG virtualbox: Instantiating the driver for machine ID: "4bfae953-6f3b-4676-a8d7-53fb1c16c970"
 INFO base: VBoxManage path: VBoxManage
DEBUG meta: Finding driver for VirtualBox version: 5.1.10
 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", "4bfae953-6f3b-4676-a8d7-53fb1c16c970"]
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:            vagrant-test_default_1487271688786_88655
Groups:          /
Guest OS:        Ubuntu (64-bit)
UUID:            4bfae953-6f3b-4676-a8d7-53fb1c16c970
Config file:     /Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox
Snapshot folder: /Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots
Log folder:      /Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs
Hardware UUID:   4bfae953-6f3b-4676-a8d7-53fb1c16c970
Memory size:     3072MB
Page Fusion:     off
VRAM size:       12MB
CPU exec cap:    100%
HPET:            off
Chipset:         piix3
Firmware:        BIOS
Number of CPUs:  1
PAE:             off
Long Mode:       on
Triple Fault Reset: off
APIC:            on
X2APIC:          off
CPUID Portability Level: 0
CPUID overrides: None
Boot menu mode:  message and menu
Boot Device (1): HardDisk
Boot Device (2): Not Assigned
Boot Device (3): Not Assigned
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:     off
VT-x VPID:       on
VT-x unr. exec.: on
Paravirt. Provider: Legacy
Effective Paravirt. Provider: None
State:           running (since 2017-02-16T19:01:30.150000000)
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):            SATAController
Storage Controller Type (0):            IntelAhci
Storage Controller Instance Number (0): 0
Storage Controller Max Port Count (0):  30
Storage Controller Port Count (0):      1
Storage Controller Bootable (0):        on
SATAController (0, 0): /Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk (UUID: c6fca45a-0522-4405-ae99-d789c25e9d9b)
NIC 1:           MAC: 080027406789, 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 = 2200, 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:          disabled
UART 2:          disabled
UART 3:          disabled
UART 4:          disabled
LPT 1:           disabled
LPT 2:           disabled
Audio:           disabled
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:

<none>

Available remote USB devices:

<none>

Currently Attached USB Devices:

<none>

Bandwidth groups:  <none>

Shared folders:

Name: 'vagrant', Host path: '/Users/alextan/Desktop/vagrant-test' (machine mapping), writable
Name: 'v-csc-7ee9e61a8', Host path: '/Users/alextan/Desktop/vagrant-test/cookbooks' (machine mapping), writable

VRDE Connection:    not active
Clients so far:     0

Video capturing:    not active
Capture screens:    0
Capture file:       /Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.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:                   4.3.36_Ubuntu r105129


Guest Facilities:

Facility "VirtualBox Base Driver": active/running (last update: 2017/02/16 19:01:36 UTC)
Facility "VirtualBox System Service": active/running (last update: 2017/02/16 19:01:40 UTC)
Facility "Seamless Mode": not active (last update: 2017/02/16 19:01:36 UTC)
Facility "Graphics Mode": not active (last update: 2017/02/16 19:01:36 UTC)


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", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
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 command: With machine: default (#<VagrantPlugins::ProviderVirtualBox::Provider:0x00000102ab3120 @logger=#<Log4r::Logger:0x00000102ab30d0 @fullname="vagrant::provider::virtualbox", @outputters=[], @additive=true, @name="virtualbox", @path="vagrant::provider", @parent=#<Log4r::Logger:0x00000102850428 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x00000100857bf8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000100857ae0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x0000010084e2d8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x000001028502e8 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @machine=#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>, @driver=#<VagrantPlugins::ProviderVirtualBox::Driver::Meta:0x00000100bb5c00 @logger=#<Log4r::Logger:0x00000100ba6ea8 @fullname="vagrant::provider::virtualbox::meta", @outputters=[], @additive=true, @name="meta", @path="vagrant::provider::virtualbox", @parent=#<Log4r::Logger:0x00000102ab30d0 @fullname="vagrant::provider::virtualbox", @outputters=[], @additive=true, @name="virtualbox", @path="vagrant::provider", @parent=#<Log4r::Logger:0x00000102850428 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x00000100857bf8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000100857ae0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x0000010084e2d8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x000001028502e8 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @level=1, @trace=false>, @interrupted=false, @vboxmanage_path="VBoxManage", @uuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970", @driver=#<VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1:0x000001031dd7e8 @logger=#<Log4r::Logger:0x00000102a9b2c8 @fullname="vagrant::provider::virtualbox_5_1", @outputters=[], @additive=true, @name="virtualbox_5_1", @path="vagrant::provider", @parent=#<Log4r::Logger:0x00000102850428 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x00000100857bf8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000100857ae0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x0000010084e2d8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x000001028502e8 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @interrupted=false, @vboxmanage_path="VBoxManage", @uuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970">, @version="5.1.10">, @cap_logger=#<Log4r::Logger:0x000001031b4078 @fullname="vagrant::capability_host::vagrantplugins::providervirtualbox::provider", @outputters=[], @additive=true, @name="provider", @path="vagrant::capability_host::vagrantplugins::providervirtualbox", @parent=#<Log4r::Logger:0x00000102850428 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x00000100857bf8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000100857ae0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x0000010084e2d8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x000001028502e8 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @cap_host_chain=[[:virtualbox, #<#<Class:0x000001031b47a8>:0x0000010316ed70>]], @cap_args=[#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>], @cap_caps={:docker=>#<Vagrant::Registry:0x000001031b4578 @items={:public_address=>#<Proc:0x00000103015de8@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/docker/plugin.rb:60>, :proxy_machine=>#<Proc:0x00000103015b68@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/docker/plugin.rb:65>}, @results_cache={}>, :hyperv=>#<Vagrant::Registry:0x000001031b4488 @items={:public_address=>#<Proc:0x000001030073b0@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/hyperv/plugin.rb:25>, :snapshot_list=>#<Proc:0x00000103006e60@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/hyperv/plugin.rb:30>}, @results_cache={}>, :virtualbox=>#<Vagrant::Registry:0x000001031b4320 @items={:forwarded_ports=>#<Proc:0x00000102838d78@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/plugin.rb:27>, :nic_mac_addresses=>#<Proc:0x00000102838cb0@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/plugin.rb:32>, :public_address=>#<Proc:0x00000102838c88@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/plugin.rb:37>, :snapshot_list=>#<Proc:0x00000102838c10@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/plugin.rb:42>}, @results_cache={}>}>)
 INFO loader: Set "2152257480_machine_default" = []
 INFO loader: Loading configuration in order: [:home, :root, "2152257480_machine_default"]
ERROR loader: Unknown config sources: [:"2168741460_ubuntu/trusty64_virtualbox"]
DEBUG loader: Loading from: root (cache)
DEBUG loader: Configuration loaded successfully, finalizing and returning
DEBUG push: finalizing
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG host: Searching for cap: provider_install_virtualbox
DEBUG host: Checking in: darwin
DEBUG host: Found cap: provider_install_virtualbox in darwin
 INFO base: VBoxManage path: VBoxManage
DEBUG meta: Finding driver for VirtualBox version: 5.1.10
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1
 INFO base: VBoxManage path: VBoxManage
DEBUG command: Getting target VMs for command. Arguments:
DEBUG command:  -- names: ["default"]
DEBUG command:  -- options: {:provider=>nil}
DEBUG command: Finding machine that match name: default
 INFO command: Active machine found with name default. Using provider: virtualbox
 INFO environment: Getting machine: default (virtualbox)
 INFO environment: Returning cached machine: default (virtualbox)
 INFO command: With machine: default (#<VagrantPlugins::ProviderVirtualBox::Provider:0x00000102ab3120 @logger=#<Log4r::Logger:0x00000102ab30d0 @fullname="vagrant::provider::virtualbox", @outputters=[], @additive=true, @name="virtualbox", @path="vagrant::provider", @parent=#<Log4r::Logger:0x00000102850428 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x00000100857bf8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000100857ae0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x0000010084e2d8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x000001028502e8 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @machine=#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>, @driver=#<VagrantPlugins::ProviderVirtualBox::Driver::Meta:0x00000100bb5c00 @logger=#<Log4r::Logger:0x00000100ba6ea8 @fullname="vagrant::provider::virtualbox::meta", @outputters=[], @additive=true, @name="meta", @path="vagrant::provider::virtualbox", @parent=#<Log4r::Logger:0x00000102ab30d0 @fullname="vagrant::provider::virtualbox", @outputters=[], @additive=true, @name="virtualbox", @path="vagrant::provider", @parent=#<Log4r::Logger:0x00000102850428 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x00000100857bf8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000100857ae0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x0000010084e2d8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x000001028502e8 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @level=1, @trace=false>, @interrupted=false, @vboxmanage_path="VBoxManage", @uuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970", @driver=#<VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1:0x000001031dd7e8 @logger=#<Log4r::Logger:0x00000102a9b2c8 @fullname="vagrant::provider::virtualbox_5_1", @outputters=[], @additive=true, @name="virtualbox_5_1", @path="vagrant::provider", @parent=#<Log4r::Logger:0x00000102850428 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x00000100857bf8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000100857ae0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x0000010084e2d8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x000001028502e8 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @interrupted=false, @vboxmanage_path="VBoxManage", @uuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970">, @version="5.1.10">, @cap_logger=#<Log4r::Logger:0x000001031b4078 @fullname="vagrant::capability_host::vagrantplugins::providervirtualbox::provider", @outputters=[], @additive=true, @name="provider", @path="vagrant::capability_host::vagrantplugins::providervirtualbox", @parent=#<Log4r::Logger:0x00000102850428 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x00000100857bf8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000100857ae0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x0000010084e2d8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x000001028502e8 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @cap_host_chain=[[:virtualbox, #<#<Class:0x000001031b47a8>:0x0000010316ed70>]], @cap_args=[#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>], @cap_caps={:docker=>#<Vagrant::Registry:0x000001031b4578 @items={:public_address=>#<Proc:0x00000103015de8@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/docker/plugin.rb:60>, :proxy_machine=>#<Proc:0x00000103015b68@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/docker/plugin.rb:65>}, @results_cache={}>, :hyperv=>#<Vagrant::Registry:0x000001031b4488 @items={:public_address=>#<Proc:0x000001030073b0@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/hyperv/plugin.rb:25>, :snapshot_list=>#<Proc:0x00000103006e60@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/hyperv/plugin.rb:30>}, @results_cache={}>, :virtualbox=>#<Vagrant::Registry:0x000001031b4320 @items={:forwarded_ports=>#<Proc:0x00000102838d78@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/plugin.rb:27>, :nic_mac_addresses=>#<Proc:0x00000102838cb0@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/plugin.rb:32>, :public_address=>#<Proc:0x00000102838c88@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/plugin.rb:37>, :snapshot_list=>#<Proc:0x00000102838c10@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/plugin.rb:42>}, @results_cache={}>}>)
 INFO interface: info: Bringing machine 'default' up with 'virtualbox' provider...
Bringing machine 'default' up with 'virtualbox' provider...
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO batch_action: Enabling parallelization by default.
 INFO batch_action: Disabling parallelization because provider doesn't support it: virtualbox
 INFO batch_action: Batch action will parallelize: false
 INFO batch_action: Starting action: #<Vagrant::Machine:0x000001013733e8> up {:destroy_on_error=>true, :install_provider=>true, :parallel=>true, :provision_ignore_sentinel=>true, :provision_types=>nil, :provision_enabled=>true}
 INFO machine: Calling action: up on provider VirtualBox (4bfae953-6f3b-4676-a8d7-53fb1c16c970)
DEBUG environment: Attempting to acquire process-lock: machine-action-8ee5b5d74cdb7ecea66a42890bed0794
DEBUG environment: Attempting to acquire process-lock: dotlock
 INFO environment: Acquired process lock: dotlock
 INFO environment: Released process lock: dotlock
 INFO environment: Acquired process lock: machine-action-8ee5b5d74cdb7ecea66a42890bed0794
 INFO interface: Machine: action ["up", "start", {:target=>:default}]
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Builder:0x000001029933a8>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x00000102952858>
 INFO base: VBoxManage path: VBoxManage
DEBUG meta: Finding driver for VirtualBox version: 5.1.10
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1
 INFO base: VBoxManage path: VBoxManage
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "list", "hostonlyifs"]
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:            vboxnet0
GUID:            786f6276-656e-4074-8000-0a0027000000
DHCP:            Disabled
IPAddress:       192.168.59.3
NetworkMask:     255.255.255.0
IPV6Address:
IPV6NetworkMaskPrefixLength: 0
HardwareAddress: 0a:00:27:00:00:00
MediumType:      Ethernet
Status:          Down
VBoxNetworkName: HostInterfaceNetworking-vboxnet0

Name:            vboxnet1
GUID:            786f6276-656e-4174-8000-0a0027000001
DHCP:            Disabled
IPAddress:       192.168.33.1
NetworkMask:     255.255.255.0
IPV6Address:
IPV6NetworkMaskPrefixLength: 0
HardwareAddress: 0a:00:27:00:00:01
MediumType:      Ethernet
Status:          Down
VBoxNetworkName: HostInterfaceNetworking-vboxnet1

DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x000001029527e0>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Builder:0x00000100c9e7e8>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000100c97498>
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling OUT action: #<VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000100c97498>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Warden:0x0000010324c198>
 INFO warden: Calling IN action: #<Proc:0x00000103207098@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Proc:0x0000010324c0f8@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::ConfigValidate:0x00000102952790>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x00000102952768>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Builder:0x00000101350460>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000101348b98>
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling OUT action: #<VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000101348b98>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Warden:0x00000100badc08>
 INFO warden: Calling IN action: #<Proc:0x000001012f0e20@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Proc:0x00000100badb40@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x000001029526c8>
 INFO base: VBoxManage path: VBoxManage
DEBUG meta: Finding driver for VirtualBox version: 5.1.10
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1
 INFO base: VBoxManage path: VBoxManage
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "list", "hostonlyifs"]
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:            vboxnet0
GUID:            786f6276-656e-4074-8000-0a0027000000
DHCP:            Disabled
IPAddress:       192.168.59.3
NetworkMask:     255.255.255.0
IPV6Address:
IPV6NetworkMaskPrefixLength: 0
HardwareAddress: 0a:00:27:00:00:00
MediumType:      Ethernet
Status:          Down
VBoxNetworkName: HostInterfaceNetworking-vboxnet0

Name:            vboxnet1
GUID:            786f6276-656e-4174-8000-0a0027000001
DHCP:            Disabled
IPAddress:       192.168.33.1
NetworkMask:     255.255.255.0
IPV6Address:
IPV6NetworkMaskPrefixLength: 0
HardwareAddress: 0a:00:27:00:00:01
MediumType:      Ethernet
Status:          Down
VBoxNetworkName: HostInterfaceNetworking-vboxnet1

DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::ConfigValidate:0x000001029526a0>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::BoxCheckOutdated:0x00000102952678>
 INFO interface: output: Checking if box 'ubuntu/trusty64' is up to date...
 INFO interface: output: ==> default: Checking if box 'ubuntu/trusty64' is up to date...
==> default: Checking if box 'ubuntu/trusty64' is up to date...
 INFO downloader: Downloader starting download:
 INFO downloader:   -- Source: https://atlas.hashicorp.com/ubuntu/trusty64
 INFO downloader:   -- Destination: /var/folders/x4/0nr28wjx1591t4hs6qycfm3r0000gn/T/vagrant-load-metadata20170216-57282-hv68bf
 INFO subprocess: Starting process: ["/opt/vagrant/embedded/bin/curl", "-q", "--fail", "--location", "--max-redirs", "10", "--user-agent", "Vagrant/1.9.1 (+https://www.vagrantup.com; ruby2.2.5)", "-H", "Accept: application/json", "--output", "/var/folders/x4/0nr28wjx1591t4hs6qycfm3r0000gn/T/vagrant-load-metadata20170216-57282-hv68bf", "https://atlas.hashicorp.com/ubuntu/trusty64"]
 INFO subprocess: Command in the installer. Specifying DYLD_LIBRARY_PATH...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stderr:   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed
  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
100   115  100   115    0     0    213      0 --:--:-- --:--:-- --:--:--   245
  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
100 51808    0 51808    0     0  42538      0 --:--:--  0:00:01 --:--:--  158k
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x00000101246448>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Builder:0x00000103063430>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::IsRunning:0x00000102932cd8>
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling OUT action: #<VagrantPlugins::ProviderVirtualBox::Action::IsRunning:0x00000102932cd8>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Warden:0x00000102ae1f98>
 INFO warden: Calling IN action: #<Proc:0x00000100cc7d00@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x00000102ae1ed0>
 INFO base: VBoxManage path: VBoxManage
DEBUG meta: Finding driver for VirtualBox version: 5.1.10
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_5_1
 INFO base: VBoxManage path: VBoxManage
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "list", "hostonlyifs"]
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:            vboxnet0
GUID:            786f6276-656e-4074-8000-0a0027000000
DHCP:            Disabled
IPAddress:       192.168.59.3
NetworkMask:     255.255.255.0
IPV6Address:
IPV6NetworkMaskPrefixLength: 0
HardwareAddress: 0a:00:27:00:00:00
MediumType:      Ethernet
Status:          Down
VBoxNetworkName: HostInterfaceNetworking-vboxnet0

Name:            vboxnet1
GUID:            786f6276-656e-4174-8000-0a0027000001
DHCP:            Disabled
IPAddress:       192.168.33.1
NetworkMask:     255.255.255.0
IPV6Address:
IPV6NetworkMaskPrefixLength: 0
HardwareAddress: 0a:00:27:00:00:01
MediumType:      Ethernet
Status:          Down
VBoxNetworkName: HostInterfaceNetworking-vboxnet1

DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::ConfigValidate:0x00000102ae1ea8>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x00000102ae1e80>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Builder:0x00000100bddef8>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000100bd6978>
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling OUT action: #<VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000100bd6978>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Warden:0x000001012f1730>
 INFO warden: Calling IN action: #<Proc:0x00000102a838a8@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x000001012f1618>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Builder:0x00000101280030>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::IsRunning:0x000001031b7db8>
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling OUT action: #<VagrantPlugins::ProviderVirtualBox::Action::IsRunning:0x000001031b7db8>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: machine_action_up #<Vagrant::Action::Warden:0x000001031456c8>
 INFO warden: Calling IN action: #<Proc:0x000001029987b8@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::CheckAccessible:0x00000103145650>
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Provision:0x00000103145628>
 INFO provision: Ignoring sentinel check, forcing provision
 INFO provision: Checking provisioner sentinel file...
 INFO provision: Sentinel found! Not provisioning.
 INFO chef: Loading cached node_name...
 INFO warden: Calling IN action: #<Proc:0x000001029f0cb0@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Proc:0x000001012f1550@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Proc:0x00000102ae1de0@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling OUT action: #<Proc:0x00000102ae1de0@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling OUT action: #<Proc:0x000001012f1550@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling OUT action: #<Proc:0x000001029f0cb0@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO interface: info: Running provisioner: chef_solo...
 INFO interface: info: ==> default: Running provisioner: chef_solo...
==> default: Running provisioner: chef_solo...
 INFO environment: Running hook: provisioner_run
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: provisioner_run #<Method: Vagrant::Action::Builtin::Provision#run_provisioner>
 INFO warden: Calling IN action: #<Proc:0x000001011a4a58@/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO chef_solo: Checking for Chef installation...
DEBUG ssh: Checking whether SSH is ready...
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1: Searching for SSH port: 22
DEBUG virtualbox_5_1: read_forward_ports: uuid=4bfae953-6f3b-4676-a8d7-53fb1c16c970 active_only=false
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2200, 22]
DEBUG ssh: Checking key permissions: /Users/alextan/Desktop/vagrant-test/.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: 2200
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["/Users/alextan/Desktop/vagrant-test/.vagrant/machines/default/virtualbox/private_key"]
DEBUG ssh:   - connect_opts: {:auth_methods=>["none", "hostbased", "publickey"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>nil, :port=>2200, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :logger=>#<Logger:0x00000102ae8398 @progname=nil, @level=0, @default_formatter=#<Logger::Formatter:0x00000102ae89d8 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x00000102ae9798 @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<StringIO:0x00000102ae8078>, @mutex=#<Logger::LogDevice::LogDeviceMutex:0x00000102ae8550 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x00000102aea4b8>>>>, :keys=>["/Users/alextan/Desktop/vagrant-test/.vagrant/machines/default/virtualbox/private_key"]}
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2017-02-16T13:12:26.156897 #57282] DEBUG -- net.ssh.transport.session[81570e14]: establishing connection to 127.0.0.1:2200
D, [2017-02-16T13:12:26.157983 #57282] DEBUG -- net.ssh.transport.session[81570e14]: connection established
I, [2017-02-16T13:12:26.158095 #57282]  INFO -- net.ssh.transport.server_version[8157025c]: negotiating protocol version
D, [2017-02-16T13:12:26.162475 #57282] DEBUG -- net.ssh.transport.server_version[8157025c]: remote is `SSH-2.0-OpenSSH_6.6.1p1 Ubuntu-2ubuntu2.8'
D, [2017-02-16T13:12:26.162546 #57282] DEBUG -- net.ssh.transport.server_version[8157025c]: local is `SSH-2.0-Ruby/Net::SSH_3.0.2 x86_64-darwin13'
D, [2017-02-16T13:12:26.163330 #57282] DEBUG -- socket[815709dc]: read 1648 bytes
D, [2017-02-16T13:12:26.163464 #57282] DEBUG -- socket[815709dc]: received packet nr 0 type 20 len 1644
I, [2017-02-16T13:12:26.163544 #57282]  INFO -- net.ssh.transport.algorithms[8156d3a4]: got KEXINIT from server
I, [2017-02-16T13:12:26.163738 #57282]  INFO -- net.ssh.transport.algorithms[8156d3a4]: sending KEXINIT
D, [2017-02-16T13:12:26.164078 #57282] DEBUG -- socket[815709dc]: queueing packet nr 0 type 20 len 1684
D, [2017-02-16T13:12:26.164159 #57282] DEBUG -- socket[815709dc]: sent 1688 bytes
I, [2017-02-16T13:12:26.164189 #57282]  INFO -- net.ssh.transport.algorithms[8156d3a4]: negotiating algorithms
D, [2017-02-16T13:12:26.164360 #57282] DEBUG -- net.ssh.transport.algorithms[8156d3a4]: negotiated:
* kex: diffie-hellman-group-exchange-sha1
* host_key: ssh-rsa
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client:
* language_server:
D, [2017-02-16T13:12:26.164390 #57282] DEBUG -- net.ssh.transport.algorithms[8156d3a4]: exchanging keys
D, [2017-02-16T13:12:26.164688 #57282] DEBUG -- socket[815709dc]: queueing packet nr 1 type 34 len 20
D, [2017-02-16T13:12:26.164758 #57282] DEBUG -- socket[815709dc]: sent 24 bytes
D, [2017-02-16T13:12:26.165888 #57282] DEBUG -- socket[815709dc]: read 152 bytes
D, [2017-02-16T13:12:26.165974 #57282] DEBUG -- socket[815709dc]: received packet nr 1 type 31 len 148
D, [2017-02-16T13:12:26.167958 #57282] DEBUG -- socket[815709dc]: queueing packet nr 2 type 32 len 140
D, [2017-02-16T13:12:26.168024 #57282] DEBUG -- socket[815709dc]: sent 144 bytes
D, [2017-02-16T13:12:26.169701 #57282] DEBUG -- socket[815709dc]: read 720 bytes
D, [2017-02-16T13:12:26.169776 #57282] DEBUG -- socket[815709dc]: received packet nr 2 type 33 len 700
D, [2017-02-16T13:12:26.170598 #57282] DEBUG -- socket[815709dc]: queueing packet nr 3 type 21 len 20
D, [2017-02-16T13:12:26.170662 #57282] DEBUG -- socket[815709dc]: sent 24 bytes
D, [2017-02-16T13:12:26.170725 #57282] DEBUG -- socket[815709dc]: received packet nr 3 type 21 len 12
D, [2017-02-16T13:12:26.171041 #57282] DEBUG -- net.ssh.authentication.session[8065e9bc]: beginning authentication of `vagrant'
D, [2017-02-16T13:12:26.171156 #57282] DEBUG -- socket[815709dc]: queueing packet nr 4 type 5 len 28
D, [2017-02-16T13:12:26.171218 #57282] DEBUG -- socket[815709dc]: sent 52 bytes
D, [2017-02-16T13:12:26.171676 #57282] DEBUG -- socket[815709dc]: read 52 bytes
D, [2017-02-16T13:12:26.171752 #57282] DEBUG -- socket[815709dc]: received packet nr 4 type 6 len 28
D, [2017-02-16T13:12:26.171850 #57282] DEBUG -- net.ssh.authentication.session[8065e9bc]: trying none
D, [2017-02-16T13:12:26.171975 #57282] DEBUG -- socket[815709dc]: queueing packet nr 5 type 50 len 44
D, [2017-02-16T13:12:26.172032 #57282] DEBUG -- socket[815709dc]: sent 68 bytes
D, [2017-02-16T13:12:26.201529 #57282] DEBUG -- socket[815709dc]: read 68 bytes
D, [2017-02-16T13:12:26.201690 #57282] DEBUG -- socket[815709dc]: received packet nr 5 type 51 len 44
D, [2017-02-16T13:12:26.201827 #57282] DEBUG -- net.ssh.authentication.session[8065e9bc]: allowed methods: publickey,password
D, [2017-02-16T13:12:26.201942 #57282] DEBUG -- net.ssh.authentication.methods.none[8065b6cc]: none failed
D, [2017-02-16T13:12:26.202039 #57282] DEBUG -- net.ssh.authentication.session[8065e9bc]: trying publickey
D, [2017-02-16T13:12:26.203241 #57282] DEBUG -- net.ssh.authentication.agent[80657c70]: connecting to ssh-agent
D, [2017-02-16T13:12:26.203385 #57282] DEBUG -- net.ssh.authentication.agent[80657c70]: sending agent request 1 len 47
D, [2017-02-16T13:12:26.203516 #57282] DEBUG -- net.ssh.authentication.agent[80657c70]: received agent packet 5 len 1
D, [2017-02-16T13:12:26.203572 #57282] DEBUG -- net.ssh.authentication.agent[80657c70]: sending agent request 11 len 0
D, [2017-02-16T13:12:26.203674 #57282] DEBUG -- net.ssh.authentication.agent[80657c70]: received agent packet 12 len 330
D, [2017-02-16T13:12:26.204073 #57282] DEBUG -- net.ssh.authentication.methods.publickey[80657f40]: trying publickey (d8:86:c2:ea:1e:0b:e4:be:ab:7c:b9:c2:14:4c:10:cd)
D, [2017-02-16T13:12:26.204224 #57282] DEBUG -- socket[815709dc]: queueing packet nr 6 type 50 len 348
D, [2017-02-16T13:12:26.204286 #57282] DEBUG -- socket[815709dc]: sent 372 bytes
D, [2017-02-16T13:12:26.204893 #57282] DEBUG -- socket[815709dc]: read 324 bytes
D, [2017-02-16T13:12:26.205039 #57282] DEBUG -- socket[815709dc]: received packet nr 6 type 60 len 300
D, [2017-02-16T13:12:26.206524 #57282] DEBUG -- socket[815709dc]: queueing packet nr 7 type 50 len 620
D, [2017-02-16T13:12:26.206596 #57282] DEBUG -- socket[815709dc]: sent 644 bytes
D, [2017-02-16T13:12:26.207591 #57282] DEBUG -- socket[815709dc]: read 36 bytes
D, [2017-02-16T13:12:26.207718 #57282] DEBUG -- socket[815709dc]: received packet nr 7 type 52 len 12
D, [2017-02-16T13:12:26.207785 #57282] DEBUG -- net.ssh.authentication.methods.publickey[80657f40]: publickey succeeded (d8:86:c2:ea:1e:0b:e4:be:ab:7c:b9:c2:14:4c:10:cd)

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: Exit status: 0
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
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=4bfae953-6f3b-4676-a8d7-53fb1c16c970 active_only=false
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2200, 22]
DEBUG ssh: Checking key permissions: /Users/alextan/Desktop/vagrant-test/.vagrant/machines/default/virtualbox/private_key
 INFO guest: Autodetecting host type for [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>]
DEBUG guest: Trying: atomic
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: grep 'ostree=' /proc/cmdline (sudo=false)
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: bash: line 4: test: too many arguments

DEBUG ssh: stderr: grep:
DEBUG ssh: stderr: Mint
DEBUG ssh: stderr: : No such file or directory
DEBUG ssh: stderr:

DEBUG ssh: stderr: grep:
DEBUG ssh: stderr: Mint
DEBUG ssh: stderr: : No such file or directory
DEBUG ssh: stderr:

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: 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: 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: grep:
DEBUG ssh: stderr: /etc/redhat-release
DEBUG ssh: stderr: : No such file or directory
DEBUG ssh: stderr:

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: 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: cat:
DEBUG ssh: stderr: /etc/pld-release
DEBUG ssh: stderr: : No such file or directory
DEBUG ssh: stderr:

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: Exit status: 0
 INFO guest: Detected: ubuntu!
DEBUG guest: Searching for cap: chef_installed
DEBUG guest: Checking in: ubuntu
DEBUG guest: Checking in: debian
DEBUG guest: Checking in: linux
DEBUG guest: Found cap: chef_installed in linux
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: Exit status: 0
DEBUG guest: Searching for cap: chef_installed
DEBUG guest: Checking in: ubuntu
DEBUG guest: Checking in: debian
DEBUG guest: Checking in: linux
DEBUG guest: Found cap: chef_installed in linux
 INFO guest: Execute capability: chef_installed [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>, "chef", :latest] (ubuntu)
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: test -x /opt/chef/bin/knife (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
 INFO interface: info: Detected Chef (latest) is already installed
 INFO interface: info: ==> default: Detected Chef (latest) is already installed
==> default: Detected Chef (latest) is already installed
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: mkdir -p /tmp/vagrant-chef (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
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=4bfae953-6f3b-4676-a8d7-53fb1c16c970 active_only=false
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2200, 22]
DEBUG ssh: Checking key permissions: /Users/alextan/Desktop/vagrant-test/.vagrant/machines/default/virtualbox/private_key
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: chown -h vagrant /tmp/vagrant-chef (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: mkdir -p /var/chef/backup (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
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=4bfae953-6f3b-4676-a8d7-53fb1c16c970 active_only=false
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2200, 22]
DEBUG ssh: Checking key permissions: /Users/alextan/Desktop/vagrant-test/.vagrant/machines/default/virtualbox/private_key
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: chown -h vagrant /var/chef/backup (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: mkdir -p /var/chef/cache (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
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=4bfae953-6f3b-4676-a8d7-53fb1c16c970 active_only=false
 INFO subprocess: Starting process: ["/usr/local/bin/VBoxManage", "showvminfo", "4bfae953-6f3b-4676-a8d7-53fb1c16c970", "--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="vagrant-test_default_1487271688786_88655"
groups="/"
ostype="Ubuntu (64-bit)"
UUID="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
CfgFile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.vbox"
SnapFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Snapshots"
LogFldr="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/Logs"
hardwareuuid="4bfae953-6f3b-4676-a8d7-53fb1c16c970"
memory=3072
pagefusion="off"
vram=12
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="none"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
paravirtprovider="legacy"
effparavirtprovider="none"
VMState="running"
VMStateChangeTime="2017-02-16T19:01:30.150000000"
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="SATAController"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="1"
storagecontrollerbootable0="on"
"SATAController-0-0"="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/box-disk1.vmdk"
"SATAController-ImageUUID-0-0"="c6fca45a-0522-4405-ae99-d789c25e9d9b"
natnet1="nat"
macaddress1="080027406789"
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,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
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/alextan/Desktop/vagrant-test"
SharedFolderNameMachineMapping2="v-csc-7ee9e61a8"
SharedFolderPathMachineMapping2="/Users/alextan/Desktop/vagrant-test/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="/Users/alextan/VirtualBox VMs/vagrant-test_default_1487271688786_88655/vagrant-test_default_1487271688786_88655.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.3.36_Ubuntu r105129"
GuestAdditionsFacility_VirtualBox Base Driver=50,1487271696529
GuestAdditionsFacility_VirtualBox System Service=50,1487271700590
GuestAdditionsFacility_Seamless Mode=0,1487271696529
GuestAdditionsFacility_Graphics Mode=0,1487271696529
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2200, 22]
DEBUG ssh: Checking key permissions: /Users/alextan/Desktop/vagrant-test/.vagrant/machines/default/virtualbox/private_key
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: chown -h vagrant /var/chef/cache (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
DEBUG chef_solo: Checking for shared folder: /tmp/vagrant-chef/b177fc06a374e4a9b26bd47cbe519235/cookbooks
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: test -d /tmp/vagrant-chef/b177fc06a374e4a9b26bd47cbe519235/cookbooks (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: sh -c 'command -v chef-solo' (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
 INFO interface: info: Generating chef JSON and uploading...
 INFO interface: info: ==> default: Generating chef JSON and uploading...
==> default: Generating chef JSON and uploading...
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: rm -f /tmp/vagrant-chef/dna.json (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
DEBUG ssh: Uploading: /var/folders/x4/0nr28wjx1591t4hs6qycfm3r0000gn/T/vagrant-chef-provisioner-config20170216-57282-2av63f to /tmp/vagrant-chef/dna.json
DEBUG ssh: Re-using SSH connection.
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: rm -f /tmp/vagrant-chef/solo.rb (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

DEBUG ssh: Exit status: 0
DEBUG ssh: Uploading: /var/folders/x4/0nr28wjx1591t4hs6qycfm3r0000gn/T/vagrant-chef-provisioner-config20170216-57282-fjdqis to /tmp/vagrant-chef/solo.rb
DEBUG ssh: Re-using SSH connection.
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: Exit status: 0
DEBUG guest: Searching for cap: wait_for_reboot
DEBUG guest: Checking in: ubuntu
DEBUG guest: Checking in: debian
DEBUG guest: Checking in: linux
 INFO interface: info: Running chef-solo...
 INFO interface: info: ==> default: Running chef-solo...
==> default: Running chef-solo...
DEBUG ssh: Re-using SSH connection.
 INFO ssh: Execute: chef-solo --config /tmp/vagrant-chef/solo.rb --json-attributes /tmp/vagrant-chef/dna.json --log_level info --force-formatter (sudo=true)
DEBUG ssh: stderr: stdin: is not a tty

 INFO interface: info: stdin: is not a tty
 INFO interface: info: ==> default: stdin: is not a tty
==> default: stdin: is not a tty
DEBUG ssh: stderr: /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default: /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default: /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr: :
 INFO interface: info: :
 INFO interface: info: ==> default: :
==> default: :
DEBUG ssh: stderr: cannot load such file -- yajl/yajl
 INFO interface: info: cannot load such file -- yajl/yajl
 INFO interface: info: ==> default: cannot load such file -- yajl/yajl
==> default: cannot load such file -- yajl/yajl
DEBUG ssh: stderr:  (
 INFO interface: info:  (
 INFO interface: info: ==> default:  (
==> default:  (
DEBUG ssh: stderr: LoadError
 INFO interface: info: LoadError
 INFO interface: info: ==> default: LoadError
==> default: LoadError
DEBUG ssh: stderr: )

 INFO interface: info: )
 INFO interface: info: ==> default: )
==> default: )
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /usr/lib/ruby/vendor_ruby/yajl.rb:1:in `<top (required)>'

 INFO interface: info:  from /usr/lib/ruby/vendor_ruby/yajl.rb:1:in `<top (required)>'
 INFO interface: info: ==> default:   from /usr/lib/ruby/vendor_ruby/yajl.rb:1:in `<top (required)>'
==> default:  from /usr/lib/ruby/vendor_ruby/yajl.rb:1:in `<top (required)>'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /usr/lib/ruby/vendor_ruby/ohai/system.rb:25:in `<top (required)>'

 INFO interface: info:  from /usr/lib/ruby/vendor_ruby/ohai/system.rb:25:in `<top (required)>'
 INFO interface: info: ==> default:   from /usr/lib/ruby/vendor_ruby/ohai/system.rb:25:in `<top (required)>'
==> default:  from /usr/lib/ruby/vendor_ruby/ohai/system.rb:25:in `<top (required)>'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /usr/lib/ruby/vendor_ruby/ohai.rb:21:in `<top (required)>'

 INFO interface: info:  from /usr/lib/ruby/vendor_ruby/ohai.rb:21:in `<top (required)>'
 INFO interface: info: ==> default:   from /usr/lib/ruby/vendor_ruby/ohai.rb:21:in `<top (required)>'
==> default:  from /usr/lib/ruby/vendor_ruby/ohai.rb:21:in `<top (required)>'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/provider/ohai.rb:19:in `<top (required)>'

 INFO interface: info:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/provider/ohai.rb:19:in `<top (required)>'
 INFO interface: info: ==> default:   from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/provider/ohai.rb:19:in `<top (required)>'
==> default:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/provider/ohai.rb:19:in `<top (required)>'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
DEBUG ssh: stderr:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/providers.rb:42:in `<top (required)>'

 INFO interface: info:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/providers.rb:42:in `<top (required)>'
 INFO interface: info: ==> default:   from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/providers.rb:42:in `<top (required)>'
==> default:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/providers.rb:42:in `<top (required)>'
DEBUG ssh: stderr:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef.rb:25:in `<top (required)>'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/application/solo.rb:19:in `<top (required)>'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /var/lib/gems/2.3.0/gems/chef-12.18.31/bin/chef-solo:23:in `<top (required)>'
  from /usr/local/bin/chef-solo:22:in `load'
  from /usr/local/bin/chef-solo:22:in `<main>'

 INFO interface: info:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef.rb:25:in `<top (required)>'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/application/solo.rb:19:in `<top (required)>'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
  from /var/lib/gems/2.3.0/gems/chef-12.18.31/bin/chef-solo:23:in `<top (required)>'
  from /usr/local/bin/chef-solo:22:in `load'
  from /usr/local/bin/chef-solo:22:in `<main>'
 INFO interface: info: ==> default:   from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef.rb:25:in `<top (required)>'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/application/solo.rb:19:in `<top (required)>'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/bin/chef-solo:23:in `<top (required)>'
==> default:  from /usr/local/bin/chef-solo:22:in `load'
==> default:  from /usr/local/bin/chef-solo:22:in `<main>'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef.rb:25:in `<top (required)>'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/lib/chef/application/solo.rb:19:in `<top (required)>'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /usr/lib/ruby/2.3.0/rubygems/core_ext/kernel_require.rb:55:in `require'
==> default:  from /var/lib/gems/2.3.0/gems/chef-12.18.31/bin/chef-solo:23:in `<top (required)>'
==> default:  from /usr/local/bin/chef-solo:22:in `load'
==> default:  from /usr/local/bin/chef-solo:22:in `<main>'
DEBUG ssh: Exit status: 1
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Calling recover: #<Vagrant::Action::Builtin::Call:0x000001012f1618>
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Calling recover: #<Vagrant::Action::Builtin::Call:0x00000102ae1e80>
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Calling recover: #<Vagrant::Action::Builtin::Call:0x00000101246448>
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Calling recover: #<Vagrant::Action::Builtin::Call:0x00000102952768>
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Calling recover: #<Vagrant::Action::Builtin::Call:0x000001029527e0>
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO environment: Released process lock: machine-action-8ee5b5d74cdb7ecea66a42890bed0794
 INFO environment: Running hook: environment_unload
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: environment_unload #<Vagrant::Action::Builder:0x00000101107b68>
ERROR vagrant: Vagrant experienced an error! Details:
ERROR vagrant: #<VagrantPlugins::Chef::Provisioner::Base::ChefError: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.>
ERROR vagrant: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
ERROR vagrant: /opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/chef/provisioner/chef_solo.rb:211:in `run_chef_solo'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/provisioners/chef/provisioner/chef_solo.rb:64:in `provision'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/provision.rb:133:in `run_provisioner'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builder.rb:116:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `block in run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/util/busy.rb:19:in `busy'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/environment.rb:479:in `hook'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/provision.rb:121:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/provision.rb:121:in `block in call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/provision.rb:103:in `each'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/provision.rb:103:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/action/check_accessible.rb:18:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builder.rb:116:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `block in run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/util/busy.rb:19:in `busy'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/call.rb:53:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builder.rb:116:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `block in run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/util/busy.rb:19:in `busy'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/call.rb:53:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/config_validate.rb:25:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/action/check_virtualbox.rb:17:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builder.rb:116:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `block in run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/util/busy.rb:19:in `busy'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/call.rb:53:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/box_check_outdated.rb:78:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/config_validate.rb:25:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/action/check_virtualbox.rb:17:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builder.rb:116:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `block in run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/util/busy.rb:19:in `busy'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/call.rb:53:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/config_validate.rb:25:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builder.rb:116:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `block in run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/util/busy.rb:19:in `busy'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builtin/call.rb:53:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/plugins/providers/virtualbox/action/check_virtualbox.rb:17:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/warden.rb:34:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/builder.rb:116:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `block in run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/util/busy.rb:19:in `busy'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/action/runner.rb:66:in `run'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/machine.rb:225:in `action_raw'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/machine.rb:200:in `block in action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/environment.rb:567:in `lock'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/machine.rb:186:in `call'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/machine.rb:186:in `action'
/opt/vagrant/embedded/gems/gems/vagrant-1.9.1/lib/vagrant/batch_action.rb:82:in `block (2 levels) in run'
 INFO interface: error: Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO interface: Machine: error-exit ["VagrantPlugins::Chef::Provisioner::Base::ChefError", "Chef never successfully completed! Any errors should be visible in the\noutput above. Please fix your recipes so that they properly complete."]