vagrant_rsync_hang

 INFO global: Vagrant version: 1.6.2
 INFO global: Ruby version: 2.0.0
 INFO global: RubyGems version: 2.0.14
 INFO global: VAGRANT_EXECUTABLE="C:\\HashiCorp\\Vagrant\\embedded\\gems\\gems\\vagrant-1.6.2\\bin\\vagrant"
 INFO global: VAGRANT_INSTALLER_EMBEDDED_DIR="C:\\HashiCorp\\Vagrant\\embedded"
 INFO global: VAGRANT_INSTALLER_ENV="1"
 INFO global: VAGRANT_INSTALLER_VERSION="2"
 INFO global: VAGRANT_INTERNAL_BUNDLERIZED="1"
 INFO global: VAGRANT_LOG="debug"
 INFO global: Plugins:
 INFO global:   - bundler = 1.6.2
 INFO global:   - mime-types = 2.2
 INFO global:   - rest-client = 1.6.7
 INFO global:   - vagrant-login = 1.0.1
 INFO global:   - vagrant-share = 1.0.1
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/box/plugin.rb
 INFO manager: Registered plugin: box command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/destroy/plugin.rb
 INFO manager: Registered plugin: destroy command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/global-status/plugin.rb
 INFO manager: Registered plugin: global-status command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/halt/plugin.rb
 INFO manager: Registered plugin: halt command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/help/plugin.rb
 INFO manager: Registered plugin: help command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/init/plugin.rb
 INFO manager: Registered plugin: init command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/list-commands/plugin.rb
 INFO manager: Registered plugin: list-commands command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/package/plugin.rb
 INFO manager: Registered plugin: package command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/plugin/plugin.rb
 INFO manager: Registered plugin: plugin command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/provision/plugin.rb
 INFO manager: Registered plugin: provision command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/rdp/plugin.rb
 INFO manager: Registered plugin: rdp command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/reload/plugin.rb
 INFO manager: Registered plugin: reload command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/resume/plugin.rb
 INFO manager: Registered plugin: resume command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/ssh/plugin.rb
 INFO manager: Registered plugin: ssh command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/ssh_config/plugin.rb
 INFO manager: Registered plugin: ssh-config command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/status/plugin.rb
 INFO manager: Registered plugin: status command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/suspend/plugin.rb
 INFO manager: Registered plugin: suspend command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/up/plugin.rb
 INFO manager: Registered plugin: up command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/version/plugin.rb
 INFO manager: Registered plugin: version command
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/communicators/ssh/plugin.rb
 INFO manager: Registered plugin: ssh communicator
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/communicators/winrm/plugin.rb
 INFO manager: Registered plugin: winrm communicator
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/arch/plugin.rb
 INFO manager: Registered plugin: Arch guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/coreos/plugin.rb
 INFO manager: Registered plugin: CoreOS guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/darwin/plugin.rb
 INFO manager: Registered plugin: Darwin guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/debian/plugin.rb
 INFO manager: Registered plugin: Debian guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/esxi/plugin.rb
 INFO manager: Registered plugin: ESXi guest.
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/fedora/plugin.rb
 INFO manager: Registered plugin: Fedora guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/freebsd/plugin.rb
 INFO manager: Registered plugin: FreeBSD guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/funtoo/plugin.rb
 INFO manager: Registered plugin: Funtoo guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/gentoo/plugin.rb
 INFO manager: Registered plugin: Gentoo guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/linux/plugin.rb
 INFO manager: Registered plugin: Linux guest.
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/mint/plugin.rb
 INFO manager: Registered plugin: Mint guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/netbsd/plugin.rb
 INFO manager: Registered plugin: NetBSD guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/omnios/plugin.rb
 INFO manager: Registered plugin: OmniOS guest.
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/openbsd/plugin.rb
 INFO manager: Registered plugin: OpenBSD guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/pld/plugin.rb
 INFO manager: Registered plugin: PLD Linux guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/redhat/plugin.rb
 INFO manager: Registered plugin: RedHat guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/smartos/plugin.rb
 INFO manager: Registered plugin: SmartOS guest.
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/solaris/plugin.rb
 INFO manager: Registered plugin: Solaris guest.
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/solaris11/plugin.rb
 INFO manager: Registered plugin: Solaris 11 guest.
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/suse/plugin.rb
 INFO manager: Registered plugin: SUSE guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/tinycore/plugin.rb
 INFO manager: Registered plugin: TinyCore Linux guest.
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/ubuntu/plugin.rb
 INFO manager: Registered plugin: Ubuntu guest
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/windows/plugin.rb
 INFO manager: Registered plugin: Windows guest.
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/arch/plugin.rb
 INFO manager: Registered plugin: Arch host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/bsd/plugin.rb
 INFO manager: Registered plugin: BSD host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/darwin/plugin.rb
 INFO manager: Registered plugin: Mac OS X host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/freebsd/plugin.rb
 INFO manager: Registered plugin: FreeBSD host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/gentoo/plugin.rb
 INFO manager: Registered plugin: Gentoo host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/linux/plugin.rb
 INFO manager: Registered plugin: Linux host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/null/plugin.rb
 INFO manager: Registered plugin: null host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/opensuse/plugin.rb
 INFO manager: Registered plugin: OpenSUSE host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/redhat/plugin.rb
 INFO manager: Registered plugin: Red Hat host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/slackware/plugin.rb
 INFO manager: Registered plugin: Slackware host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/windows/plugin.rb
 INFO manager: Registered plugin: Windows host
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/kernel_v1/plugin.rb
 INFO manager: Registered plugin: kernel
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/kernel_v2/plugin.rb
 INFO manager: Registered plugin: kernel
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/docker/plugin.rb
 INFO manager: Registered plugin: docker-provider
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/hyperv/plugin.rb
 INFO manager: Registered plugin: Hyper-V provider
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/virtualbox/plugin.rb
 INFO manager: Registered plugin: VirtualBox provider
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/ansible/plugin.rb
 INFO manager: Registered plugin: ansible
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/cfengine/plugin.rb
 INFO manager: Registered plugin: CFEngine Provisioner
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/chef/plugin.rb
 INFO manager: Registered plugin: chef
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/docker/plugin.rb
 INFO manager: Registered plugin: docker
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/file/plugin.rb
 INFO manager: Registered plugin: file
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/puppet/plugin.rb
 INFO manager: Registered plugin: puppet
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/salt/plugin.rb
 INFO manager: Registered plugin: salt
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/shell/plugin.rb
 INFO manager: Registered plugin: shell
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/synced_folders/nfs/plugin.rb
 INFO manager: Registered plugin: NFS synced folders
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/synced_folders/rsync/plugin.rb
 INFO manager: Registered plugin: RSync synced folders
