Script started on Sun, Jan 04, 2015 11:43:34 PM [?1034h]0;~/vagrant_ubuntu jkl@root-PC ~/vagrant_ubuntu $ vagrant up INFO global: Vagrant version: 1.7.1 INFO global: Ruby version: 2.0.0 INFO global: RubyGems version: 2.0.14 INFO global: VAGRANT_DETECTED_OS="CYGWIN_NT-6.1" INFO global: VAGRANT_EXECUTABLE="C:\\Vagrant\\embedded\\gems\\gems\\vagrant-1.7.1\\bin\\vagrant" INFO global: VAGRANT_HOME="C:\\Users\\jkl\\.vagrant.d" INFO global: VAGRANT_INSTALLER_EMBEDDED_DIR="C:\\Vagrant\\embedded" INFO global: VAGRANT_INSTALLER_ENV="1" INFO global: VAGRANT_INSTALLER_VERSION="2" INFO global: VAGRANT_INTERNAL_BUNDLERIZED="1" INFO global: VAGRANT_LOG="info" INFO global: VAGRANT_NO_COLOR="1" INFO global: Plugins: INFO global: - bundler = 1.7.9 INFO global: - mime-types = 1.25.1 INFO global: - rdoc = 4.0.0 INFO global: - rest-client = 1.6.8 INFO global: - vagrant-share = 1.1.4 INFO manager: Registered plugin: box command INFO manager: Registered plugin: destroy command INFO manager: Registered plugin: global-status command INFO manager: Registered plugin: halt command INFO manager: Registered plugin: help command INFO manager: Registered plugin: init command INFO manager: Registered plugin: list-commands command INFO manager: Registered plugin: vagrant-login INFO manager: Registered plugin: package command INFO manager: Registered plugin: plugin command INFO manager: Registered plugin: provision command INFO manager: Registered plugin: push command INFO manager: Registered plugin: rdp command INFO manager: Registered plugin: reload command INFO manager: Registered plugin: resume command INFO manager: Registered plugin: ssh command INFO manager: Registered plugin: ssh-config command INFO manager: Registered plugin: status command INFO manager: Registered plugin: suspend command INFO manager: Registered plugin: up command INFO manager: Registered plugin: version command INFO manager: Registered plugin: ssh communicator INFO manager: Registered plugin: winrm communicator INFO manager: Registered plugin: Arch guest INFO manager: Registered plugin: CoreOS guest INFO manager: Registered plugin: Darwin guest INFO manager: Registered plugin: Debian guest INFO manager: Registered plugin: ESXi guest. INFO manager: Registered plugin: Fedora guest INFO manager: Registered plugin: FreeBSD guest INFO manager: Registered plugin: Funtoo guest INFO manager: Registered plugin: Gentoo guest INFO manager: Registered plugin: Linux guest. INFO manager: Registered plugin: Mint guest INFO manager: Registered plugin: NetBSD guest INFO manager: Registered plugin: NixOS guest INFO manager: Registered plugin: OmniOS guest. INFO manager: Registered plugin: OpenBSD guest INFO manager: Registered plugin: PLD Linux guest INFO manager: Registered plugin: RedHat guest INFO manager: Registered plugin: SmartOS guest. INFO manager: Registered plugin: Solaris guest. INFO manager: Registered plugin: Solaris 11 guest. INFO manager: Registered plugin: SUSE guest INFO manager: Registered plugin: TinyCore Linux guest. INFO manager: Registered plugin: Ubuntu guest INFO manager: Registered plugin: Windows guest. INFO manager: Registered plugin: Arch host INFO manager: Registered plugin: BSD host INFO manager: Registered plugin: Mac OS X host INFO manager: Registered plugin: FreeBSD host INFO manager: Registered plugin: Gentoo host INFO manager: Registered plugin: Linux host INFO manager: Registered plugin: null host INFO manager: Registered plugin: Red Hat host INFO manager: Registered plugin: Slackware host INFO manager: Registered plugin: SUSE host INFO manager: Registered plugin: Windows host INFO manager: Registered plugin: kernel INFO manager: Registered plugin: kernel INFO manager: Registered plugin: docker-provider INFO manager: Registered plugin: Hyper-V provider INFO manager: Registered plugin: VirtualBox provider INFO manager: Registered plugin: ansible INFO manager: Registered plugin: CFEngine Provisioner INFO manager: Registered plugin: chef INFO manager: Registered plugin: docker INFO manager: Registered plugin: file INFO manager: Registered plugin: puppet INFO manager: Registered plugin: salt INFO manager: Registered plugin: shell INFO manager: Registered plugin: atlas INFO manager: Registered plugin: ftp INFO manager: Registered plugin: heroku INFO manager: Registered plugin: local-exec INFO manager: Registered plugin: noop INFO manager: Registered plugin: NFS synced folders INFO manager: Registered plugin: RSync synced folders INFO manager: Registered plugin: SMB synced folders INFO global: Loading plugins! INFO manager: Registered plugin: vagrant-share INFO vagrant: `vagrant` invoked: ["up"] INFO environment: Environment initialized (#) INFO environment: - cwd: C:/cygwin64/home/jkl/vagrant_ubuntu INFO environment: Home path: C:/Users/jkl/.vagrant.d INFO environment: Local data path: C:/cygwin64/home/jkl/vagrant_ubuntu/.vagrant INFO environment: Running hook: environment_plugins_loaded INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO environment: Running hook: environment_load INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO cli: CLI: [] "up" [] INFO loader: Set :root = # INFO loader: Loading configuration in order: [:home, :root] INFO loader: Set "30455616_machine_default" = [] INFO loader: Loading configuration in order: [:home, :root, "30455616_machine_default"] INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO environment: Getting machine: default (virtualbox) INFO environment: Uncached load of machine. INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO loader: Set "30455616_machine_default" = [] INFO loader: Loading configuration in order: [:home, :root, "30455616_machine_default"] INFO box_collection: Box not found: hashicorp/precise32 (virtualbox) INFO machine: Initializing machine: default INFO machine: - Provider: VagrantPlugins::ProviderVirtualBox::Provider INFO machine: - Box: INFO machine: - Data dir: C:/cygwin64/home/jkl/vagrant_ubuntu/.vagrant/machines/default/virtualbox INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO machine: New machine ID: nil INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO command: With machine: default (#, @name="stderr", @level=0, @formatter=#, @out=#>>], @additive=true, @name="vagrant", @path="", @parent=#, @level=2, @trace=false>, @level=2, @trace=false>, @machine=#, @driver=#, @name="stderr", @level=0, @formatter=#, @out=#>>], @additive=true, @name="vagrant", @path="", @parent=#, @level=2, @trace=false>, @level=2, @trace=false>, @level=2, @trace=false>, @interrupted=false, @vboxmanage_path="C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", @uuid=nil, @version="4.3.20", @driver=#, @name="stderr", @level=0, @formatter=#, @out=#>>], @additive=true, @name="vagrant", @path="", @parent=#, @level=2, @trace=false>, @level=2, @trace=false>, @interrupted=false, @vboxmanage_path="C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", @uuid=nil>>, @cap_logger=#, @name="stderr", @level=0, @formatter=#, @out=#>>], @additive=true, @name="vagrant", @path="", @parent=#, @level=2, @trace=false>, @level=2, @trace=false>, @cap_host_chain=[[:virtualbox, #<#:0x39dd748>]], @cap_args=[#], @cap_caps={:docker=>##, :proxy_machine=>#}, @results_cache={}>, :hyperv=>##}, @results_cache={}>, :virtualbox=>##, :nic_mac_addresses=>#, :public_address=>#}, @results_cache={}>}>) INFO interface: info: Bringing machine 'default' up with 'virtualbox' provider... Bringing machine 'default' up with 'virtualbox' provider... 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: # up {:destroy_on_error=>true, :parallel=>true, :provision_ignore_sentinel=>false, :provision_types=>nil} INFO machine: Calling action: up on provider VirtualBox (new VM) INFO environment: Acquired process lock: dotlock INFO environment: Released process lock: dotlock INFO environment: Acquired process lock: machine-action-a8914bcdd76acdd81bd190f02222b0da INFO host: Autodetecting host type for [#] INFO host: Detected: windows! INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "list", "hostonlyifs"] INFO warden: Calling IN action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling OUT action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO interface: output: Box 'hashicorp/precise32' could not be found. Attempting to find and install... INFO interface: output: ==> default: Box 'hashicorp/precise32' could not be found. Attempting to find and install... ==> default: Box 'hashicorp/precise32' could not be found. Attempting to find and install... INFO interface: detail: Box Provider: virtualbox INFO interface: detail: default: Box Provider: virtualbox default: Box Provider: virtualbox INFO interface: detail: Box Version: >= 0 INFO interface: detail: default: Box Version: >= 0 default: Box Version: >= 0 INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/cygwin64/home/jkl/vagrant_ubuntu/hashicorp/precise32"] INFO environment: Running hook: authenticate_box_url INFO runner: Preparing hooks for middleware sequence... INFO runner: 2 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling OUT action: # INFO box_add: Downloading box: https://atlas.hashicorp.com/hashicorp/precise32 => C:/Users/jkl/.vagrant.d/tmp/boxdeb900558e30e555d08742f6e47fbcf902a8a099 INFO downloader: HEAD: https://atlas.hashicorp.com/hashicorp/precise32 INFO subprocess: Starting process: ["C:\\Vagrant\\embedded\\bin/curl.EXE", "-I", "-q", "--fail", "--location", "--max-redirs", "10", "--user-agent", "Vagrant/1.7.1", "--continue-at", "-", "-H", "Accept: application/json", "https://atlas.hashicorp.com/hashicorp/precise32"] INFO interface: output: Loading metadata for box 'hashicorp/precise32' INFO interface: output: ==> default: Loading metadata for box 'hashicorp/precise32' ==> default: Loading metadata for box 'hashicorp/precise32' INFO interface: detail: URL: https://atlas.hashicorp.com/hashicorp/precise32 INFO interface: detail: default: URL: https://atlas.hashicorp.com/hashicorp/precise32 default: URL: https://atlas.hashicorp.com/hashicorp/precise32 INFO box_add: Downloading box: https://atlas.hashicorp.com/hashicorp/precise32 => C:/Users/jkl/.vagrant.d/tmp/boxdeb900558e30e555d08742f6e47fbcf902a8a099 INFO downloader: Downloader starting download: INFO downloader: -- Source: https://atlas.hashicorp.com/hashicorp/precise32 INFO downloader: -- Destination: C:/Users/jkl/.vagrant.d/tmp/boxdeb900558e30e555d08742f6e47fbcf902a8a099 INFO subprocess: Starting process: ["C:\\Vagrant\\embedded\\bin/curl.EXE", "-q", "--fail", "--location", "--max-redirs", "10", "--user-agent", "Vagrant/1.7.1", "--continue-at", "-", "-H", "Accept: application/json", "--output", "C:/Users/jkl/.vagrant.d/tmp/boxdeb900558e30e555d08742f6e47fbcf902a8a099", "https://atlas.hashicorp.com/hashicorp/precise32"] INFO interface: output: Adding box 'hashicorp/precise32' (v1.0.0) for provider: virtualbox INFO interface: output: ==> default: Adding box 'hashicorp/precise32' (v1.0.0) for provider: virtualbox ==> default: Adding box 'hashicorp/precise32' (v1.0.0) for provider: virtualbox INFO box_collection: Box not found: hashicorp/precise32 (virtualbox) INFO box_add: Downloading box: https://atlas.hashicorp.com/hashicorp/boxes/precise32/versions/1.0.0/providers/virtualbox.box => C:/Users/jkl/.vagrant.d/tmp/box72e2e33d2e7634570ddd616e403e10782711cdf0 INFO interface: detail: Downloading: https://atlas.hashicorp.com/hashicorp/boxes/precise32/versions/1.0.0/providers/virtualbox.box INFO interface: detail: default: Downloading: https://atlas.hashicorp.com/hashicorp/boxes/precise32/versions/1.0.0/providers/virtualbox.box default: Downloading: https://atlas.hashicorp.com/hashicorp/boxes/precise32/versions/1.0.0/providers/virtualbox.box INFO downloader: Downloader starting download: INFO downloader: -- Source: https://atlas.hashicorp.com/hashicorp/boxes/precise32/versions/1.0.0/providers/virtualbox.box INFO downloader: -- Destination: C:/Users/jkl/.vagrant.d/tmp/box72e2e33d2e7634570ddd616e403e10782711cdf0 INFO subprocess: Starting process: ["C:\\Vagrant\\embedded\\bin/curl.EXE", "-q", "--fail", "--location", "--max-redirs", "10", "--user-agent", "Vagrant/1.7.1", "--continue-at", "-", "--output", "C:/Users/jkl/.vagrant.d/tmp/box72e2e33d2e7634570ddd616e403e10782711cdf0", "https://atlas.hashicorp.com/hashicorp/boxes/precise32/versions/1.0.0/providers/virtualbox.box"] INFO interface: info:   INFO interface: detail: Progress: 0% (Rate: 0/s, Estimated time remaining: --:--:--) INFO interface: detail: default: Progress: 0% (Rate: 0/s, Estimated time remaining: --:--:--) default: Progress: 0% (Rate: 0/s, Estimated time remaining: --:--:--) INFO interface: info:   INFO interface: detail: Progress: 100% (Rate: 294/s, Estimated time remaining: --:--:--) INFO interface: detail: default: Progress: 100% (Rate: 294/s, Estimated time remaining: --:--:--) default: Progress: 100% (Rate: 294/s, Estimated time remaining: --:--:--) INFO interface: info:   INFO interface: detail: Progress: 100% (Rate: 155/s, Estimated time remaining: --:--:--) INFO interface: detail: default: Progress: 100% (Rate: 155/s, Estimated time remaining: --:--:--) default: Progress: 100% (Rate: 155/s, Estimated time remaining: --:--:--) INFO interface: info:   INFO interface: detail: Progress: 0% (Rate: 552k/s, Estimated time remaining: 0:08:42) INFO interface: detail: default: Progress: 0% (Rate: 552k/s, Estimated time remaining: 0:08:42) default: Progress: 0% (Rate: 552k/s, Estimated time remaining: 0:08:42) INFO interface: info:   INFO interface: detail: Progress: 1% (Rate: 2684k/s, Estimated time remaining: 0:02:56) INFO interface: detail: default: Progress: 1% (Rate: 2684k/s, Estimated time remaining: 0:02:56) default: Progress: 1% (Rate: 2684k/s, Estimated time remaining: 0:02:56) INFO interface: info:   INFO interface: detail: Progress: 1% (Rate: 2330k/s, Estimated time remaining: 0:02:43) INFO interface: detail: default: Progress: 1% (Rate: 2330k/s, Estimated time remaining: 0:02:43) default: Progress: 1% (Rate: 2330k/s, Estimated time remaining: 0:02:43) INFO interface: info:   INFO interface: detail: Progress: 3% (Rate: 2756k/s, Estimated time remaining: 0:02:07) INFO interface: detail: default: Progress: 3% (Rate: 2756k/s, Estimated time remaining: 0:02:07) default: Progress: 3% (Rate: 2756k/s, Estimated time remaining: 0:02:07) INFO interface: info:   INFO interface: detail: Progress: 3% (Rate: 2529k/s, Estimated time remaining: 0:02:10) INFO interface: detail: default: Progress: 3% (Rate: 2529k/s, Estimated time remaining: 0:02:10) default: Progress: 3% (Rate: 2529k/s, Estimated time remaining: 0:02:10) INFO interface: info:   INFO interface: detail: Progress: 4% (Rate: 2392k/s, Estimated time remaining: 0:02:12) INFO interface: detail: default: Progress: 4% (Rate: 2392k/s, Estimated time remaining: 0:02:12) default: Progress: 4% (Rate: 2392k/s, Estimated time remaining: 0:02:12) INFO interface: info:   INFO interface: detail: Progress: 4% (Rate: 2225k/s, Estimated time remaining: 0:02:14) INFO interface: detail: default: Progress: 4% (Rate: 2225k/s, Estimated time remaining: 0:02:14) default: Progress: 4% (Rate: 2225k/s, Estimated time remaining: 0:02:14) INFO interface: info:   INFO interface: detail: Progress: 5% (Rate: 2198k/s, Estimated time remaining: 0:02:15) INFO interface: detail: default: Progress: 5% (Rate: 2198k/s, Estimated time remaining: 0:02:15) default: Progress: 5% (Rate: 2198k/s, Estimated time remaining: 0:02:15) INFO interface: info:   INFO interface: detail: Progress: 6% (Rate: 1846k/s, Estimated time remaining: 0:02:15) INFO interface: detail: default: Progress: 6% (Rate: 1846k/s, Estimated time remaining: 0:02:15) default: Progress: 6% (Rate: 1846k/s, Estimated time remaining: 0:02:15) INFO interface: info:   INFO interface: detail: Progress: 6% (Rate: 1845k/s, Estimated time remaining: 0:02:15) INFO interface: detail: default: Progress: 6% (Rate: 1845k/s, Estimated time remaining: 0:02:15) default: Progress: 6% (Rate: 1845k/s, Estimated time remaining: 0:02:15) INFO interface: info:   INFO interface: detail: Progress: 7% (Rate: 1845k/s, Estimated time remaining: 0:02:15) INFO interface: detail: default: Progress: 7% (Rate: 1845k/s, Estimated time remaining: 0:02:15) default: Progress: 7% (Rate: 1845k/s, Estimated time remaining: 0:02:15) INFO interface: info:   INFO interface: detail: Progress: 8% (Rate: 1845k/s, Estimated time remaining: 0:02:15) INFO interface: detail: default: Progress: 8% (Rate: 1845k/s, Estimated time remaining: 0:02:15) default: Progress: 8% (Rate: 1845k/s, Estimated time remaining: 0:02:15) INFO interface: info:   INFO interface: detail: Progress: 8% (Rate: 1845k/s, Estimated time remaining: 0:02:15) INFO interface: detail: default: Progress: 8% (Rate: 1845k/s, Estimated time remaining: 0:02:15) default: Progress: 8% (Rate: 1845k/s, Estimated time remaining: 0:02:15) INFO interface: info:   INFO interface: detail: Progress: 9% (Rate: 1845k/s, Estimated time remaining: 0:02:14) INFO interface: detail: default: Progress: 9% (Rate: 1845k/s, Estimated time remaining: 0:02:14) default: Progress: 9% (Rate: 1845k/s, Estimated time remaining: 0:02:14) INFO interface: info:   INFO interface: detail: Progress: 10% (Rate: 1845k/s, Estimated time remaining: 0:02:14) INFO interface: detail: default: Progress: 10% (Rate: 1845k/s, Estimated time remaining: 0:02:14) default: Progress: 10% (Rate: 1845k/s, Estimated time remaining: 0:02:14) INFO interface: info:   INFO interface: detail: Progress: 10% (Rate: 1845k/s, Estimated time remaining: 0:02:13) INFO interface: detail: default: Progress: 10% (Rate: 1845k/s, Estimated time remaining: 0:02:13) default: Progress: 10% (Rate: 1845k/s, Estimated time remaining: 0:02:13) INFO interface: info:   INFO interface: detail: Progress: 11% (Rate: 1845k/s, Estimated time remaining: 0:02:13) INFO interface: detail: default: Progress: 11% (Rate: 1845k/s, Estimated time remaining: 0:02:13) default: Progress: 11% (Rate: 1845k/s, Estimated time remaining: 0:02:13) INFO interface: info:   INFO interface: detail: Progress: 12% (Rate: 1846k/s, Estimated time remaining: 0:02:12) INFO interface: detail: default: Progress: 12% (Rate: 1846k/s, Estimated time remaining: 0:02:12) default: Progress: 12% (Rate: 1846k/s, Estimated time remaining: 0:02:12) INFO interface: info:   INFO interface: detail: Progress: 12% (Rate: 1846k/s, Estimated time remaining: 0:02:11) INFO interface: detail: default: Progress: 12% (Rate: 1846k/s, Estimated time remaining: 0:02:11) default: Progress: 12% (Rate: 1846k/s, Estimated time remaining: 0:02:11) INFO interface: info:   INFO interface: detail: Progress: 13% (Rate: 1846k/s, Estimated time remaining: 0:02:11) INFO interface: detail: default: Progress: 13% (Rate: 1846k/s, Estimated time remaining: 0:02:11) default: Progress: 13% (Rate: 1846k/s, Estimated time remaining: 0:02:11) INFO interface: info:   INFO interface: detail: Progress: 13% (Rate: 1846k/s, Estimated time remaining: 0:02:10) INFO interface: detail: default: Progress: 13% (Rate: 1846k/s, Estimated time remaining: 0:02:10) default: Progress: 13% (Rate: 1846k/s, Estimated time remaining: 0:02:10) INFO interface: info:   INFO interface: detail: Progress: 14% (Rate: 1845k/s, Estimated time remaining: 0:02:09) INFO interface: detail: default: Progress: 14% (Rate: 1845k/s, Estimated time remaining: 0:02:09) default: Progress: 14% (Rate: 1845k/s, Estimated time remaining: 0:02:09) INFO interface: info:   INFO interface: detail: Progress: 15% (Rate: 1846k/s, Estimated time remaining: 0:02:09) INFO interface: detail: default: Progress: 15% (Rate: 1846k/s, Estimated time remaining: 0:02:09) default: Progress: 15% (Rate: 1846k/s, Estimated time remaining: 0:02:09) INFO interface: info:   INFO interface: detail: Progress: 15% (Rate: 1845k/s, Estimated time remaining: 0:02:08) INFO interface: detail: default: Progress: 15% (Rate: 1845k/s, Estimated time remaining: 0:02:08) default: Progress: 15% (Rate: 1845k/s, Estimated time remaining: 0:02:08) INFO interface: info:   INFO interface: detail: Progress: 16% (Rate: 1846k/s, Estimated time remaining: 0:02:07) INFO interface: detail: default: Progress: 16% (Rate: 1846k/s, Estimated time remaining: 0:02:07) default: Progress: 16% (Rate: 1846k/s, Estimated time remaining: 0:02:07) INFO interface: info:   INFO interface: detail: Progress: 17% (Rate: 1846k/s, Estimated time remaining: 0:02:06) INFO interface: detail: default: Progress: 17% (Rate: 1846k/s, Estimated time remaining: 0:02:06) default: Progress: 17% (Rate: 1846k/s, Estimated time remaining: 0:02:06) INFO interface: info:   INFO interface: detail: Progress: 17% (Rate: 1846k/s, Estimated time remaining: 0:02:05) INFO interface: detail: default: Progress: 17% (Rate: 1846k/s, Estimated time remaining: 0:02:05) default: Progress: 17% (Rate: 1846k/s, Estimated time remaining: 0:02:05) INFO interface: info:   INFO interface: detail: Progress: 18% (Rate: 1846k/s, Estimated time remaining: 0:02:04) INFO interface: detail: default: Progress: 18% (Rate: 1846k/s, Estimated time remaining: 0:02:04) default: Progress: 18% (Rate: 1846k/s, Estimated time remaining: 0:02:04) INFO interface: info:   INFO interface: detail: Progress: 19% (Rate: 1846k/s, Estimated time remaining: 0:02:04) INFO interface: detail: default: Progress: 19% (Rate: 1846k/s, Estimated time remaining: 0:02:04) default: Progress: 19% (Rate: 1846k/s, Estimated time remaining: 0:02:04) INFO interface: info:   INFO interface: detail: Progress: 19% (Rate: 1846k/s, Estimated time remaining: 0:02:03) INFO interface: detail: default: Progress: 19% (Rate: 1846k/s, Estimated time remaining: 0:02:03) default: Progress: 19% (Rate: 1846k/s, Estimated time remaining: 0:02:03) INFO interface: info:   INFO interface: detail: Progress: 20% (Rate: 1840k/s, Estimated time remaining: 0:02:02) INFO interface: detail: default: Progress: 20% (Rate: 1840k/s, Estimated time remaining: 0:02:02) default: Progress: 20% (Rate: 1840k/s, Estimated time remaining: 0:02:02) INFO interface: info:   INFO interface: detail: Progress: 20% (Rate: 1840k/s, Estimated time remaining: 0:02:01) INFO interface: detail: default: Progress: 20% (Rate: 1840k/s, Estimated time remaining: 0:02:01) default: Progress: 20% (Rate: 1840k/s, Estimated time remaining: 0:02:01) INFO interface: info:   INFO interface: detail: Progress: 21% (Rate: 1840k/s, Estimated time remaining: 0:02:00) INFO interface: detail: default: Progress: 21% (Rate: 1840k/s, Estimated time remaining: 0:02:00) default: Progress: 21% (Rate: 1840k/s, Estimated time remaining: 0:02:00) INFO interface: info:   INFO interface: detail: Progress: 22% (Rate: 1840k/s, Estimated time remaining: 0:01:59) INFO interface: detail: default: Progress: 22% (Rate: 1840k/s, Estimated time remaining: 0:01:59) default: Progress: 22% (Rate: 1840k/s, Estimated time remaining: 0:01:59) INFO interface: info:   INFO interface: detail: Progress: 22% (Rate: 1840k/s, Estimated time remaining: 0:01:58) INFO interface: detail: default: Progress: 22% (Rate: 1840k/s, Estimated time remaining: 0:01:58) default: Progress: 22% (Rate: 1840k/s, Estimated time remaining: 0:01:58) INFO interface: info:   INFO interface: detail: Progress: 23% (Rate: 1846k/s, Estimated time remaining: 0:01:57) INFO interface: detail: default: Progress: 23% (Rate: 1846k/s, Estimated time remaining: 0:01:57) default: Progress: 23% (Rate: 1846k/s, Estimated time remaining: 0:01:57) INFO interface: info:   INFO interface: detail: Progress: 24% (Rate: 1845k/s, Estimated time remaining: 0:01:56) INFO interface: detail: default: Progress: 24% (Rate: 1845k/s, Estimated time remaining: 0:01:56) default: Progress: 24% (Rate: 1845k/s, Estimated time remaining: 0:01:56) INFO interface: info:   INFO interface: detail: Progress: 24% (Rate: 1846k/s, Estimated time remaining: 0:01:56) INFO interface: detail: default: Progress: 24% (Rate: 1846k/s, Estimated time remaining: 0:01:56) default: Progress: 24% (Rate: 1846k/s, Estimated time remaining: 0:01:56) INFO interface: info:   INFO interface: detail: Progress: 25% (Rate: 1846k/s, Estimated time remaining: 0:01:55) INFO interface: detail: default: Progress: 25% (Rate: 1846k/s, Estimated time remaining: 0:01:55) default: Progress: 25% (Rate: 1846k/s, Estimated time remaining: 0:01:55) INFO interface: info:   INFO interface: detail: Progress: 26% (Rate: 1846k/s, Estimated time remaining: 0:01:54) INFO interface: detail: default: Progress: 26% (Rate: 1846k/s, Estimated time remaining: 0:01:54) default: Progress: 26% (Rate: 1846k/s, Estimated time remaining: 0:01:54) INFO interface: info:   INFO interface: detail: Progress: 26% (Rate: 1846k/s, Estimated time remaining: 0:01:53) INFO interface: detail: default: Progress: 26% (Rate: 1846k/s, Estimated time remaining: 0:01:53) default: Progress: 26% (Rate: 1846k/s, Estimated time remaining: 0:01:53) INFO interface: info:   INFO interface: detail: Progress: 27% (Rate: 1846k/s, Estimated time remaining: 0:01:52) INFO interface: detail: default: Progress: 27% (Rate: 1846k/s, Estimated time remaining: 0:01:52) default: Progress: 27% (Rate: 1846k/s, Estimated time remaining: 0:01:52) INFO interface: info:   INFO interface: detail: Progress: 28% (Rate: 1846k/s, Estimated time remaining: 0:01:51) INFO interface: detail: default: Progress: 28% (Rate: 1846k/s, Estimated time remaining: 0:01:51) default: Progress: 28% (Rate: 1846k/s, Estimated time remaining: 0:01:51) INFO interface: info:   INFO interface: detail: Progress: 28% (Rate: 1846k/s, Estimated time remaining: 0:01:50) INFO interface: detail: default: Progress: 28% (Rate: 1846k/s, Estimated time remaining: 0:01:50) default: Progress: 28% (Rate: 1846k/s, Estimated time remaining: 0:01:50) INFO interface: info:   INFO interface: detail: Progress: 29% (Rate: 1846k/s, Estimated time remaining: 0:01:49) INFO interface: detail: default: Progress: 29% (Rate: 1846k/s, Estimated time remaining: 0:01:49) default: Progress: 29% (Rate: 1846k/s, Estimated time remaining: 0:01:49) INFO interface: info:   INFO interface: detail: Progress: 29% (Rate: 1846k/s, Estimated time remaining: 0:01:48) INFO interface: detail: default: Progress: 29% (Rate: 1846k/s, Estimated time remaining: 0:01:48) default: Progress: 29% (Rate: 1846k/s, Estimated time remaining: 0:01:48) INFO interface: info:   INFO interface: detail: Progress: 30% (Rate: 1846k/s, Estimated time remaining: 0:01:47) INFO interface: detail: default: Progress: 30% (Rate: 1846k/s, Estimated time remaining: 0:01:47) default: Progress: 30% (Rate: 1846k/s, Estimated time remaining: 0:01:47) INFO interface: info:   INFO interface: detail: Progress: 31% (Rate: 1846k/s, Estimated time remaining: 0:01:46) INFO interface: detail: default: Progress: 31% (Rate: 1846k/s, Estimated time remaining: 0:01:46) default: Progress: 31% (Rate: 1846k/s, Estimated time remaining: 0:01:46) INFO interface: info:   INFO interface: detail: Progress: 31% (Rate: 1846k/s, Estimated time remaining: 0:01:45) INFO interface: detail: default: Progress: 31% (Rate: 1846k/s, Estimated time remaining: 0:01:45) default: Progress: 31% (Rate: 1846k/s, Estimated time remaining: 0:01:45) INFO interface: info:   INFO interface: detail: Progress: 32% (Rate: 1846k/s, Estimated time remaining: 0:01:44) INFO interface: detail: default: Progress: 32% (Rate: 1846k/s, Estimated time remaining: 0:01:44) default: Progress: 32% (Rate: 1846k/s, Estimated time remaining: 0:01:44) INFO interface: info:   INFO interface: detail: Progress: 33% (Rate: 1846k/s, Estimated time remaining: 0:01:43) INFO interface: detail: default: Progress: 33% (Rate: 1846k/s, Estimated time remaining: 0:01:43) default: Progress: 33% (Rate: 1846k/s, Estimated time remaining: 0:01:43) INFO interface: info:   INFO interface: detail: Progress: 33% (Rate: 1846k/s, Estimated time remaining: 0:01:42) INFO interface: detail: default: Progress: 33% (Rate: 1846k/s, Estimated time remaining: 0:01:42) default: Progress: 33% (Rate: 1846k/s, Estimated time remaining: 0:01:42) INFO interface: info:   INFO interface: detail: Progress: 34% (Rate: 1846k/s, Estimated time remaining: 0:01:41) INFO interface: detail: default: Progress: 34% (Rate: 1846k/s, Estimated time remaining: 0:01:41) default: Progress: 34% (Rate: 1846k/s, Estimated time remaining: 0:01:41) INFO interface: info:   INFO interface: detail: Progress: 35% (Rate: 1846k/s, Estimated time remaining: 0:01:40) INFO interface: detail: default: Progress: 35% (Rate: 1846k/s, Estimated time remaining: 0:01:40) default: Progress: 35% (Rate: 1846k/s, Estimated time remaining: 0:01:40) INFO interface: info:   INFO interface: detail: Progress: 35% (Rate: 1846k/s, Estimated time remaining: 0:01:40) INFO interface: detail: default: Progress: 35% (Rate: 1846k/s, Estimated time remaining: 0:01:40) default: Progress: 35% (Rate: 1846k/s, Estimated time remaining: 0:01:40) INFO interface: info:   INFO interface: detail: Progress: 36% (Rate: 1845k/s, Estimated time remaining: 0:01:39) INFO interface: detail: default: Progress: 36% (Rate: 1845k/s, Estimated time remaining: 0:01:39) default: Progress: 36% (Rate: 1845k/s, Estimated time remaining: 0:01:39) INFO interface: info:   INFO interface: detail: Progress: 36% (Rate: 1845k/s, Estimated time remaining: 0:01:38) INFO interface: detail: default: Progress: 36% (Rate: 1845k/s, Estimated time remaining: 0:01:38) default: Progress: 36% (Rate: 1845k/s, Estimated time remaining: 0:01:38) INFO interface: info:   INFO interface: detail: Progress: 37% (Rate: 1845k/s, Estimated time remaining: 0:01:37) INFO interface: detail: default: Progress: 37% (Rate: 1845k/s, Estimated time remaining: 0:01:37) default: Progress: 37% (Rate: 1845k/s, Estimated time remaining: 0:01:37) INFO interface: info:   INFO interface: detail: Progress: 38% (Rate: 1845k/s, Estimated time remaining: 0:01:36) INFO interface: detail: default: Progress: 38% (Rate: 1845k/s, Estimated time remaining: 0:01:36) default: Progress: 38% (Rate: 1845k/s, Estimated time remaining: 0:01:36) INFO interface: info:   INFO interface: detail: Progress: 38% (Rate: 1844k/s, Estimated time remaining: 0:01:35) INFO interface: detail: default: Progress: 38% (Rate: 1844k/s, Estimated time remaining: 0:01:35) default: Progress: 38% (Rate: 1844k/s, Estimated time remaining: 0:01:35) INFO interface: info:   INFO interface: detail: Progress: 39% (Rate: 1845k/s, Estimated time remaining: 0:01:34) INFO interface: detail: default: Progress: 39% (Rate: 1845k/s, Estimated time remaining: 0:01:34) default: Progress: 39% (Rate: 1845k/s, Estimated time remaining: 0:01:34) INFO interface: info:   INFO interface: detail: Progress: 40% (Rate: 1844k/s, Estimated time remaining: 0:01:33) INFO interface: detail: default: Progress: 40% (Rate: 1844k/s, Estimated time remaining: 0:01:33) default: Progress: 40% (Rate: 1844k/s, Estimated time remaining: 0:01:33) INFO interface: info:   INFO interface: detail: Progress: 40% (Rate: 1845k/s, Estimated time remaining: 0:01:32) INFO interface: detail: default: Progress: 40% (Rate: 1845k/s, Estimated time remaining: 0:01:32) default: Progress: 40% (Rate: 1845k/s, Estimated time remaining: 0:01:32) INFO interface: info:   INFO interface: detail: Progress: 41% (Rate: 1845k/s, Estimated time remaining: 0:01:31) INFO interface: detail: default: Progress: 41% (Rate: 1845k/s, Estimated time remaining: 0:01:31) default: Progress: 41% (Rate: 1845k/s, Estimated time remaining: 0:01:31) INFO interface: info:   INFO interface: detail: Progress: 42% (Rate: 1846k/s, Estimated time remaining: 0:01:30) INFO interface: detail: default: Progress: 42% (Rate: 1846k/s, Estimated time remaining: 0:01:30) default: Progress: 42% (Rate: 1846k/s, Estimated time remaining: 0:01:30) INFO interface: info:   INFO interface: detail: Progress: 42% (Rate: 1846k/s, Estimated time remaining: 0:01:29) INFO interface: detail: default: Progress: 42% (Rate: 1846k/s, Estimated time remaining: 0:01:29) default: Progress: 42% (Rate: 1846k/s, Estimated time remaining: 0:01:29) INFO interface: info:   INFO interface: detail: Progress: 43% (Rate: 1827k/s, Estimated time remaining: 0:01:28) INFO interface: detail: default: Progress: 43% (Rate: 1827k/s, Estimated time remaining: 0:01:28) default: Progress: 43% (Rate: 1827k/s, Estimated time remaining: 0:01:28) INFO interface: info:   INFO interface: detail: Progress: 43% (Rate: 1784k/s, Estimated time remaining: 0:01:27) INFO interface: detail: default: Progress: 43% (Rate: 1784k/s, Estimated time remaining: 0:01:27) default: Progress: 43% (Rate: 1784k/s, Estimated time remaining: 0:01:27) INFO interface: info:   INFO interface: detail: Progress: 44% (Rate: 1772k/s, Estimated time remaining: 0:01:26) INFO interface: detail: default: Progress: 44% (Rate: 1772k/s, Estimated time remaining: 0:01:26) default: Progress: 44% (Rate: 1772k/s, Estimated time remaining: 0:01:26) INFO interface: info:   INFO interface: detail: Progress: 45% (Rate: 1764k/s, Estimated time remaining: 0:01:25) INFO interface: detail: default: Progress: 45% (Rate: 1764k/s, Estimated time remaining: 0:01:25) default: Progress: 45% (Rate: 1764k/s, Estimated time remaining: 0:01:25) INFO interface: info:   INFO interface: detail: Progress: 45% (Rate: 1763k/s, Estimated time remaining: 0:01:24) INFO interface: detail: default: Progress: 45% (Rate: 1763k/s, Estimated time remaining: 0:01:24) default: Progress: 45% (Rate: 1763k/s, Estimated time remaining: 0:01:24) INFO interface: info:   INFO interface: detail: Progress: 46% (Rate: 1782k/s, Estimated time remaining: 0:01:24) INFO interface: detail: default: Progress: 46% (Rate: 1782k/s, Estimated time remaining: 0:01:24) default: Progress: 46% (Rate: 1782k/s, Estimated time remaining: 0:01:24) INFO interface: info:   INFO interface: detail: Progress: 46% (Rate: 1704k/s, Estimated time remaining: 0:01:23) INFO interface: detail: default: Progress: 46% (Rate: 1704k/s, Estimated time remaining: 0:01:23) default: Progress: 46% (Rate: 1704k/s, Estimated time remaining: 0:01:23) INFO interface: info:   INFO interface: detail: Progress: 47% (Rate: 1733k/s, Estimated time remaining: 0:01:22) INFO interface: detail: default: Progress: 47% (Rate: 1733k/s, Estimated time remaining: 0:01:22) default: Progress: 47% (Rate: 1733k/s, Estimated time remaining: 0:01:22) INFO interface: info:   INFO interface: detail: Progress: 48% (Rate: 1839k/s, Estimated time remaining: 0:01:21) INFO interface: detail: default: Progress: 48% (Rate: 1839k/s, Estimated time remaining: 0:01:21) default: Progress: 48% (Rate: 1839k/s, Estimated time remaining: 0:01:21) INFO interface: info:   INFO interface: detail: Progress: 48% (Rate: 1840k/s, Estimated time remaining: 0:01:20) INFO interface: detail: default: Progress: 48% (Rate: 1840k/s, Estimated time remaining: 0:01:20) default: Progress: 48% (Rate: 1840k/s, Estimated time remaining: 0:01:20) INFO interface: info:   INFO interface: detail: Progress: 49% (Rate: 1840k/s, Estimated time remaining: 0:01:19) INFO interface: detail: default: Progress: 49% (Rate: 1840k/s, Estimated time remaining: 0:01:19) default: Progress: 49% (Rate: 1840k/s, Estimated time remaining: 0:01:19) INFO interface: info:   INFO interface: detail: Progress: 50% (Rate: 1962k/s, Estimated time remaining: 0:01:18) INFO interface: detail: default: Progress: 50% (Rate: 1962k/s, Estimated time remaining: 0:01:18) default: Progress: 50% (Rate: 1962k/s, Estimated time remaining: 0:01:18) INFO interface: info:   INFO interface: detail: Progress: 50% (Rate: 1943k/s, Estimated time remaining: 0:01:17) INFO interface: detail: default: Progress: 50% (Rate: 1943k/s, Estimated time remaining: 0:01:17) default: Progress: 50% (Rate: 1943k/s, Estimated time remaining: 0:01:17) INFO interface: info:   INFO interface: detail: Progress: 51% (Rate: 1846k/s, Estimated time remaining: 0:01:16) INFO interface: detail: default: Progress: 51% (Rate: 1846k/s, Estimated time remaining: 0:01:16) default: Progress: 51% (Rate: 1846k/s, Estimated time remaining: 0:01:16) INFO interface: info:   INFO interface: detail: Progress: 52% (Rate: 1837k/s, Estimated time remaining: 0:01:15) INFO interface: detail: default: Progress: 52% (Rate: 1837k/s, Estimated time remaining: 0:01:15) default: Progress: 52% (Rate: 1837k/s, Estimated time remaining: 0:01:15) INFO interface: info:   INFO interface: detail: Progress: 52% (Rate: 1834k/s, Estimated time remaining: 0:01:14) INFO interface: detail: default: Progress: 52% (Rate: 1834k/s, Estimated time remaining: 0:01:14) default: Progress: 52% (Rate: 1834k/s, Estimated time remaining: 0:01:14) INFO interface: info:   INFO interface: detail: Progress: 53% (Rate: 1834k/s, Estimated time remaining: 0:01:13) INFO interface: detail: default: Progress: 53% (Rate: 1834k/s, Estimated time remaining: 0:01:13) default: Progress: 53% (Rate: 1834k/s, Estimated time remaining: 0:01:13) INFO interface: info:   INFO interface: detail: Progress: 54% (Rate: 1833k/s, Estimated time remaining: 0:01:12) INFO interface: detail: default: Progress: 54% (Rate: 1833k/s, Estimated time remaining: 0:01:12) default: Progress: 54% (Rate: 1833k/s, Estimated time remaining: 0:01:12) INFO interface: info:   INFO interface: detail: Progress: 54% (Rate: 1834k/s, Estimated time remaining: 0:01:11) INFO interface: detail: default: Progress: 54% (Rate: 1834k/s, Estimated time remaining: 0:01:11) default: Progress: 54% (Rate: 1834k/s, Estimated time remaining: 0:01:11) INFO interface: info:   INFO interface: detail: Progress: 55% (Rate: 1842k/s, Estimated time remaining: 0:01:10) INFO interface: detail: default: Progress: 55% (Rate: 1842k/s, Estimated time remaining: 0:01:10) default: Progress: 55% (Rate: 1842k/s, Estimated time remaining: 0:01:10) INFO interface: info:   INFO interface: detail: Progress: 56% (Rate: 1837k/s, Estimated time remaining: 0:01:09) INFO interface: detail: default: Progress: 56% (Rate: 1837k/s, Estimated time remaining: 0:01:09) default: Progress: 56% (Rate: 1837k/s, Estimated time remaining: 0:01:09) INFO interface: info:   INFO interface: detail: Progress: 56% (Rate: 1828k/s, Estimated time remaining: 0:01:08) INFO interface: detail: default: Progress: 56% (Rate: 1828k/s, Estimated time remaining: 0:01:08) default: Progress: 56% (Rate: 1828k/s, Estimated time remaining: 0:01:08) INFO interface: info:   INFO interface: detail: Progress: 57% (Rate: 1822k/s, Estimated time remaining: 0:01:07) INFO interface: detail: default: Progress: 57% (Rate: 1822k/s, Estimated time remaining: 0:01:07) default: Progress: 57% (Rate: 1822k/s, Estimated time remaining: 0:01:07) INFO interface: info:   INFO interface: detail: Progress: 57% (Rate: 1822k/s, Estimated time remaining: 0:01:06) INFO interface: detail: default: Progress: 57% (Rate: 1822k/s, Estimated time remaining: 0:01:06) default: Progress: 57% (Rate: 1822k/s, Estimated time remaining: 0:01:06) INFO interface: info:   INFO interface: detail: Progress: 58% (Rate: 1823k/s, Estimated time remaining: 0:01:05) INFO interface: detail: default: Progress: 58% (Rate: 1823k/s, Estimated time remaining: 0:01:05) default: Progress: 58% (Rate: 1823k/s, Estimated time remaining: 0:01:05) INFO interface: info:   INFO interface: detail: Progress: 59% (Rate: 1829k/s, Estimated time remaining: 0:01:04) INFO interface: detail: default: Progress: 59% (Rate: 1829k/s, Estimated time remaining: 0:01:04) default: Progress: 59% (Rate: 1829k/s, Estimated time remaining: 0:01:04) INFO interface: info:   INFO interface: detail: Progress: 59% (Rate: 1840k/s, Estimated time remaining: 0:01:03) INFO interface: detail: default: Progress: 59% (Rate: 1840k/s, Estimated time remaining: 0:01:03) default: Progress: 59% (Rate: 1840k/s, Estimated time remaining: 0:01:03) INFO interface: info:   INFO interface: detail: Progress: 60% (Rate: 1842k/s, Estimated time remaining: 0:01:02) INFO interface: detail: default: Progress: 60% (Rate: 1842k/s, Estimated time remaining: 0:01:02) default: Progress: 60% (Rate: 1842k/s, Estimated time remaining: 0:01:02) INFO interface: info:   INFO interface: detail: Progress: 61% (Rate: 1837k/s, Estimated time remaining: 0:01:01) INFO interface: detail: default: Progress: 61% (Rate: 1837k/s, Estimated time remaining: 0:01:01) default: Progress: 61% (Rate: 1837k/s, Estimated time remaining: 0:01:01) INFO interface: info:   INFO interface: detail: Progress: 61% (Rate: 1836k/s, Estimated time remaining: 0:01:00) INFO interface: detail: default: Progress: 61% (Rate: 1836k/s, Estimated time remaining: 0:01:00) default: Progress: 61% (Rate: 1836k/s, Estimated time remaining: 0:01:00) INFO interface: info:   INFO interface: detail: Progress: 62% (Rate: 1838k/s, Estimated time remaining: 0:00:59) INFO interface: detail: default: Progress: 62% (Rate: 1838k/s, Estimated time remaining: 0:00:59) default: Progress: 62% (Rate: 1838k/s, Estimated time remaining: 0:00:59) INFO interface: info:   INFO interface: detail: Progress: 63% (Rate: 1837k/s, Estimated time remaining: 0:00:58) INFO interface: detail: default: Progress: 63% (Rate: 1837k/s, Estimated time remaining: 0:00:58) default: Progress: 63% (Rate: 1837k/s, Estimated time remaining: 0:00:58) INFO interface: info:   INFO interface: detail: Progress: 63% (Rate: 1841k/s, Estimated time remaining: 0:00:57) INFO interface: detail: default: Progress: 63% (Rate: 1841k/s, Estimated time remaining: 0:00:57) default: Progress: 63% (Rate: 1841k/s, Estimated time remaining: 0:00:57) INFO interface: info:   INFO interface: detail: Progress: 64% (Rate: 1846k/s, Estimated time remaining: 0:00:56) INFO interface: detail: default: Progress: 64% (Rate: 1846k/s, Estimated time remaining: 0:00:56) default: Progress: 64% (Rate: 1846k/s, Estimated time remaining: 0:00:56) INFO interface: info:   INFO interface: detail: Progress: 64% (Rate: 1846k/s, Estimated time remaining: 0:00:55) INFO interface: detail: default: Progress: 64% (Rate: 1846k/s, Estimated time remaining: 0:00:55) default: Progress: 64% (Rate: 1846k/s, Estimated time remaining: 0:00:55) INFO interface: info:   INFO interface: detail: Progress: 65% (Rate: 1845k/s, Estimated time remaining: 0:00:54) INFO interface: detail: default: Progress: 65% (Rate: 1845k/s, Estimated time remaining: 0:00:54) default: Progress: 65% (Rate: 1845k/s, Estimated time remaining: 0:00:54) INFO interface: info:   INFO interface: detail: Progress: 66% (Rate: 1845k/s, Estimated time remaining: 0:00:53) INFO interface: detail: default: Progress: 66% (Rate: 1845k/s, Estimated time remaining: 0:00:53) default: Progress: 66% (Rate: 1845k/s, Estimated time remaining: 0:00:53) INFO interface: info:   INFO interface: detail: Progress: 66% (Rate: 1846k/s, Estimated time remaining: 0:00:52) INFO interface: detail: default: Progress: 66% (Rate: 1846k/s, Estimated time remaining: 0:00:52) default: Progress: 66% (Rate: 1846k/s, Estimated time remaining: 0:00:52) INFO interface: info:   INFO interface: detail: Progress: 67% (Rate: 1845k/s, Estimated time remaining: 0:00:51) INFO interface: detail: default: Progress: 67% (Rate: 1845k/s, Estimated time remaining: 0:00:51) default: Progress: 67% (Rate: 1845k/s, Estimated time remaining: 0:00:51) INFO interface: info:   INFO interface: detail: Progress: 68% (Rate: 1846k/s, Estimated time remaining: 0:00:50) INFO interface: detail: default: Progress: 68% (Rate: 1846k/s, Estimated time remaining: 0:00:50) default: Progress: 68% (Rate: 1846k/s, Estimated time remaining: 0:00:50) INFO interface: info:   INFO interface: detail: Progress: 68% (Rate: 1846k/s, Estimated time remaining: 0:00:49) INFO interface: detail: default: Progress: 68% (Rate: 1846k/s, Estimated time remaining: 0:00:49) default: Progress: 68% (Rate: 1846k/s, Estimated time remaining: 0:00:49) INFO interface: info:   INFO interface: detail: Progress: 69% (Rate: 1846k/s, Estimated time remaining: 0:00:48) INFO interface: detail: default: Progress: 69% (Rate: 1846k/s, Estimated time remaining: 0:00:48) default: Progress: 69% (Rate: 1846k/s, Estimated time remaining: 0:00:48) INFO interface: info:   INFO interface: detail: Progress: 70% (Rate: 1846k/s, Estimated time remaining: 0:00:47) INFO interface: detail: default: Progress: 70% (Rate: 1846k/s, Estimated time remaining: 0:00:47) default: Progress: 70% (Rate: 1846k/s, Estimated time remaining: 0:00:47) INFO interface: info:   INFO interface: detail: Progress: 70% (Rate: 1847k/s, Estimated time remaining: 0:00:46) INFO interface: detail: default: Progress: 70% (Rate: 1847k/s, Estimated time remaining: 0:00:46) default: Progress: 70% (Rate: 1847k/s, Estimated time remaining: 0:00:46) INFO interface: info:   INFO interface: detail: Progress: 71% (Rate: 1846k/s, Estimated time remaining: 0:00:45) INFO interface: detail: default: Progress: 71% (Rate: 1846k/s, Estimated time remaining: 0:00:45) default: Progress: 71% (Rate: 1846k/s, Estimated time remaining: 0:00:45) INFO interface: info:   INFO interface: detail: Progress: 71% (Rate: 1846k/s, Estimated time remaining: 0:00:44) INFO interface: detail: default: Progress: 71% (Rate: 1846k/s, Estimated time remaining: 0:00:44) default: Progress: 71% (Rate: 1846k/s, Estimated time remaining: 0:00:44) INFO interface: info:   INFO interface: detail: Progress: 72% (Rate: 1846k/s, Estimated time remaining: 0:00:43) INFO interface: detail: default: Progress: 72% (Rate: 1846k/s, Estimated time remaining: 0:00:43) default: Progress: 72% (Rate: 1846k/s, Estimated time remaining: 0:00:43) INFO interface: info:   INFO interface: detail: Progress: 73% (Rate: 1846k/s, Estimated time remaining: 0:00:42) INFO interface: detail: default: Progress: 73% (Rate: 1846k/s, Estimated time remaining: 0:00:42) default: Progress: 73% (Rate: 1846k/s, Estimated time remaining: 0:00:42) INFO interface: info:   INFO interface: detail: Progress: 73% (Rate: 1845k/s, Estimated time remaining: 0:00:41) INFO interface: detail: default: Progress: 73% (Rate: 1845k/s, Estimated time remaining: 0:00:41) default: Progress: 73% (Rate: 1845k/s, Estimated time remaining: 0:00:41) INFO interface: info:   INFO interface: detail: Progress: 74% (Rate: 1845k/s, Estimated time remaining: 0:00:40) INFO interface: detail: default: Progress: 74% (Rate: 1845k/s, Estimated time remaining: 0:00:40) default: Progress: 74% (Rate: 1845k/s, Estimated time remaining: 0:00:40) INFO interface: info:   INFO interface: detail: Progress: 75% (Rate: 1845k/s, Estimated time remaining: 0:00:39) INFO interface: detail: default: Progress: 75% (Rate: 1845k/s, Estimated time remaining: 0:00:39) default: Progress: 75% (Rate: 1845k/s, Estimated time remaining: 0:00:39) INFO interface: info:   INFO interface: detail: Progress: 75% (Rate: 1844k/s, Estimated time remaining: 0:00:38) INFO interface: detail: default: Progress: 75% (Rate: 1844k/s, Estimated time remaining: 0:00:38) default: Progress: 75% (Rate: 1844k/s, Estimated time remaining: 0:00:38) INFO interface: info:   INFO interface: detail: Progress: 76% (Rate: 1845k/s, Estimated time remaining: 0:00:37) INFO interface: detail: default: Progress: 76% (Rate: 1845k/s, Estimated time remaining: 0:00:37) default: Progress: 76% (Rate: 1845k/s, Estimated time remaining: 0:00:37) INFO interface: info:   INFO interface: detail: Progress: 77% (Rate: 1846k/s, Estimated time remaining: 0:00:36) INFO interface: detail: default: Progress: 77% (Rate: 1846k/s, Estimated time remaining: 0:00:36) default: Progress: 77% (Rate: 1846k/s, Estimated time remaining: 0:00:36) INFO interface: info:   INFO interface: detail: Progress: 77% (Rate: 1846k/s, Estimated time remaining: 0:00:35) INFO interface: detail: default: Progress: 77% (Rate: 1846k/s, Estimated time remaining: 0:00:35) default: Progress: 77% (Rate: 1846k/s, Estimated time remaining: 0:00:35) INFO interface: info:   INFO interface: detail: Progress: 78% (Rate: 1846k/s, Estimated time remaining: 0:00:34) INFO interface: detail: default: Progress: 78% (Rate: 1846k/s, Estimated time remaining: 0:00:34) default: Progress: 78% (Rate: 1846k/s, Estimated time remaining: 0:00:34) INFO interface: info:   INFO interface: detail: Progress: 79% (Rate: 1846k/s, Estimated time remaining: 0:00:33) INFO interface: detail: default: Progress: 79% (Rate: 1846k/s, Estimated time remaining: 0:00:33) default: Progress: 79% (Rate: 1846k/s, Estimated time remaining: 0:00:33) INFO interface: info:   INFO interface: detail: Progress: 79% (Rate: 1846k/s, Estimated time remaining: 0:00:32) INFO interface: detail: default: Progress: 79% (Rate: 1846k/s, Estimated time remaining: 0:00:32) default: Progress: 79% (Rate: 1846k/s, Estimated time remaining: 0:00:32) INFO interface: info:   INFO interface: detail: Progress: 80% (Rate: 1846k/s, Estimated time remaining: 0:00:31) INFO interface: detail: default: Progress: 80% (Rate: 1846k/s, Estimated time remaining: 0:00:31) default: Progress: 80% (Rate: 1846k/s, Estimated time remaining: 0:00:31) INFO interface: info:   INFO interface: detail: Progress: 80% (Rate: 1846k/s, Estimated time remaining: 0:00:30) INFO interface: detail: default: Progress: 80% (Rate: 1846k/s, Estimated time remaining: 0:00:30) default: Progress: 80% (Rate: 1846k/s, Estimated time remaining: 0:00:30) INFO interface: info:   INFO interface: detail: Progress: 81% (Rate: 1846k/s, Estimated time remaining: 0:00:29) INFO interface: detail: default: Progress: 81% (Rate: 1846k/s, Estimated time remaining: 0:00:29) default: Progress: 81% (Rate: 1846k/s, Estimated time remaining: 0:00:29) INFO interface: info:   INFO interface: detail: Progress: 82% (Rate: 1846k/s, Estimated time remaining: 0:00:28) INFO interface: detail: default: Progress: 82% (Rate: 1846k/s, Estimated time remaining: 0:00:28) default: Progress: 82% (Rate: 1846k/s, Estimated time remaining: 0:00:28) INFO interface: info:   INFO interface: detail: Progress: 82% (Rate: 1846k/s, Estimated time remaining: 0:00:27) INFO interface: detail: default: Progress: 82% (Rate: 1846k/s, Estimated time remaining: 0:00:27) default: Progress: 82% (Rate: 1846k/s, Estimated time remaining: 0:00:27) INFO interface: info:   INFO interface: detail: Progress: 83% (Rate: 1846k/s, Estimated time remaining: 0:00:26) INFO interface: detail: default: Progress: 83% (Rate: 1846k/s, Estimated time remaining: 0:00:26) default: Progress: 83% (Rate: 1846k/s, Estimated time remaining: 0:00:26) INFO interface: info:   INFO interface: detail: Progress: 84% (Rate: 1846k/s, Estimated time remaining: 0:00:25) INFO interface: detail: default: Progress: 84% (Rate: 1846k/s, Estimated time remaining: 0:00:25) default: Progress: 84% (Rate: 1846k/s, Estimated time remaining: 0:00:25) INFO interface: info:   INFO interface: detail: Progress: 84% (Rate: 1846k/s, Estimated time remaining: 0:00:24) INFO interface: detail: default: Progress: 84% (Rate: 1846k/s, Estimated time remaining: 0:00:24) default: Progress: 84% (Rate: 1846k/s, Estimated time remaining: 0:00:24) INFO interface: info:   INFO interface: detail: Progress: 85% (Rate: 1846k/s, Estimated time remaining: 0:00:23) INFO interface: detail: default: Progress: 85% (Rate: 1846k/s, Estimated time remaining: 0:00:23) default: Progress: 85% (Rate: 1846k/s, Estimated time remaining: 0:00:23) INFO interface: info:   INFO interface: detail: Progress: 86% (Rate: 1846k/s, Estimated time remaining: 0:00:22) INFO interface: detail: default: Progress: 86% (Rate: 1846k/s, Estimated time remaining: 0:00:22) default: Progress: 86% (Rate: 1846k/s, Estimated time remaining: 0:00:22) INFO interface: info:   INFO interface: detail: Progress: 86% (Rate: 1846k/s, Estimated time remaining: 0:00:21) INFO interface: detail: default: Progress: 86% (Rate: 1846k/s, Estimated time remaining: 0:00:21) default: Progress: 86% (Rate: 1846k/s, Estimated time remaining: 0:00:21) INFO interface: info:   INFO interface: detail: Progress: 87% (Rate: 1846k/s, Estimated time remaining: 0:00:20) INFO interface: detail: default: Progress: 87% (Rate: 1846k/s, Estimated time remaining: 0:00:20) default: Progress: 87% (Rate: 1846k/s, Estimated time remaining: 0:00:20) INFO interface: info:   INFO interface: detail: Progress: 87% (Rate: 1846k/s, Estimated time remaining: 0:00:19) INFO interface: detail: default: Progress: 87% (Rate: 1846k/s, Estimated time remaining: 0:00:19) default: Progress: 87% (Rate: 1846k/s, Estimated time remaining: 0:00:19) INFO interface: info:   INFO interface: detail: Progress: 88% (Rate: 1846k/s, Estimated time remaining: 0:00:18) INFO interface: detail: default: Progress: 88% (Rate: 1846k/s, Estimated time remaining: 0:00:18) default: Progress: 88% (Rate: 1846k/s, Estimated time remaining: 0:00:18) INFO interface: info:   INFO interface: detail: Progress: 89% (Rate: 1846k/s, Estimated time remaining: 0:00:17) INFO interface: detail: default: Progress: 89% (Rate: 1846k/s, Estimated time remaining: 0:00:17) default: Progress: 89% (Rate: 1846k/s, Estimated time remaining: 0:00:17) INFO interface: info:   INFO interface: detail: Progress: 89% (Rate: 1846k/s, Estimated time remaining: 0:00:16) INFO interface: detail: default: Progress: 89% (Rate: 1846k/s, Estimated time remaining: 0:00:16) default: Progress: 89% (Rate: 1846k/s, Estimated time remaining: 0:00:16) INFO interface: info:   INFO interface: detail: Progress: 90% (Rate: 1846k/s, Estimated time remaining: 0:00:15) INFO interface: detail: default: Progress: 90% (Rate: 1846k/s, Estimated time remaining: 0:00:15) default: Progress: 90% (Rate: 1846k/s, Estimated time remaining: 0:00:15) INFO interface: info:   INFO interface: detail: Progress: 91% (Rate: 1846k/s, Estimated time remaining: 0:00:14) INFO interface: detail: default: Progress: 91% (Rate: 1846k/s, Estimated time remaining: 0:00:14) default: Progress: 91% (Rate: 1846k/s, Estimated time remaining: 0:00:14) INFO interface: info:   INFO interface: detail: Progress: 91% (Rate: 1843k/s, Estimated time remaining: 0:00:13) INFO interface: detail: default: Progress: 91% (Rate: 1843k/s, Estimated time remaining: 0:00:13) default: Progress: 91% (Rate: 1843k/s, Estimated time remaining: 0:00:13) INFO interface: info:   INFO interface: detail: Progress: 92% (Rate: 1846k/s, Estimated time remaining: 0:00:12) INFO interface: detail: default: Progress: 92% (Rate: 1846k/s, Estimated time remaining: 0:00:12) default: Progress: 92% (Rate: 1846k/s, Estimated time remaining: 0:00:12) INFO interface: info:   INFO interface: detail: Progress: 93% (Rate: 1846k/s, Estimated time remaining: 0:00:11) INFO interface: detail: default: Progress: 93% (Rate: 1846k/s, Estimated time remaining: 0:00:11) default: Progress: 93% (Rate: 1846k/s, Estimated time remaining: 0:00:11) INFO interface: info:   INFO interface: detail: Progress: 93% (Rate: 1846k/s, Estimated time remaining: 0:00:10) INFO interface: detail: default: Progress: 93% (Rate: 1846k/s, Estimated time remaining: 0:00:10) default: Progress: 93% (Rate: 1846k/s, Estimated time remaining: 0:00:10) INFO interface: info:   INFO interface: detail: Progress: 94% (Rate: 1846k/s, Estimated time remaining: 0:00:09) INFO interface: detail: default: Progress: 94% (Rate: 1846k/s, Estimated time remaining: 0:00:09) default: Progress: 94% (Rate: 1846k/s, Estimated time remaining: 0:00:09) INFO interface: info:   INFO interface: detail: Progress: 95% (Rate: 1849k/s, Estimated time remaining: 0:00:08) INFO interface: detail: default: Progress: 95% (Rate: 1849k/s, Estimated time remaining: 0:00:08) default: Progress: 95% (Rate: 1849k/s, Estimated time remaining: 0:00:08) INFO interface: info:   INFO interface: detail: Progress: 95% (Rate: 1846k/s, Estimated time remaining: 0:00:07) INFO interface: detail: default: Progress: 95% (Rate: 1846k/s, Estimated time remaining: 0:00:07) default: Progress: 95% (Rate: 1846k/s, Estimated time remaining: 0:00:07) INFO interface: info:   INFO interface: detail: Progress: 96% (Rate: 1846k/s, Estimated time remaining: 0:00:06) INFO interface: detail: default: Progress: 96% (Rate: 1846k/s, Estimated time remaining: 0:00:06) default: Progress: 96% (Rate: 1846k/s, Estimated time remaining: 0:00:06) INFO interface: info:   INFO interface: detail: Progress: 96% (Rate: 1846k/s, Estimated time remaining: 0:00:05) INFO interface: detail: default: Progress: 96% (Rate: 1846k/s, Estimated time remaining: 0:00:05) default: Progress: 96% (Rate: 1846k/s, Estimated time remaining: 0:00:05) INFO interface: info:   INFO interface: detail: Progress: 97% (Rate: 1846k/s, Estimated time remaining: 0:00:04) INFO interface: detail: default: Progress: 97% (Rate: 1846k/s, Estimated time remaining: 0:00:04) default: Progress: 97% (Rate: 1846k/s, Estimated time remaining: 0:00:04) INFO interface: info:   INFO interface: detail: Progress: 98% (Rate: 1778k/s, Estimated time remaining: 0:00:03) INFO interface: detail: default: Progress: 98% (Rate: 1778k/s, Estimated time remaining: 0:00:03) default: Progress: 98% (Rate: 1778k/s, Estimated time remaining: 0:00:03) INFO interface: info:   INFO interface: detail: Progress: 98% (Rate: 1841k/s, Estimated time remaining: 0:00:02) INFO interface: detail: default: Progress: 98% (Rate: 1841k/s, Estimated time remaining: 0:00:02) default: Progress: 98% (Rate: 1841k/s, Estimated time remaining: 0:00:02) INFO interface: info:   INFO interface: detail: Progress: 99% (Rate: 1840k/s, Estimated time remaining: 0:00:01) INFO interface: detail: default: Progress: 99% (Rate: 1840k/s, Estimated time remaining: 0:00:01) default: Progress: 99% (Rate: 1840k/s, Estimated time remaining: 0:00:01) INFO interface: info:   INFO interface: detail: Progress: 100% (Rate: 1846k/s, Estimated time remaining: --:--:--) INFO interface: detail: default: Progress: 100% (Rate: 1846k/s, Estimated time remaining: --:--:--) default: Progress: 100% (Rate: 1846k/s, Estimated time remaining: --:--:--) INFO interface: info:   INFO interface: detail: INFO interface: detail: default: default: INFO box_collection: Box not found: hashicorp/precise32 (virtualbox) INFO subprocess: Starting process: ["C:\\Vagrant\\embedded\\gnuwin32\\bin/bsdtar.EXE", "-v", "-x", "-m", "-C", "C:/Users/jkl/.vagrant.d/tmp/vagrant-box-add-temp-20150104-6168-1gj524h", "-f", "C:/Users/jkl/.vagrant.d/tmp/box72e2e33d2e7634570ddd616e403e10782711cdf0"] INFO box_collection: Box found: hashicorp/precise32 (virtualbox) INFO environment: Running hook: authenticate_box_url INFO runner: Preparing hooks for middleware sequence... INFO runner: 2 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling OUT action: # INFO interface: success: Successfully added box 'hashicorp/precise32' (v1.0.0) for 'virtualbox'! INFO interface: success: ==> default: Successfully added box 'hashicorp/precise32' (v1.0.0) for 'virtualbox'! ==> default: Successfully added box 'hashicorp/precise32' (v1.0.0) for 'virtualbox'! INFO warden: Calling OUT action: # INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO loader: Set "30455616_machine_default" = [] INFO loader: Loading configuration in order: [:home, :root, "30455616_machine_default"] INFO box_collection: Box found: hashicorp/precise32 (virtualbox) INFO environment: Running hook: authenticate_box_url INFO runner: Preparing hooks for middleware sequence... INFO runner: 2 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling OUT action: # INFO loader: Set :"30222912_hashicorp/precise32_virtualbox" = # INFO loader: Loading configuration in order: [:"30222912_hashicorp/precise32_virtualbox", :home, :root, "30455616_machine_default"] INFO machine: Initializing machine: default INFO machine: - Provider: VagrantPlugins::ProviderVirtualBox::Provider INFO machine: - Box: # INFO machine: - Data dir: C:/cygwin64/home/jkl/vagrant_ubuntu/.vagrant/machines/default/virtualbox INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO machine: New machine ID: nil INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling OUT action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO interface: info: Importing base box 'hashicorp/precise32'... INFO interface: info: ==> default: Importing base box 'hashicorp/precise32'... ==> default: Importing base box 'hashicorp/precise32'... INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Users/jkl/.vagrant.d/boxes/hashicorp-VAGRANTSLASH-precise32/1.0.0/virtualbox/box.ovf"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "import", "-n", "C:\\Users\\jkl\\.vagrant.d\\boxes\\hashicorp-VAGRANTSLASH-precise32\\1.0.0\\virtualbox\\box.ovf"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "import", "C:\\Users\\jkl\\.vagrant.d\\boxes\\hashicorp-VAGRANTSLASH-precise32\\1.0.0\\virtualbox\\box.ovf", "--vsys", "0", "--vmname", "precise32_1420433187640_51182", "--vsys", "0", "--unit", "9", "--disk", "C:\\Users\\jkl\\VirtualBoxVMs\\precise32_1420433187640_51182\\box-disk1.vmdk"] INFO interface: info:   INFO interface: info: Progress: 30% Progress: 30% INFO interface: info:   INFO interface: info: Progress: 40% Progress: 40% INFO interface: info:   INFO interface: info: Progress: 50% Progress: 50% INFO interface: info:   INFO interface: info: Progress: 80% Progress: 80% INFO interface: info:   INFO interface: info: Progress: 90% Progress: 90% INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "list", "vms"] INFO machine: New machine ID: "aa11f60a-6063-4caf-b34a-74f3b7ecedf2" INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2"] INFO interface: info:   INFO warden: Calling IN action: # INFO interface: info: Matching MAC address for NAT networking... INFO interface: info: ==> default: Matching MAC address for NAT networking... ==> default: Matching MAC address for NAT networking... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "modifyvm", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--macaddress1", "080027129698"] INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"] INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/Program Files/Oracle/VirtualBox/VBoxManage.exe"] INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "list", "hostonlyifs"] INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO interface: output: Checking if box 'hashicorp/precise32' is up to date... INFO interface: output: ==> default: Checking if box 'hashicorp/precise32' is up to date... ==> default: Checking if box 'hashicorp/precise32' is up to date... INFO downloader: Downloader starting download: INFO downloader: -- Source: https://atlas.hashicorp.com/hashicorp/precise32 INFO downloader: -- Destination: C:/cygwin64/tmp/vagrant20150104-6168-219k3v INFO subprocess: Starting process: ["C:\\Vagrant\\embedded\\bin/curl.EXE", "-q", "--fail", "--location", "--max-redirs", "10", "--user-agent", "Vagrant/1.7.1", "-H", "Accept: application/json", "--output", "C:/cygwin64/tmp/vagrant20150104-6168-219k3v", "https://atlas.hashicorp.com/hashicorp/precise32"] INFO warden: Calling IN action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO warden: Calling OUT action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO warden: Calling OUT action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO warden: Calling OUT action: # INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "list", "systemproperties"] INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "list", "vms"] INFO interface: info: Setting the name of the VM: vagrant_ubuntu_default_1420433207909_81445 INFO interface: info: ==> default: Setting the name of the VM: vagrant_ubuntu_default_1420433207909_81445 ==> default: Setting the name of the VM: vagrant_ubuntu_default_1420433207909_81445 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "modifyvm", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--name", "vagrant_ubuntu_default_1420433207909_81445"] INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO warden: Calling IN action: # INFO provision: Checking provisioner sentinel file... INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "list", "vms"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO warden: Calling IN action: # INFO environment: Acquired process lock: dotlock INFO environment: Released process lock: dotlock INFO environment: Acquired process lock: fpcollision INFO handle_port_collisions: Detecting any forwarded port collisions... INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "list", "vms"] INFO warden: Calling IN action: # INFO nfs: Host doesn't support pruning NFS. Skipping. INFO warden: Calling IN action: # INFO synced_folder_cleanup: Invoking synced folder cleanup for: virtualbox INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO warden: Calling IN action: # INFO synced_folders: Synced Folder Implementation: virtualbox INFO synced_folders: - /vagrant: . => /vagrant INFO synced_folders: Invoking synced folder prepare for: virtualbox INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/cygwin64/home/jkl/vagrant_ubuntu"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "sharedfolder", "add", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--name", "vagrant", "--hostpath", "C:\\cygwin64\\home\\jkl\\vagrant_ubuntu"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "setextradata", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "VBoxInternal2/SharedFoldersEnableSymlinksCreate/vagrant", "1"] INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO interface: info: Clearing any previously set network interfaces... INFO interface: info: ==> default: Clearing any previously set network interfaces... ==> default: Clearing any previously set network interfaces... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "modifyvm", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--nic2", "none", "--nic3", "none", "--nic4", "none", "--nic5", "none", "--nic6", "none", "--nic7", "none", "--nic8", "none"] INFO warden: Calling IN action: # INFO network: Determining network adapters required for high-level configuration... INFO network: Determining adapters and compiling network configuration... INFO network: Network slot 1. Type: nat. INFO network: Enabling adapters... INFO interface: output: Preparing network interfaces based on configuration... INFO interface: output: ==> default: Preparing network interfaces based on configuration... ==> default: Preparing network interfaces based on configuration... INFO interface: detail: Adapter 1: nat INFO interface: detail: default: Adapter 1: nat default: Adapter 1: nat INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "modifyvm", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--nic1", "nat"] INFO warden: Calling IN action: # INFO interface: output: Forwarding ports... INFO interface: output: ==> default: Forwarding ports... ==> default: Forwarding ports... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO interface: detail: 22 => 2222 (adapter 1) INFO interface: detail: default: 22 => 2222 (adapter 1) default: 22 => 2222 (adapter 1) INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "modifyvm", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--natpf1", "ssh,tcp,127.0.0.1,2222,,22"] INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "modifyvm", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--rtcuseutc", "on"] INFO sanedefaults: Automatically figuring out whether to enable/disable NAT DNS proxy... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "modifyvm", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--natdnsproxy1", "on"] INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO interface: info: Booting VM... INFO interface: info: ==> default: Booting VM... ==> default: Booting VM... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "startvm", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--type", "headless"] INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO interface: output: Waiting for machine to boot. This may take a few minutes... INFO interface: output: ==> default: Waiting for machine to boot. This may take a few minutes... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] ==> default: Waiting for machine to boot. This may take a few minutes... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO interface: detail: SSH address: 127.0.0.1:2222 INFO interface: detail: default: SSH address: 127.0.0.1:2222 default: SSH address: 127.0.0.1:2222 INFO interface: detail: SSH username: vagrant INFO interface: detail: default: SSH username: vagrant default: SSH username: vagrant INFO interface: detail: SSH auth method: private key INFO interface: detail: default: SSH auth method: private key default: SSH auth method: private key INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO ssh: Attempting SSH connection... INFO ssh: Attempting to connect to SSH... INFO ssh: - Host: 127.0.0.1 INFO ssh: - Port: 2222 INFO ssh: - Username: vagrant INFO ssh: - Password? false INFO ssh: - Key Path: ["C:/Users/jkl/.vagrant.d/insecure_private_key"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO ssh: SSH not ready: # INFO interface: detail: Warning: Connection timeout. Retrying... INFO interface: detail: default: Warning: Connection timeout. Retrying... default: Warning: Connection timeout. Retrying... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO ssh: Attempting SSH connection... INFO ssh: Attempting to connect to SSH... INFO ssh: - Host: 127.0.0.1 INFO ssh: - Port: 2222 INFO ssh: - Username: vagrant INFO ssh: - Password? false INFO ssh: - Key Path: ["C:/Users/jkl/.vagrant.d/insecure_private_key"] INFO ssh: SSH is ready! INFO ssh: Execute: (sudo=false) INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO interface: detail: Vagrant insecure key detected. Vagrant will automatically replace this with a newly generated keypair for better security. INFO interface: detail: default: default: Vagrant insecure key detected. Vagrant will automatically replace default: this with a newly generated keypair for better security. default: default: Vagrant insecure key detected. Vagrant will automatically replace default: this with a newly generated keypair for better security. INFO ssh: SSH is ready! INFO ssh: Execute: (sudo=false) INFO guest: Autodetecting host type for [#] INFO ssh: Execute: cat /etc/issue | grep 'Linux Mint' (sudo=false) INFO ssh: Execute: grep 'Fedora release [12][67890]' /etc/redhat-release (sudo=false) INFO ssh: Execute: cat /etc/pld-release (sudo=false) INFO ssh: Execute: [ -x /usr/bin/lsb_release ] && /usr/bin/lsb_release -i 2>/dev/null | grep Ubuntu (sudo=false) INFO guest: Detected: ubuntu! INFO ssh: SSH is ready! INFO ssh: Execute: (sudo=false) INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO ssh: Inserting key to avoid password: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCiZpfA3ROfr8Du+tOY8oFD320U9cZuq9O9YH4W9kiZiK9lxt60tj+GGkvy9okzbUChM8jEKj+WOh5s1cpaYRi0LmZ3IrJEs+BMpnc/7jM1w4PQJgdEyccQaxdEksoRMsyrlpjO7Moz1XpzJQCRhIXMRxUeJ+6CkJa5ubdgQINfkniguN4loFcArQfyQTisYDDOiPm0DK6ylTtozCuuqwSoQPHZDCRlfwzO8HtqAprRtQgFxpWLkwKZpKWId5Z50b1iik46aAN2A76pnJ4XP3t3WPIx2+FFZvDM2Rm4sUZxdudUtlVxKq7z1OUh4r574g+lna/BMoAmYJvFGt7pI4Up vagrant INFO interface: detail: Inserting generated public key within guest... INFO interface: detail: default: default: Inserting generated public key within guest... default: default: Inserting generated public key within guest... INFO ssh: SSH is ready! INFO ssh: Execute: (sudo=false) INFO guest: Execute capability: insert_public_key [#, "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCiZpfA3ROfr8Du+tOY8oFD320U9cZuq9O9YH4W9kiZiK9lxt60tj+GGkvy9okzbUChM8jEKj+WOh5s1cpaYRi0LmZ3IrJEs+BMpnc/7jM1w4PQJgdEyccQaxdEksoRMsyrlpjO7Moz1XpzJQCRhIXMRxUeJ+6CkJa5ubdgQINfkniguN4loFcArQfyQTisYDDOiPm0DK6ylTtozCuuqwSoQPHZDCRlfwzO8HtqAprRtQgFxpWLkwKZpKWId5Z50b1iik46aAN2A76pnJ4XP3t3WPIx2+FFZvDM2Rm4sUZxdudUtlVxKq7z1OUh4r574g+lna/BMoAmYJvFGt7pI4Up vagrant"] (ubuntu) INFO ssh: Execute: mkdir -p ~/.ssh (sudo=false) INFO ssh: Execute: chmod 0700 ~/.ssh (sudo=false) INFO ssh: Execute: printf 'ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCiZpfA3ROfr8Du+tOY8oFD320U9cZuq9O9YH4W9kiZiK9lxt60tj+GGkvy9okzbUChM8jEKj+WOh5s1cpaYRi0LmZ3IrJEs+BMpnc/7jM1w4PQJgdEyccQaxdEksoRMsyrlpjO7Moz1XpzJQCRhIXMRxUeJ+6CkJa5ubdgQINfkniguN4loFcArQfyQTisYDDOiPm0DK6ylTtozCuuqwSoQPHZDCRlfwzO8HtqAprRtQgFxpWLkwKZpKWId5Z50b1iik46aAN2A76pnJ4XP3t3WPIx2+FFZvDM2Rm4sUZxdudUtlVxKq7z1OUh4r574g+lna/BMoAmYJvFGt7pI4Up vagrant\n' >> ~/.ssh/authorized_keys (sudo=false) INFO ssh: Execute: chmod 0600 ~/.ssh/authorized_keys (sudo=false) INFO interface: detail: Removing insecure key from the guest if its present... INFO interface: detail: default: Removing insecure key from the guest if its present... default: Removing insecure key from the guest if its present... INFO ssh: SSH is ready! INFO ssh: Execute: (sudo=false) INFO guest: Execute capability: remove_public_key [#, "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA6NF8iallvQVp22WDkTkyrtvp9eWW6A8YVr+kz4TjGYe7gHzIw+niNltGEFHzD8+v1I2YJ6oXevct1YeS0o9HZyN1Q9qgCgzUFtdOKLv6IedplqoPkcmF0aYet2PkEDo3MlTBckFXPITAMzF8dJSIFo9D8HfdOV0IAdx4O7PtixWKn5y2hMNG0zQPyUecp4pzC6kivAIhyfHilFR61RGL+GPXQ2MWZWFYbAGjyiYJnAmCP3NOTd0jMZEnDkbUvxhMmBYSdETk1rRgm+R4LOzFUGaHqHDLKLX+FIPKcF96hrucXzcWyLbIbEgE98OHlnVYCzRdK8jlqm8tehUc9c9WhQ== vagrant insecure public key"] (ubuntu) INFO ssh: Execute: test -f ~/.ssh/authorized_keys (sudo=false) INFO ssh: Execute: sed -i '/^.*ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA6NF8iallvQVp22WDkTkyrtvp9eWW6A8YVr+kz4TjGYe7gHzIw+niNltGEFHzD8+v1I2YJ6oXevct1YeS0o9HZyN1Q9qgCgzUFtdOKLv6IedplqoPkcmF0aYet2PkEDo3MlTBckFXPITAMzF8dJSIFo9D8HfdOV0IAdx4O7PtixWKn5y2hMNG0zQPyUecp4pzC6kivAIhyfHilFR61RGL+GPXQ2MWZWFYbAGjyiYJnAmCP3NOTd0jMZEnDkbUvxhMmBYSdETk1rRgm+R4LOzFUGaHqHDLKLX+FIPKcF96hrucXzcWyLbIbEgE98OHlnVYCzRdK8jlqm8tehUc9c9WhQ== vagrant insecure public key.*$/d' ~/.ssh/authorized_keys (sudo=false) INFO interface: detail: Key inserted! Disconnecting and reconnecting using new SSH key... INFO interface: detail: default: Key inserted! Disconnecting and reconnecting using new SSH key... default: Key inserted! Disconnecting and reconnecting using new SSH key... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO ssh: Attempting SSH connection... INFO ssh: Attempting to connect to SSH... INFO ssh: - Host: 127.0.0.1 INFO ssh: - Port: 2222 INFO ssh: - Username: vagrant INFO ssh: - Password? false INFO ssh: - Key Path: ["C:/cygwin64/home/jkl/vagrant_ubuntu/.vagrant/machines/default/virtualbox/private_key"] INFO ssh: SSH is ready! INFO ssh: Execute: (sudo=false) INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO interface: output: Machine booted and ready! INFO interface: output: ==> default: Machine booted and ready! ==> default: Machine booted and ready! INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO interface: output: Checking for guest additions in VM... INFO interface: output: ==> default: Checking for guest additions in VM... ==> default: Checking for guest additions in VM... INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "guestproperty", "get", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "/VirtualBox/GuestAdd/Version"] INFO interface: detail: The guest additions on this VM do not match the installed version of VirtualBox! In most cases this is fine, but in rare cases it can prevent things such as shared folders from working properly. If you see shared folder errors, please make sure the guest additions within the virtual machine match the version of VirtualBox you have installed on your host and reload your VM. Guest Additions Version: 4.2.0 VirtualBox Version: 4.3 INFO interface: detail: default: The guest additions on this VM do not match the installed version of default: VirtualBox! In most cases this is fine, but in rare cases it can default: prevent things such as shared folders from working properly. If you see default: shared folder errors, please make sure the guest additions within the default: virtual machine match the version of VirtualBox you have installed on default: your host and reload your VM. default: default: Guest Additions Version: 4.2.0 default: VirtualBox Version: 4.3 default: The guest additions on this VM do not match the installed version of default: VirtualBox! In most cases this is fine, but in rare cases it can default: prevent things such as shared folders from working properly. If you see default: shared folder errors, please make sure the guest additions within the default: virtual machine match the version of VirtualBox you have installed on default: your host and reload your VM. default: default: Guest Additions Version: 4.2.0 default: VirtualBox Version: 4.3 INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO synced_folders: Invoking synced folder enable: virtualbox INFO subprocess: Starting process: ["C:\\cygwin64\\bin/cygpath.EXE", "-w", "-l", "-a", "C:/cygwin64/home/jkl/vagrant_ubuntu"] INFO interface: output: Mounting shared folders... INFO interface: output: ==> default: Mounting shared folders... ==> default: Mounting shared folders... INFO interface: detail: /vagrant => C:/cygwin64/home/jkl/vagrant_ubuntu INFO interface: detail: default: /vagrant => C:/cygwin64/home/jkl/vagrant_ubuntu default: /vagrant => C:/cygwin64/home/jkl/vagrant_ubuntu INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "aa11f60a-6063-4caf-b34a-74f3b7ecedf2", "--machinereadable"] INFO ssh: SSH is ready! INFO ssh: Execute: (sudo=false) INFO guest: Execute capability: mount_virtualbox_shared_folder [#, "vagrant", "/vagrant", {:guestpath=>"/vagrant", :hostpath=>"C:/cygwin64/home/jkl/vagrant_ubuntu", :disabled=>false, :owner=>"vagrant", :group=>"vagrant"}] (ubuntu) INFO ssh: SSH is ready! INFO ssh: Execute: (sudo=false) INFO guest: Execute capability: shell_expand_guest_path [#, "/vagrant"] (ubuntu) INFO ssh: Execute: echo; printf /vagrant (sudo=false) INFO ssh: Execute: mkdir -p /vagrant (sudo=true) INFO ssh: Execute: mount -t vboxsf -o uid=`id -u vagrant`,gid=`getent group vagrant | cut -d: -f3` vagrant /vagrant (sudo=true) INFO ssh: Execute: chown `id -u vagrant`:`getent group vagrant | cut -d: -f3` /vagrant (sudo=true) INFO ssh: Execute: test -x /sbin/initctl (sudo=false) INFO ssh: Execute: /sbin/initctl emit --no-wait vagrant-mounted MOUNTPOINT=/vagrant (sudo=true) INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO environment: Released process lock: fpcollision INFO environment: Acquired process lock: dotlock INFO environment: Released process lock: dotlock INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO provision: Writing provisioning sentinel so we don't provision again INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO environment: Released process lock: machine-action-a8914bcdd76acdd81bd190f02222b0da INFO environment: Acquired process lock: dotlock INFO environment: Released process lock: dotlock INFO environment: Running hook: environment_unload INFO runner: Preparing hooks for middleware sequence... INFO runner: 1 hooks defined. INFO runner: Running action: # ]0;~/vagrant_ubuntu jkl@root-PC ~/vagrant_ubuntu $ exit exit Script done on Sun, Jan 04, 2015 11:47:25 PM