DEBUG global: Loading core plugin: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/synced_folders/smb/plugin.rb
 INFO manager: Registered plugin: SMB synced folders
 INFO global: Loading plugins!
 INFO manager: Registered plugin: vagrant-login
 INFO manager: Registered plugin: vagrant-share
 INFO vagrant: `vagrant` invoked: ["up", "--provider=docker", "--debug"]
DEBUG vagrant: Creating Vagrant environment
 INFO environment: Environment initialized (#<Vagrant::Environment:0x363ac80>)
 INFO environment:   - cwd: C:/dev/1_vagrant_machines/vagrant-docker-learn
 INFO environment: Home path: C:/Users/snowc/.vagrant.d
 INFO environment: Local data path: C:/dev/1_vagrant_machines/vagrant-docker-learn/.vagrant
DEBUG environment: Creating: C:/dev/1_vagrant_machines/vagrant-docker-learn/.vagrant
 INFO environment: Running hook: environment_plugins_loaded
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x37afd78>
 INFO environment: Running hook: environment_load
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x3868338>
 INFO cli: CLI: [] "up" ["--provider=docker"]
DEBUG cli: Invoking command class: VagrantPlugins::CommandUp::Command ["--provider=docker"]
DEBUG command: 'Up' each target VM...
 INFO loader: Set :root = #<Pathname:C:/dev/1_vagrant_machines/vagrant-docker-learn/Vagrantfile>
DEBUG loader: Populating proc cache for #<Pathname:C:/dev/1_vagrant_machines/vagrant-docker-learn/Vagrantfile>
DEBUG loader: Load procs for pathname: C:/dev/1_vagrant_machines/vagrant-docker-learn/Vagrantfile
 INFO loader: Loading configuration in order: [:home, :root]
DEBUG loader: Loading from: root (evaluating)
DEBUG loader: Configuration loaded successfully, finalizing and returning
DEBUG command: Getting target VMs for command. Arguments:
DEBUG command:  -- names: ["default"]
DEBUG command:  -- options: {:provider=>"docker"}
DEBUG command: Finding machine that match name: default
 INFO environment: Getting machine: default (docker)
 INFO environment: Uncached load of machine.
 INFO loader: Set "23723112_machine_default" = []
 INFO loader: Loading configuration in order: [:home, :root, "23723112_machine_default"]
DEBUG loader: Loading from: root (cache)
DEBUG loader: Configuration loaded successfully, finalizing and returning
 INFO machine: Initializing machine: default
 INFO machine:   - Provider: VagrantPlugins::DockerProvider::Provider
 INFO machine:   - Box: 
 INFO machine:   - Data dir: C:/dev/1_vagrant_machines/vagrant-docker-learn/.vagrant/machines/default/docker
 INFO command: With machine: default (#<VagrantPlugins::DockerProvider::Provider:0x3651168 @logger=#<Log4r::Logger:0x3651090 @fullname="vagrant::provider::docker", @outputters=[], @additive=true, @name="docker", @path="vagrant::provider", @parent=#<Log4r::Logger:0x3804b58 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x3837018 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x3836fd0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x38351b8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x3804a80 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @machine=#<Vagrant::Machine: default (VagrantPlugins::DockerProvider::Provider)>, @cap_logger=#<Log4r::Logger:0x28d0748 @fullname="vagrant::capability_host::vagrantplugins::dockerprovider::provider", @outputters=[], @additive=true, @name="provider", @path="vagrant::capability_host::vagrantplugins::dockerprovider", @parent=#<Log4r::Logger:0x3804b58 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x3837018 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x3836fd0>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x38351b8 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x3804a80 @level=0, @outputters=[]>, @level=1, @trace=false>, @level=1, @trace=false>, @cap_host_chain=[[:docker, #<#<Class:0x28d0ec8>:0x295e990>]], @cap_args=[#<Vagrant::Machine: default (VagrantPlugins::DockerProvider::Provider)>], @cap_caps={:docker=>#<Vagrant::Registry:0x28d0c88 @items={:public_address=>#<Proc:0x382da78@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/docker/plugin.rb:54>}, @results_cache={}>, :hyperv=>#<Vagrant::Registry:0x28d0b50 @items={:public_address=>#<Proc:0x38360b8@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/hyperv/plugin.rb:25>}, @results_cache={}>, :virtualbox=>#<Vagrant::Registry:0x28d0a18 @items={:forwarded_ports=>#<Proc:0x3844878@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/virtualbox/plugin.rb:27>, :nic_mac_addresses=>#<Proc:0x3844818@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/virtualbox/plugin.rb:32>, :public_address=>#<Proc:0x25a5bd8@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-share-1.0.1/lib/vagrant-share.rb:39>}, @results_cache={}>}>)
 INFO interface: info: Bringing machine 'default' up with 'docker' provider...
Bringing machine 'default' up with 'docker' provider...
 INFO batch_action: Enabling parallelization by default.
 INFO batch_action: Disabling parallelization because only executing one action
 INFO batch_action: Batch action will parallelize: false
 INFO batch_action: Starting action: #<Vagrant::Machine:0x3780570> up {:destroy_on_error=>true, :parallel=>true, :provision_ignore_sentinel=>false, :provision_types=>nil, :provider=>"docker"}
 INFO machine: Calling action: up on provider Docker (new container)
DEBUG environment: Attempting to acquire process-lock: machine-action-2a4085d3c4944e8134fe57472994a22c
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-2a4085d3c4944e8134fe57472994a22c
 INFO host: Autodetecting host type for [#<Vagrant::Environment: C:/dev/1_vagrant_machines/vagrant-docker-learn>]
DEBUG host: Trying: arch
DEBUG host: Trying: darwin
DEBUG host: Trying: freebsd
DEBUG host: Trying: gentoo
DEBUG host: Trying: opensuse
DEBUG host: Trying: redhat
DEBUG host: Trying: slackware
DEBUG host: Trying: bsd
DEBUG host: Trying: linux
DEBUG host: Trying: null
DEBUG host: Trying: windows
 INFO host: Detected: windows!
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x2d9d0f8>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::ConfigValidate:0x354e0b8>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x354e058>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x3682d40>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::IsState:0x3680658>
DEBUG is_state: Checking if machine state is 'not_created'
 INFO machine: New machine ID: nil
DEBUG is_state: -- Machine state: not_created
 INFO warden: Calling OUT action: #<Vagrant::Action::Builtin::IsState:0x3680658>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x3749df0>
 INFO warden: Calling IN action: #<Proc:0x37fd340@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::HandleBox:0x3749da8>
 INFO handle_box: Skipping HandleBox because no box is set
 INFO warden: Calling IN action: #<Proc:0x378ed60@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<VagrantPlugins::DockerProvider::Action::HostMachine:0x354dff8>
 INFO interface: output: Docker host is required. One will be created if necessary...
 INFO interface: output: ==> default: Docker host is required. One will be created if necessary...
==> default: Docker host is required. One will be created if necessary...
DEBUG environment: Attempting to acquire process-lock: docker-provider-hostvm
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: docker-provider-hostvm
 INFO environment: Released process lock: docker-provider-hostvm
DEBUG environment: Attempting to acquire process-lock: dotlock
 INFO environment: Acquired process lock: dotlock
 INFO environment: Released process lock: dotlock
 INFO environment: Environment initialized (#<Vagrant::Environment:0x39293e8>)
 INFO environment:   - cwd: C:/Users/snowc/.vagrant.d/data/docker-host
 INFO environment: Home path: C:/Users/snowc/.vagrant.d
 INFO environment: Local data path: C:/Users/snowc/.vagrant.d/data/docker-host/.vagrant
DEBUG environment: Creating: C:/Users/snowc/.vagrant.d/data/docker-host/.vagrant
 INFO environment: Running hook: environment_plugins_loaded
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x3701070>
 INFO environment: Running hook: environment_load
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x3643a58>
DEBUG base: Windows. Trying VBOX_INSTALL_PATH for VBoxManage
 INFO base: VBoxManage path: VBoxManage
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox/VBoxManage.EXE", "--version"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: 4.3.12r93733
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG meta: Finding driver for VirtualBox version: 4.3.12
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3
DEBUG base: Windows. Trying VBOX_INSTALL_PATH for VBoxManage
 INFO base: VBoxManage path: VBoxManage
 INFO environment: Getting machine: default (virtualbox)
 INFO environment: Uncached load of machine.
 INFO loader: Set :root = #<Pathname:C:/Users/snowc/.vagrant.d/data/docker-host/Vagrantfile>
DEBUG loader: Populating proc cache for #<Pathname:C:/Users/snowc/.vagrant.d/data/docker-host/Vagrantfile>
DEBUG loader: Load procs for pathname: C:/Users/snowc/.vagrant.d/data/docker-host/Vagrantfile
 INFO loader: Loading configuration in order: [:home, :root]
DEBUG loader: Loading from: root (evaluating)
DEBUG loader: Configuration loaded successfully, finalizing and returning
DEBUG base: Windows. Trying VBOX_INSTALL_PATH for VBoxManage
 INFO base: VBoxManage path: VBoxManage
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox/VBoxManage.EXE", "--version"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: 4.3.12r93733
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG meta: Finding driver for VirtualBox version: 4.3.12
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3
DEBUG base: Windows. Trying VBOX_INSTALL_PATH for VBoxManage
 INFO base: VBoxManage path: VBoxManage
 INFO loader: Set "29297724_machine_default" = []
 INFO loader: Loading configuration in order: [:home, :root, "29297724_machine_default"]
DEBUG loader: Loading from: root (cache)
DEBUG loader: Configuration loaded successfully, finalizing and returning
 INFO box_collection: Box found: mitchellh/boot2docker (virtualbox)
 INFO environment: Running hook: authenticate_box_url
 INFO host: Autodetecting host type for [#<Vagrant::Environment: C:/Users/snowc/.vagrant.d/data/docker-host>]
DEBUG host: Trying: arch
DEBUG host: Trying: darwin
DEBUG host: Trying: freebsd
DEBUG host: Trying: gentoo
DEBUG host: Trying: opensuse
DEBUG host: Trying: redhat
DEBUG host: Trying: slackware
DEBUG host: Trying: bsd
DEBUG host: Trying: linux
DEBUG host: Trying: null
DEBUG host: Trying: windows
 INFO host: Detected: windows!
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 2 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x2dd42f8>
 INFO warden: Calling IN action: #<VagrantPlugins::Login::ActionAuthenticateBox:0x536a4c8>
 INFO warden: Calling OUT action: #<VagrantPlugins::Login::ActionAuthenticateBox:0x536a4c8>
 INFO loader: Set :"29055948_mitchellh/boot2docker_virtualbox" = #<Pathname:C:/Users/snowc/.vagrant.d/boxes/mitchellh-VAGRANTSLASH-boot2docker/0.8.0/virtualbox/Vagrantfile>
DEBUG loader: Populating proc cache for #<Pathname:C:/Users/snowc/.vagrant.d/boxes/mitchellh-VAGRANTSLASH-boot2docker/0.8.0/virtualbox/Vagrantfile>
DEBUG loader: Load procs for pathname: C:/Users/snowc/.vagrant.d/boxes/mitchellh-VAGRANTSLASH-boot2docker/0.8.0/virtualbox/Vagrantfile
 INFO loader: Loading configuration in order: [:"29055948_mitchellh/boot2docker_virtualbox", :home, :root, "29297724_machine_default"]
DEBUG loader: Loading from: 29055948_mitchellh/boot2docker_virtualbox (evaluating)
DEBUG loader: Loading from: 29055948_mitchellh/boot2docker_virtualbox (evaluating)
DEBUG loader: Loading from: root (cache)
DEBUG loader: Configuration loaded successfully, finalizing and returning
 INFO machine: Initializing machine: default
 INFO machine:   - Provider: VagrantPlugins::ProviderVirtualBox::Provider
 INFO machine:   - Box: #<Vagrant::Box:0x53208d8>
 INFO machine:   - Data dir: C:/Users/snowc/.vagrant.d/data/docker-host/.vagrant/machines/default/virtualbox
DEBUG virtualbox: Instantiating the driver for machine ID: "5fa075e2-26b0-4e1b-8cac-23e299c8ac57"
DEBUG base: Windows. Trying VBOX_INSTALL_PATH for VBoxManage
 INFO base: VBoxManage path: VBoxManage
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox/VBoxManage.EXE", "--version"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: 4.3.12r93733
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG meta: Finding driver for VirtualBox version: 4.3.12
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3
DEBUG base: Windows. Trying VBOX_INSTALL_PATH for VBoxManage
 INFO base: VBoxManage path: VBoxManage
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox/VBoxManage.EXE", "showvminfo", "5fa075e2-26b0-4e1b-8cac-23e299c8ac57"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: Name:            docker-host_default_1400698030155_65125

Groups:          /

Guest OS:        Other Linux (64-bit)

UUID:            5fa075e2-26b0-4e1b-8cac-23e299c8ac57

Config file:     C:\Users\snowc\VirtualBox VMs\docker-host_default_1400698030155_65125\docker-host_default_1400698030155_65125.vbox

Snapshot folder: C:\Users\snowc\VirtualBox VMs\docker-host_default_1400698030155_65125\Snapshots

Log folder:      C:\Users\snowc\VirtualBox VMs\docker-host_default_1400698030155_65125\Logs

Hardware UUID:   5fa075e2-26b0-4e1b-8cac-23e299c8ac57

Memory size:     512MB

Page Fusion:     off

VRAM size:       8MB

CPU exec cap:    100%

HPET:            off

Chipset:         piix3

Firmware:        BIOS

Number of CPUs:  1

PAE:             on

Long Mode:       on

Synthetic CPU:   off

CPUID overrides: None

Boot menu mode:  message and menu

Boot Device (1): HardDisk

Boot Device (2): DVD

Boot Device (3): Not Assigned

Boot Device (4): Not Assigned

ACPI:            on

IOAPIC:          on

Time offset:     0ms

RTC:             UTC

Hardw. virt.ext: on

Nested Paging:   on

Large Pages:     on

VT-x VPID:       on

VT-x unr. exec.: on

State:           running (since 2014-05-24T18:50:26.997000000)

Monitor count:   1

3D Acceleration: off

2D Video Acceleration: off

Teleporter Enabled: off

Teleporter Port: 0

Teleporter Address: 

Teleporter Password: 

Tracing Enabled: off

Allow Tracing to Access VM: off

Tracing Configuration: 

Autostart Enabled: off

Autostart Delay: 0

Default Frontend: 

Storage Controller Name (0):            IDE Controller

Storage Controller Type (0):            PIIX4

Storage Controller Instance Number (0): 0

Storage Controller Max Port Count (0):  2

Storage Controller Port Count (0):      2

Storage Controller Bootable (0):        on

IDE Controller (0, 0): C:\Users\snowc\VirtualBox VMs\packer-virtualbox-iso\packer-virtualbox-iso-disk1.vmdk (UUID: 1c5f93ae-19f2-4e99-90dc-4dff4431e89c)

IDE Controller (0, 1): C:\Users\snowc\.vagrant.d\boxes\mitchellh-VAGRANTSLASH-boot2docker\0.8.0\virtualbox\boot2docker-vagrant.iso (UUID: e41a6c36-ff4f-4bbc-b3c7-3c1c86886a81)

NIC 1:           MAC: 0800272E82AE, Attachment: NAT, Cable connected: on, Trace: off (file: none), Type: 82540EM, Reported speed: 0 Mbps, Boot priority: 0, Promisc Policy: deny, Bandwidth group: none

NIC 1 Settings:  MTU: 0, Socket (send: 64, receive: 64), TCP Window (send:64, receive: 64)

NIC 1 Rule(0):   name = ssh, protocol = tcp, host ip = 127.0.0.1, host port = 2222, guest ip = , guest port = 22

NIC 1 Rule(1):   name = tcp4243, protocol = tcp, host ip = , host port = 4243, guest ip = , guest port = 4243

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

LPT 1:           disabled

LPT 2:           disabled

Audio:           disabled

Clipboard Mode:  disabled

Drag'n'drop Mode: disabled

Session type:    headless

Video mode:      720x400x0 at 0,0

VRDE:            disabled

USB:             disabled

EHCI:            disabled



USB Device Filters:



<none>



Available remote USB devices:



<none>



Currently Attached USB Devices:



<none>



Bandwidth groups:  <none>



Shared folders:  <none>



VRDE Connection:    not active

Clients so far:     0



Video capturing:    not active

Capture screens:    0

Capture file:       C:\Users\snowc\VirtualBox VMs\docker-host_default_1400698030155_65125\docker-host_default_1400698030155_65125.webm

Capture dimensions: 1024x768

Capture rate:       512 kbps

Capture FPS:        25



Guest:



Configured memory balloon size:      0 MB

OS type:                             Linux_64

Additions run level:                 0



Guest Facilities:



No active facilities.




DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG environment: Attempting to acquire process-lock: 83fd64cbb25f27d26c6984a6a5592dff
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: 83fd64cbb25f27d26c6984a6a5592dff
DEBUG ssh: Checking whether SSH is ready...
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox/VBoxManage.EXE", "showvminfo", "5fa075e2-26b0-4e1b-8cac-23e299c8ac57", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="docker-host_default_1400698030155_65125"

groups="/"

ostype="Other Linux (64-bit)"

UUID="5fa075e2-26b0-4e1b-8cac-23e299c8ac57"

CfgFile="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\docker-host_default_1400698030155_65125.vbox"

SnapFldr="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\Snapshots"

LogFldr="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\Logs"

hardwareuuid="5fa075e2-26b0-4e1b-8cac-23e299c8ac57"

memory=512

pagefusion="off"

vram=8

cpuexecutioncap=100

hpet="off"

chipset="piix3"

firmware="BIOS"

cpus=1

pae="on"

longmode="on"

synthcpu="off"

bootmenu="messageandmenu"

boot1="disk"

boot2="dvd"

boot3="none"

boot4="none"

acpi="on"

ioapic="on"

Time offset=0rtcuseutc="on"

hwvirtex="on"

nestedpaging="on"

largepages="on"

vtxvpid="on"

vtxux="on"

VMState="running"

VMStateChangeTime="2014-05-24T18:50:26.997000000"

monitorcount=1

accelerate3d="off"

accelerate2dvideo="off"

teleporterenabled="off"

teleporterport=0

teleporteraddress=""

teleporterpassword=""

tracing-enabled="off"

tracing-allow-vm-access="off"

tracing-config=""

autostart-enabled="off"

autostart-delay=0

defaultfrontend=""

storagecontrollername0="IDE Controller"

storagecontrollertype0="PIIX4"

storagecontrollerinstance0="0"

storagecontrollermaxportcount0="2"

storagecontrollerportcount0="2"

storagecontrollerbootable0="on"

"IDE Controller-0-0"="C:\Users\snowc\VirtualBox VMs\packer-virtualbox-iso\packer-virtualbox-iso-disk1.vmdk"

"IDE Controller-ImageUUID-0-0"="1c5f93ae-19f2-4e99-90dc-4dff4431e89c"

"IDE Controller-0-1"="C:\Users\snowc\.vagrant.d\boxes\mitchellh-VAGRANTSLASH-boot2docker\0.8.0\virtualbox\boot2docker-vagrant.iso"

"IDE Controller-ImageUUID-0-1"="e41a6c36-ff4f-4bbc-b3c7-3c1c86886a81"

"IDE Controller-tempeject"="off"

"IDE Controller-IsEjected"="off"

"IDE Controller-1-0"="none"

"IDE Controller-1-1"="none"

natnet1="nat"

macaddress1="0800272E82AE"

cableconnected1="on"

nic1="nat"

nictype1="82540EM"

nicspeed1="0"

mtu="0"

sockSnd="64"

sockRcv="64"

tcpWndSnd="64"

tcpWndRcv="64"

Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"

Forwarding(1)="tcp4243,tcp,,4243,,4243"

nic2="none"

nic3="none"

nic4="none"

nic5="none"

nic6="none"

nic7="none"

nic8="none"

hidpointing="ps2mouse"

hidkeyboard="ps2kbd"

uart1="off"

uart2="off"

lpt1="off"

lpt2="off"

audio="none"

clipboard="disabled"

draganddrop="disabled"

SessionType="headless"

VideoMode="720,400,0"@0,0

vrde="off"

usb="off"

ehci="off"

VRDEActiveConnection="off"

VRDEClients=0

vcpenabled="off"

vcpscreens=0

vcpfile="C:\Users\snowc\VirtualBox VMs\docker-host_default_1400698030155_65125\docker-host_default_1400698030155_65125.webm"

vcpwidth=1024

vcpheight=768

vcprate=512

vcpfps=25

GuestMemoryBalloon=0

GuestOSType="Linux_64"

GuestAdditionsRunLevel=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_3: Searching for SSH port: 22
DEBUG virtualbox_4_3: read_forward_ports: uuid=5fa075e2-26b0-4e1b-8cac-23e299c8ac57 active_only=false
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox/VBoxManage.EXE", "showvminfo", "5fa075e2-26b0-4e1b-8cac-23e299c8ac57", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="docker-host_default_1400698030155_65125"

groups="/"

ostype="Other Linux (64-bit)"

UUID="5fa075e2-26b0-4e1b-8cac-23e299c8ac57"

CfgFile="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\docker-host_default_1400698030155_65125.vbox"

SnapFldr="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\Snapshots"

LogFldr="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\Logs"

hardwareuuid="5fa075e2-26b0-4e1b-8cac-23e299c8ac57"

memory=512

pagefusion="off"

vram=8

cpuexecutioncap=100

hpet="off"

chipset="piix3"

firmware="BIOS"

cpus=1

pae="on"

longmode="on"

synthcpu="off"

bootmenu="messageandmenu"

boot1="disk"

boot2="dvd"

boot3="none"

boot4="none"

acpi="on"

ioapic="on"

Time offset=0rtcuseutc="on"

hwvirtex="on"

nestedpaging="on"

largepages="on"

vtxvpid="on"

vtxux="on"

VMState="running"

VMStateChangeTime="2014-05-24T18:50:26.997000000"

monitorcount=1

accelerate3d="off"

accelerate2dvideo="off"

teleporterenabled="off"

teleporterport=0

teleporteraddress=""

teleporterpassword=""

tracing-enabled="off"

tracing-allow-vm-access="off"

tracing-config=""

autostart-enabled="off"

autostart-delay=0

defaultfrontend=""

storagecontrollername0="IDE Controller"

storagecontrollertype0="PIIX4"

storagecontrollerinstance0="0"

storagecontrollermaxportcount0="2"

storagecontrollerportcount0="2"

storagecontrollerbootable0="on"

"IDE Controller-0-0"="C:\Users\snowc\VirtualBox VMs\packer-virtualbox-iso\packer-virtualbox-iso-disk1.vmdk"

"IDE Controller-ImageUUID-0-0"="1c5f93ae-19f2-4e99-90dc-4dff4431e89c"

"IDE Controller-0-1"="C:\Users\snowc\.vagrant.d\boxes\mitchellh-VAGRANTSLASH-boot2docker\0.8.0\virtualbox\boot2docker-vagrant.iso"

"IDE Controller-ImageUUID-0-1"="e41a6c36-ff4f-4bbc-b3c7-3c1c86886a81"

"IDE Controller-tempeject"="off"

"IDE Controller-IsEjected"="off"

"IDE Controller-1-0"="none"

"IDE Controller-1-1"="none"

natnet1="nat"

macaddress1="0800272E82AE"

cableconnected1="on"

nic1="nat"

nictype1="82540EM"

nicspeed1="0"

mtu="0"

sockSnd="64"

sockRcv="64"

tcpWndSnd="64"

tcpWndRcv="64"

Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"

Forwarding(1)="tcp4243,tcp,,4243,,4243"

nic2="none"

nic3="none"

nic4="none"

nic5="none"

nic6="none"

nic7="none"

nic8="none"

hidpointing="ps2mouse"

hidkeyboard="ps2kbd"

uart1="off"

uart2="off"

lpt1="off"

lpt2="off"

audio="none"

clipboard="disabled"

draganddrop="disabled"

SessionType="headless"

VideoMode="720,400,0"@0,0

vrde="off"

usb="off"

ehci="off"

VRDEActiveConnection="off"

VRDEClients=0

vcpenabled="off"

vcpscreens=0

vcpfile="C:\Users\snowc\VirtualBox VMs\docker-host_default_1400698030155_65125\docker-host_default_1400698030155_65125.webm"

vcpwidth=1024

vcpheight=768

vcprate=512

vcpfps=25

GuestMemoryBalloon=0

GuestOSType="Linux_64"

GuestAdditionsRunLevel=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_3:   - [1, "ssh", 2222, 22]
DEBUG virtualbox_4_3:   - [1, "tcp4243", 4243, 4243]
 INFO ssh: Attempting SSH connnection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: docker
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["C:/Users/snowc/.vagrant.d/insecure_private_key"]
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2014-05-24T19:59:29.473150 #1928] DEBUG -- net.ssh.transport.session[227f3dc]: establishing connection to 127.0.0.1:2222
D, [2014-05-24T19:59:29.478650 #1928] DEBUG -- net.ssh.transport.session[227f3dc]: connection established
I, [2014-05-24T19:59:29.479150 #1928]  INFO -- net.ssh.transport.server_version[227ec98]: negotiating protocol version
D, [2014-05-24T19:59:29.483650 #1928] DEBUG -- net.ssh.transport.server_version[227ec98]: remote is `SSH-2.0-OpenSSH_6.0'
D, [2014-05-24T19:59:29.483650 #1928] DEBUG -- net.ssh.transport.server_version[227ec98]: local is `SSH-2.0-Ruby/Net::SSH_2.9.1 i386-mingw32'
D, [2014-05-24T19:59:29.497650 #1928] DEBUG -- tcpsocket[227f0ac]: read 984 bytes
D, [2014-05-24T19:59:29.497650 #1928] DEBUG -- tcpsocket[227f0ac]: received packet nr 0 type 20 len 980
I, [2014-05-24T19:59:29.498150 #1928]  INFO -- net.ssh.transport.algorithms[227e5f0]: got KEXINIT from server
I, [2014-05-24T19:59:29.498150 #1928]  INFO -- net.ssh.transport.algorithms[227e5f0]: sending KEXINIT
D, [2014-05-24T19:59:29.498150 #1928] DEBUG -- tcpsocket[227f0ac]: queueing packet nr 0 type 20 len 2020
D, [2014-05-24T19:59:29.498650 #1928] DEBUG -- tcpsocket[227f0ac]: sent 2024 bytes
I, [2014-05-24T19:59:29.498650 #1928]  INFO -- net.ssh.transport.algorithms[227e5f0]: negotiating algorithms
D, [2014-05-24T19:59:29.498650 #1928] DEBUG -- net.ssh.transport.algorithms[227e5f0]: 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, [2014-05-24T19:59:29.498650 #1928] DEBUG -- net.ssh.transport.algorithms[227e5f0]: exchanging keys
D, [2014-05-24T19:59:29.499150 #1928] DEBUG -- tcpsocket[227f0ac]: queueing packet nr 1 type 34 len 20
D, [2014-05-24T19:59:29.499150 #1928] DEBUG -- tcpsocket[227f0ac]: sent 24 bytes
D, [2014-05-24T19:59:29.509150 #1928] DEBUG -- tcpsocket[227f0ac]: read 152 bytes
D, [2014-05-24T19:59:29.509150 #1928] DEBUG -- tcpsocket[227f0ac]: received packet nr 1 type 31 len 148
D, [2014-05-24T19:59:32.964650 #1928] DEBUG -- tcpsocket[227f0ac]: queueing packet nr 2 type 32 len 140
D, [2014-05-24T19:59:32.964650 #1928] DEBUG -- tcpsocket[227f0ac]: sent 144 bytes
D, [2014-05-24T19:59:32.975150 #1928] DEBUG -- tcpsocket[227f0ac]: read 720 bytes
D, [2014-05-24T19:59:32.975150 #1928] DEBUG -- tcpsocket[227f0ac]: received packet nr 2 type 33 len 700
D, [2014-05-24T19:59:32.978150 #1928] DEBUG -- tcpsocket[227f0ac]: queueing packet nr 3 type 21 len 20
D, [2014-05-24T19:59:32.978650 #1928] DEBUG -- tcpsocket[227f0ac]: sent 24 bytes
D, [2014-05-24T19:59:32.978650 #1928] DEBUG -- tcpsocket[227f0ac]: received packet nr 3 type 21 len 12
D, [2014-05-24T19:59:32.979150 #1928] DEBUG -- net.ssh.authentication.session[155505c]: beginning authentication of `docker'
D, [2014-05-24T19:59:32.979150 #1928] DEBUG -- tcpsocket[227f0ac]: queueing packet nr 4 type 5 len 28
D, [2014-05-24T19:59:32.979150 #1928] DEBUG -- tcpsocket[227f0ac]: sent 52 bytes
D, [2014-05-24T19:59:32.989150 #1928] DEBUG -- tcpsocket[227f0ac]: read 52 bytes
D, [2014-05-24T19:59:32.989150 #1928] DEBUG -- tcpsocket[227f0ac]: received packet nr 4 type 6 len 28
D, [2014-05-24T19:59:32.989150 #1928] DEBUG -- net.ssh.authentication.session[155505c]: trying none
D, [2014-05-24T19:59:32.989650 #1928] DEBUG -- tcpsocket[227f0ac]: queueing packet nr 5 type 50 len 44
D, [2014-05-24T19:59:32.989650 #1928] DEBUG -- tcpsocket[227f0ac]: sent 68 bytes
D, [2014-05-24T19:59:33.089650 #1928] DEBUG -- tcpsocket[227f0ac]: read 84 bytes
D, [2014-05-24T19:59:33.090150 #1928] DEBUG -- tcpsocket[227f0ac]: received packet nr 5 type 51 len 60
D, [2014-05-24T19:59:33.090650 #1928] DEBUG -- net.ssh.authentication.session[155505c]: allowed methods: publickey,password,keyboard-interactive
D, [2014-05-24T19:59:33.090650 #1928] DEBUG -- net.ssh.authentication.methods.none[1569600]: none failed
D, [2014-05-24T19:59:33.091150 #1928] DEBUG -- net.ssh.authentication.session[155505c]: trying publickey
D, [2014-05-24T19:59:33.093150 #1928] DEBUG -- net.ssh.authentication.agent[168b2d4]: connecting to ssh-agent
E, [2014-05-24T19:59:33.093650 #1928] ERROR -- net.ssh.authentication.agent[168b2d4]: could not connect to ssh-agent
D, [2014-05-24T19:59:33.094150 #1928] DEBUG -- net.ssh.authentication.methods.publickey[16866d8]: trying publickey (dd:3b:b8:2e:85:04:06:e9:ab:ff:a8:0a:c0:04:6e:d6)
D, [2014-05-24T19:59:33.094650 #1928] DEBUG -- tcpsocket[227f0ac]: queueing packet nr 6 type 50 len 348
D, [2014-05-24T19:59:33.095150 #1928] DEBUG -- tcpsocket[227f0ac]: sent 372 bytes
D, [2014-05-24T19:59:33.105650 #1928] DEBUG -- tcpsocket[227f0ac]: read 324 bytes
D, [2014-05-24T19:59:33.106150 #1928] DEBUG -- tcpsocket[227f0ac]: received packet nr 6 type 60 len 300
D, [2014-05-24T19:59:33.126650 #1928] DEBUG -- tcpsocket[227f0ac]: queueing packet nr 7 type 50 len 620
D, [2014-05-24T19:59:33.126650 #1928] DEBUG -- tcpsocket[227f0ac]: sent 644 bytes
D, [2014-05-24T19:59:33.137150 #1928] DEBUG -- tcpsocket[227f0ac]: read 36 bytes
D, [2014-05-24T19:59:33.137150 #1928] DEBUG -- tcpsocket[227f0ac]: received packet nr 7 type 52 len 12
D, [2014-05-24T19:59:33.137650 #1928] DEBUG -- net.ssh.authentication.methods.publickey[16866d8]: publickey succeeded (dd:3b:b8:2e:85:04:06:e9:ab:ff:a8:0a:c0:04:6e:d6)

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: stdout: boot2docker: 0.8.0

DEBUG ssh: Exit status: 0
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox/VBoxManage.EXE", "showvminfo", "5fa075e2-26b0-4e1b-8cac-23e299c8ac57", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="docker-host_default_1400698030155_65125"

groups="/"

ostype="Other Linux (64-bit)"

UUID="5fa075e2-26b0-4e1b-8cac-23e299c8ac57"

CfgFile="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\docker-host_default_1400698030155_65125.vbox"

SnapFldr="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\Snapshots"

LogFldr="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\Logs"

hardwareuuid="5fa075e2-26b0-4e1b-8cac-23e299c8ac57"

memory=512

pagefusion="off"

vram=8

cpuexecutioncap=100

hpet="off"

chipset="piix3"

firmware="BIOS"

cpus=1

pae="on"

longmode="on"

synthcpu="off"

bootmenu="messageandmenu"

boot1="disk"

boot2="dvd"

boot3="none"

boot4="none"

acpi="on"

ioapic="on"

Time offset=0rtcuseutc="on"

hwvirtex="on"

nestedpaging="on"

largepages="on"

vtxvpid="on"

vtxux="on"

VMState="running"

VMStateChangeTime="2014-05-24T18:50:26.997000000"

monitorcount=1

accelerate3d="off"

accelerate2dvideo="off"

teleporterenabled="off"

teleporterport=0

teleporteraddress=""

teleporterpassword=""

tracing-enabled="off"

tracing-allow-vm-access="off"

tracing-config=""

autostart-enabled="off"

autostart-delay=0

defaultfrontend=""

storagecontrollername0="IDE Controller"

storagecontrollertype0="PIIX4"

storagecontrollerinstance0="0"

storagecontrollermaxportcount0="2"

storagecontrollerportcount0="2"

storagecontrollerbootable0="on"

"IDE Controller-0-0"="C:\Users\snowc\VirtualBox VMs\packer-virtualbox-iso\packer-virtualbox-iso-disk1.vmdk"

"IDE Controller-ImageUUID-0-0"="1c5f93ae-19f2-4e99-90dc-4dff4431e89c"

"IDE Controller-0-1"="C:\Users\snowc\.vagrant.d\boxes\mitchellh-VAGRANTSLASH-boot2docker\0.8.0\virtualbox\boot2docker-vagrant.iso"

"IDE Controller-ImageUUID-0-1"="e41a6c36-ff4f-4bbc-b3c7-3c1c86886a81"

"IDE Controller-tempeject"="off"

"IDE Controller-IsEjected"="off"

"IDE Controller-1-0"="none"

"IDE Controller-1-1"="none"

natnet1="nat"

macaddress1="0800272E82AE"

cableconnected1="on"

nic1="nat"

nictype1="82540EM"

nicspeed1="0"

mtu="0"

sockSnd="64"

sockRcv="64"

tcpWndSnd="64"

tcpWndRcv="64"

Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"

Forwarding(1)="tcp4243,tcp,,4243,,4243"

nic2="none"

nic3="none"

nic4="none"

nic5="none"

nic6="none"

nic7="none"

nic8="none"

hidpointing="ps2mouse"

hidkeyboard="ps2kbd"

uart1="off"

uart2="off"

lpt1="off"

lpt2="off"

audio="none"

clipboard="disabled"

draganddrop="disabled"

SessionType="headless"

VideoMode="720,400,0"@0,0

vrde="off"

usb="off"

ehci="off"

VRDEActiveConnection="off"

VRDEClients=0

vcpenabled="off"

vcpscreens=0

vcpfile="C:\Users\snowc\VirtualBox VMs\docker-host_default_1400698030155_65125\docker-host_default_1400698030155_65125.webm"

vcpwidth=1024

vcpheight=768

vcprate=512

vcpfps=25

GuestMemoryBalloon=0

GuestOSType="Linux_64"

GuestAdditionsRunLevel=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_3: Searching for SSH port: 22
DEBUG virtualbox_4_3: read_forward_ports: uuid=5fa075e2-26b0-4e1b-8cac-23e299c8ac57 active_only=false
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox/VBoxManage.EXE", "showvminfo", "5fa075e2-26b0-4e1b-8cac-23e299c8ac57", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="docker-host_default_1400698030155_65125"

groups="/"

ostype="Other Linux (64-bit)"

UUID="5fa075e2-26b0-4e1b-8cac-23e299c8ac57"

CfgFile="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\docker-host_default_1400698030155_65125.vbox"

SnapFldr="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\Snapshots"

LogFldr="C:\\Users\\snowc\\VirtualBox VMs\\docker-host_default_1400698030155_65125\\Logs"

hardwareuuid="5fa075e2-26b0-4e1b-8cac-23e299c8ac57"

memory=512

pagefusion="off"

vram=8

cpuexecutioncap=100

hpet="off"

chipset="piix3"

firmware="BIOS"

cpus=1

pae="on"

longmode="on"

synthcpu="off"

bootmenu="messageandmenu"

boot1="disk"

boot2="dvd"

boot3="none"

boot4="none"

acpi="on"

ioapic="on"

Time offset=0rtcuseutc="on"

hwvirtex="on"

nestedpaging="on"

largepages="on"

vtxvpid="on"

vtxux="on"

VMState="running"

VMStateChangeTime="2014-05-24T18:50:26.997000000"

monitorcount=1

accelerate3d="off"

accelerate2dvideo="off"

teleporterenabled="off"

teleporterport=0

teleporteraddress=""

teleporterpassword=""

tracing-enabled="off"

tracing-allow-vm-access="off"

tracing-config=""

autostart-enabled="off"

autostart-delay=0

defaultfrontend=""

storagecontrollername0="IDE Controller"

storagecontrollertype0="PIIX4"

storagecontrollerinstance0="0"

storagecontrollermaxportcount0="2"

storagecontrollerportcount0="2"

storagecontrollerbootable0="on"

"IDE Controller-0-0"="C:\Users\snowc\VirtualBox VMs\packer-virtualbox-iso\packer-virtualbox-iso-disk1.vmdk"

"IDE Controller-ImageUUID-0-0"="1c5f93ae-19f2-4e99-90dc-4dff4431e89c"

"IDE Controller-0-1"="C:\Users\snowc\.vagrant.d\boxes\mitchellh-VAGRANTSLASH-boot2docker\0.8.0\virtualbox\boot2docker-vagrant.iso"

"IDE Controller-ImageUUID-0-1"="e41a6c36-ff4f-4bbc-b3c7-3c1c86886a81"

"IDE Controller-tempeject"="off"

"IDE Controller-IsEjected"="off"

"IDE Controller-1-0"="none"

"IDE Controller-1-1"="none"

natnet1="nat"

macaddress1="0800272E82AE"

cableconnected1="on"

nic1="nat"

nictype1="82540EM"

nicspeed1="0"

mtu="0"

sockSnd="64"

sockRcv="64"

tcpWndSnd="64"

tcpWndRcv="64"

Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"

Forwarding(1)="tcp4243,tcp,,4243,,4243"

nic2="none"

nic3="none"

nic4="none"

nic5="none"

nic6="none"

nic7="none"

nic8="none"

hidpointing="ps2mouse"

hidkeyboard="ps2kbd"

uart1="off"

uart2="off"

lpt1="off"

lpt2="off"

audio="none"

clipboard="disabled"

draganddrop="disabled"

SessionType="headless"

VideoMode="720,400,0"@0,0

vrde="off"

usb="off"

ehci="off"

VRDEActiveConnection="off"

VRDEClients=0

vcpenabled="off"

vcpscreens=0

vcpfile="C:\Users\snowc\VirtualBox VMs\docker-host_default_1400698030155_65125\docker-host_default_1400698030155_65125.webm"

vcpwidth=1024

vcpheight=768

vcprate=512

vcpfps=25

GuestMemoryBalloon=0

GuestOSType="Linux_64"

GuestAdditionsRunLevel=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_3:   - [1, "ssh", 2222, 22]
DEBUG virtualbox_4_3:   - [1, "tcp4243", 4243, 4243]
 INFO interface: detail: Docker host VM is already ready.
 INFO interface: detail:     default: Docker host VM is already ready.
    default: Docker host VM is already ready.
 INFO environment: Released process lock: 83fd64cbb25f27d26c6984a6a5592dff
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x35aefe8>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x3856620>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::IsState:0x3928f38>
DEBUG is_state: Checking if machine state is 'not_created'
 INFO machine: New machine ID: nil
DEBUG is_state: -- Machine state: not_created
 INFO warden: Calling OUT action: #<Vagrant::Action::Builtin::IsState:0x3928f38>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x2daf860>
 INFO warden: Calling IN action: #<Proc:0x3735be8@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::HandleBox:0x2daf7d0>
 INFO handle_box: Skipping HandleBox because no box is set
 INFO warden: Calling IN action: #<VagrantPlugins::DockerProvider::Action::DestroyBuildImage:0x353e6c8>
 INFO warden: Calling IN action: #<Proc:0x35e9e30@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x35aff78>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x43229d0>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::IsState:0x432b4c0>
DEBUG is_state: Checking if machine state is 'running'
 INFO machine: New machine ID: nil
DEBUG is_state: -- Machine state: not_created
 INFO warden: Calling OUT action: #<Vagrant::Action::Builtin::IsState:0x432b4c0>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x43ed6c8>
 INFO warden: Calling IN action: #<Proc:0x450c300@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x43ed638>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x454ec60>
 INFO warden: Calling IN action: #<VagrantPlugins::DockerProvider::Action::HasSSH:0x454ef60>
 INFO warden: Calling OUT action: #<VagrantPlugins::DockerProvider::Action::HasSSH:0x454ef60>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x456ed48>
 INFO warden: Calling IN action: #<Proc:0x458ef98@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Message:0x456ed00>
 INFO warden: Calling IN action: #<Proc:0x456ecb8@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x43ed5c0>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x45c59b8>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::IsState:0x45cfe70>
DEBUG is_state: Checking if machine state is 'not_created'
 INFO machine: New machine ID: nil
DEBUG is_state: -- Machine state: not_created
 INFO warden: Calling OUT action: #<Vagrant::Action::Builtin::IsState:0x45cfe70>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x4606f38>
 INFO warden: Calling IN action: #<Proc:0x46276c8@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<Proc:0x4606ed8@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.6.2/lib/vagrant/action/warden.rb:94 (lambda)>
 INFO warden: Calling IN action: #<VagrantPlugins::DockerProvider::Action::HostMachineBuildDir:0x43ed548>
 INFO warden: Calling IN action: #<VagrantPlugins::DockerProvider::Action::HostMachineSyncFolders:0x440e638>
DEBUG environment: Attempting to acquire process-lock: 83fd64cbb25f27d26c6984a6a5592dff
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: 83fd64cbb25f27d26c6984a6a5592dff
 INFO interface: output: Syncing folders to the host VM...
 INFO interface: output: ==> default: Syncing folders to the host VM...
==> default: Syncing folders to the host VM...
 INFO machine: Calling action: sync_folders on provider VirtualBox (5fa075e2-26b0-4e1b-8cac-23e299c8ac57)
DEBUG environment: Attempting to acquire process-lock: machine-action-1028b18f80317c0bc04aba0120f92ede
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-1028b18f80317c0bc04aba0120f92ede
 INFO environment: Released process lock: machine-action-1028b18f80317c0bc04aba0120f92ede
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 1 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x2d3ce40>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::SyncedFolders:0x2d7d988>
 INFO subprocess: Starting process: ["C:\\Windows\\System32\\WindowsPowerShell\\v1.0\\/powershell.EXE", "-NoProfile", "-ExecutionPolicy", "Bypass", "$PSVersionTable.PSVersion.Major"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: 2