Skip to content

Instantly share code, notes, and snippets.

@russellcardullo
Last active December 15, 2015 00:19
Show Gist options
  • Save russellcardullo/5171931 to your computer and use it in GitHub Desktop.
Save russellcardullo/5171931 to your computer and use it in GitHub Desktop.
Setting ssh username for the vagrant-aws plugin shows how provisioning hangs using Virtualbox provider
Vagrant.configure("2") do |config|
config.vm.define :testbox do |testbox|
testbox.vm.box = 'opscode-ubuntu-12.04'
testbox.ssh.username = 'ubuntu'
testbox.vm.provider :aws do |aws|
aws.access_key_id = 'MY_ACCESS_KEY'
aws.secret_access_key = 'MY_SECRET_ACCESS_KEY'
aws.keypair_name = 'MY_KEYPAIR_NAME'
aws.ssh_private_key_path = 'MY_SSH_PRIVATE_KEY_PATH'
aws.ssh_username = 'ubuntu'
aws.tags = {
Name: 'vagrant-aws testing'
}
end
end
end
@russellcardullo
Copy link
Author

→ VAGRANT_LOG=debug vagrant up --provider=virtualbox
INFO global: Vagrant version: 1.1.0
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/box/plugin.rb
INFO manager: Registered plugin: box command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/destroy/plugin.rb
INFO manager: Registered plugin: destroy command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/halt/plugin.rb
INFO manager: Registered plugin: halt command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/init/plugin.rb
INFO manager: Registered plugin: init command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/package/plugin.rb
INFO manager: Registered plugin: package command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/plugin/plugin.rb
INFO manager: Registered plugin: plugin command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/provision/plugin.rb
INFO manager: Registered plugin: provision command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/reload/plugin.rb
INFO manager: Registered plugin: reload command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/resume/plugin.rb
INFO manager: Registered plugin: resume command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/ssh/plugin.rb
INFO manager: Registered plugin: ssh command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/ssh_config/plugin.rb
INFO manager: Registered plugin: ssh-config command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/status/plugin.rb
INFO manager: Registered plugin: status command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/suspend/plugin.rb
INFO manager: Registered plugin: suspend command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/commands/up/plugin.rb
INFO manager: Registered plugin: up command
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/communicators/ssh/plugin.rb
INFO manager: Registered plugin: ssh communiator
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/arch/plugin.rb
INFO manager: Registered plugin: Arch guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/debian/plugin.rb
INFO manager: Registered plugin: Debian guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/fedora/plugin.rb
INFO manager: Registered plugin: Fedora guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/freebsd/plugin.rb
INFO manager: Registered plugin: FreeBSD guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/gentoo/plugin.rb
INFO manager: Registered plugin: Gentoo guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/linux/plugin.rb
INFO manager: Registered plugin: Linux guest.
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/openbsd/plugin.rb
INFO manager: Registered plugin: OpenBSD guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/redhat/plugin.rb
INFO manager: Registered plugin: RedHat guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/solaris/plugin.rb
INFO manager: Registered plugin: Solaris guest.
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/suse/plugin.rb
INFO manager: Registered plugin: SUSE guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/guests/ubuntu/plugin.rb
INFO manager: Registered plugin: Ubuntu guest
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/hosts/arch/plugin.rb
INFO manager: Registered plugin: Arch host
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/hosts/bsd/plugin.rb
INFO manager: Registered plugin: BSD host
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/hosts/fedora/plugin.rb
INFO manager: Registered plugin: Fedora host
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/hosts/freebsd/plugin.rb
INFO manager: Registered plugin: FreeBSD host
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/hosts/gentoo/plugin.rb
INFO manager: Registered plugin: Gentoo host
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/hosts/linux/plugin.rb
INFO manager: Registered plugin: Linux host
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/hosts/opensuse/plugin.rb
INFO manager: Registered plugin: OpenSUSE host
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/hosts/windows/plugin.rb
INFO manager: Registered plugin: Windows host
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/kernel_v1/plugin.rb
INFO manager: Registered plugin: kernel
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/kernel_v2/plugin.rb
INFO manager: Registered plugin: kernel
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/providers/virtualbox/plugin.rb
INFO manager: Registered plugin: VirtualBox provider
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/provisioners/chef/plugin.rb
INFO manager: Registered plugin: chef
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/provisioners/puppet/plugin.rb
INFO manager: Registered plugin: puppet
DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/plugins/provisioners/shell/plugin.rb
INFO manager: Registered plugin: shell
INFO vagrant: vagrant invoked: ["up", "--provider=virtualbox"]
DEBUG vagrant: Creating Vagrant environment
INFO environment: Environment initialized (#Vagrant::Environment:0x00000100c2c990)
INFO environment: - cwd: /Users/engineer/workspace/vagrant_aws_exploration
INFO environment: Home path: /Users/engineer/.vagrant.d
INFO environment: Local data path: /Users/engineer/workspace/vagrant_aws_exploration/.vagrant
DEBUG environment: Creating: /Users/engineer/workspace/vagrant_aws_exploration/.vagrant
DEBUG environment: Loading plugins from: /Users/engineer/.vagrant.d/plugins.json
INFO environment: Loading plugin from JSON: dotenv
INFO environment: Loading plugin from JSON: vagrant-aws
INFO manager: Registered plugin: AWS
INFO environment: Running hook: environment_load
INFO environment: Initializing config...
INFO loader: Set :default = "/Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/config/default.rb"
DEBUG loader: Populating proc cache for "/Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/config/default.rb"
DEBUG loader: Load procs for pathname: /Applications/Vagrant/embedded/gems/gems/vagrant-1.1.0/config/default.rb
INFO loader: Set :root = #Pathname:/Users/engineer/workspace/vagrant_aws_exploration/Vagrantfile
DEBUG loader: Populating proc cache for #Pathname:/Users/engineer/workspace/vagrant_aws_exploration/Vagrantfile
DEBUG loader: Load procs for pathname: /Users/engineer/workspace/vagrant_aws_exploration/Vagrantfile
INFO loader: Loading configuration in order: [:default, :home, :root]
DEBUG loader: Loading from: default (evaluating)
DEBUG loader: Loading from: root (evaluating)
DEBUG loader: Configuration loaded successfully, finalizing and returning
DEBUG hosts: Host path search classes: [VagrantPlugins::HostWindows::Host, VagrantPlugins::HostOpenSUSE::Host, VagrantPlugins::HostArch::Host, VagrantPlugins::HostFedora::Host, VagrantPlugins::HostFreeBSD::Host, VagrantPlugins::HostGentoo::Host, VagrantPlugins::HostLinux::Host, VagrantPlugins::HostBSD::Host]
INFO hosts: Host class: VagrantPlugins::HostBSD::Host
INFO runner: Running action: #Vagrant::Action::Builder:0x00000100c79448
INFO cli: CLI: [] "up" ["--provider=virtualbox"]
DEBUG cli: Invoking command class: VagrantPlugins::CommandUp::Command ["--provider=virtualbox"]
DEBUG command: 'Up' each target VM...
DEBUG command: Getting target VMs for command. Arguments:
DEBUG command: -- names: []
DEBUG command: -- options: {:provider=>"virtualbox"}
DEBUG command: Loading all machines...
INFO environment: Getting machine: testbox (virtualbox)
INFO environment: Uncached load of machine.
INFO loader: Set :vm_testbox = [["2", #Proc:0x00000100a4a320@/Users/engineer/workspace/vagrant_aws_exploration/Vagrantfile:5]]
DEBUG loader: Populating proc cache for ["2", #Proc:0x00000100a4a320@/Users/engineer/workspace/vagrant_aws_exploration/Vagrantfile:5]
INFO loader: Loading configuration in order: [:default, :home, :root, :vm_testbox]
DEBUG loader: Loading from: default (cache)
DEBUG loader: Loading from: root (cache)
DEBUG loader: Loading from: vm_testbox (evaluating)
DEBUG loader: Configuration loaded successfully, finalizing and returning
INFO box_collection: Searching for box: opscode-ubuntu-12.04 (virtualbox) in /Users/engineer/.vagrant.d/boxes/opscode-ubuntu-12.04/virtualbox/metadata.json
INFO box_collection: Box found: opscode-ubuntu-12.04 (virtualbox)
INFO environment: Box exists with Vagrantfile. Reloading machine config.
INFO loader: Set :"box_opscode-ubuntu-12.04_virtualbox" = #Pathname:/Users/engineer/.vagrant.d/boxes/opscode-ubuntu-12.04/virtualbox/Vagrantfile
DEBUG loader: Populating proc cache for #Pathname:/Users/engineer/.vagrant.d/boxes/opscode-ubuntu-12.04/virtualbox/Vagrantfile
DEBUG loader: Load procs for pathname: /Users/engineer/.vagrant.d/boxes/opscode-ubuntu-12.04/virtualbox/Vagrantfile
INFO loader: Loading configuration in order: [:default, :"box_opscode-ubuntu-12.04_virtualbox", :home, :root, :vm_testbox]
DEBUG loader: Loading from: default (cache)
DEBUG loader: Loading from: box_opscode-ubuntu-12.04_virtualbox (evaluating)
DEBUG loader: Upgrading config from version 1 to 2
DEBUG loader: Upgrading config to version 2
DEBUG loader: Upgraded to version 2 with 0 warnings and 0 errors
DEBUG loader: Loading from: root (cache)
DEBUG loader: Loading from: vm_testbox (cache)
DEBUG loader: Configuration loaded successfully, finalizing and returning
INFO machine: Initializing machine: testbox
INFO machine: - Provider: VagrantPlugins::ProviderVirtualBox::Provider
INFO machine: - Box: #Vagrant::Box:0x00000100c666e0
INFO machine: - Data dir: /Users/engineer/workspace/vagrant_aws_exploration/.vagrant/machines/testbox/virtualbox
DEBUG virtualbox: Instantiating the driver for machine ID: nil
INFO base: VBoxManage path: VBoxManage
INFO subprocess: Starting process: ["VBoxManage", "--version"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: 4.2.6r82870
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG meta: Finding driver for VirtualBox version: 4.2.6
INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_2
INFO base: VBoxManage path: VBoxManage
INFO command: With machine: testbox (VirtualBox (new VM))
INFO interface: info: Bringing machine 'testbox' up with 'virtualbox' provider...
Bringing machine 'testbox' up with 'virtualbox' provider...
INFO machine: Calling action: up on provider VirtualBox (new VM)
INFO runner: Running action: #Vagrant::Action::Builder:0x00000100abdc80
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x00000100940628
INFO base: VBoxManage path: VBoxManage
INFO subprocess: Starting process: ["VBoxManage", "--version"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: 4.2.6r82870
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG meta: Finding driver for VirtualBox version: 4.2.6
INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_2
INFO base: VBoxManage path: VBoxManage
INFO subprocess: Starting process: ["VBoxManage", "list", "hostonlyifs"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: Name: vboxnet0
GUID: 786f6276-656e-4074-8000-0a0027000000
DHCP: Disabled
IPAddress: 192.168.42.1
NetworkMask: 255.255.255.0
IPV6Address:
IPV6NetworkMaskPrefixLength: 0
HardwareAddress: 0a:00:27:00:00:00
MediumType: Ethernet
Status: Up
VBoxNetworkName: HostInterfaceNetworking-vboxnet0

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

DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #Vagrant::Action::Builtin::ConfigValidate:0x00000100940600
INFO warden: Calling action: #Vagrant::Action::Builtin::Call:0x000001009405d8
INFO runner: Running action: #Vagrant::Action::Builder:0x00000100c5ed00
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000100c5cf50
INFO runner: Running action: #Vagrant::Action::Warden:0x00000100bc6c30
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::CheckAccessible:0x00000100bc6b90
INFO warden: Calling action: #Vagrant::Action::Builtin::HandleBoxUrl:0x00000100bc6b68
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::Import:0x00000100bc6b40
INFO interface: info: Importing base box 'opscode-ubuntu-12.04'...
[testbox] Importing base box 'opscode-ubuntu-12.04'...
INFO subprocess: Starting process: ["VBoxManage", "import", "/Users/engineer/.vagrant.d/boxes/opscode-ubuntu-12.04/virtualbox/box.ovf"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stderr: 0%...
DEBUG subprocess: stderr: 10%...20%...30%...40%...50%...60%...70%...80%...90%...
DEBUG subprocess: stderr: 100%
Interpreting /Users/engineer/.vagrant.d/boxes/opscode-ubuntu-12.04/virtualbox/box.ovf...
DEBUG subprocess: stderr: OK.
DEBUG subprocess: stderr: 0%...
DEBUG subprocess: stderr: 10%...

INFO interface: info: Progress: 10%
[testbox] Progress: 10%DEBUG subprocess: stderr: 20%...

INFO interface: info: Progress: 20%
[testbox] Progress: 20%DEBUG subprocess: stderr: 30%...

INFO interface: info: Progress: 30%
[testbox] Progress: 30%DEBUG subprocess: stderr: 40%...

INFO interface: info: Progress: 40%
[testbox] Progress: 40%DEBUG subprocess: stderr: 50%...

INFO interface: info: Progress: 50%
[testbox] Progress: 50%DEBUG subprocess: stderr: 60%...

INFO interface: info: Progress: 60%
[testbox] Progress: 60%DEBUG subprocess: stderr: 70%...80%...90%...

INFO interface: info: Progress: 90%
[testbox] Progress: 90%DEBUG subprocess: stderr: 100%
DEBUG subprocess: stdout: Disks: vmdisk1 42949672960 -1 http://www.vmware.com/interfaces/specifications/vmdk.html#streamOptimized box-disk1.vmdk -1 -1
Virtual system 0:
0: Suggested OS type: "Ubuntu_64"
(change with "--vsys 0 --ostype "; use "list ostypes" to list all possible values)
1: Suggested VM name "ubuntu-12.04"
(change with "--vsys 0 --vmname ")
2: Number of CPUs: 1
(change with "--vsys 0 --cpus ")
3: Guest memory: 384 MB
(change with "--vsys 0 --memory ")
4: Network adapter: orig NAT, config 3, extra slot=0;type=NAT
5: CD-ROM
(disable with "--vsys 0 --unit 5 --ignore")
6: IDE controller, type PIIX4
(disable with "--vsys 0 --unit 6 --ignore")
7: IDE controller, type PIIX4
(disable with "--vsys 0 --unit 7 --ignore")
8: SATA controller, type AHCI
(disable with "--vsys 0 --unit 8 --ignore")
9: Hard disk image: source image=box-disk1.vmdk, target path=/Users/engineer/VirtualBox VMs/ubuntu-12.04/box-disk1.vmdk, controller=8;channel=0
(change target path with "--vsys 0 --unit 9 --disk path";
disable with "--vsys 0 --unit 9 --ignore")
Successfully imported the appliance.
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31985
DEBUG subprocess: Exit status: 0
INFO subprocess: Starting process: ["VBoxManage", "list", "vms"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: "chef_1358211975" {eb5892bc-9242-4c58-a029-4a24e3ed7bba}
"tracktastic_1360263600" {246ad679-2cc2-4748-bb20-027c8d62e210}
"tracktastic_1360284078" {157ec768-3475-4b90-aff9-d858405ab883}
"agora_1363038425" {e570af98-7acd-47d9-ac57-e103b4bdbb6f}
"nexus_1363200399" {914a843b-cb9a-42ec-bbc4-451c0e221aa1}
"ubuntu-12.04" {486150c1-f3b7-4d5f-9fee-f5146b2d3af2}
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox: Instantiating the driver for machine ID: "486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
INFO base: VBoxManage path: VBoxManage
INFO subprocess: Starting process: ["VBoxManage", "--version"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: 4.2.6r82870
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG meta: Finding driver for VirtualBox version: 4.2.6
INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_2
INFO base: VBoxManage path: VBoxManage
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: Name: ubuntu-12.04
Groups: /
Guest OS: Ubuntu (64 bit)
UUID: 486150c1-f3b7-4d5f-9fee-f5146b2d3af2
Config file: /Users/engineer/VirtualBox VMs/ubuntu-12.04/ubuntu-12.04.vbox
Snapshot folder: /Users/engineer/VirtualBox VMs/ubuntu-12.04/Snapshots
Log folder: /Users/engineer/VirtualBox VMs/ubuntu-12.04/Logs
Hardware UUID: 486150c1-f3b7-4d5f-9fee-f5146b2d3af2
Memory size: 384MB
Page Fusion: off
VRAM size: 8MB
CPU exec cap: 100%
HPET: off
Chipset: piix3
Firmware: BIOS
Number of CPUs: 1
Synthetic Cpu: off
CPUID overrides: None
Boot menu mode: message and menu
Boot Device (1): HardDisk
Boot Device (2): DVD
Boot Device (3): Not Assigned
Boot Device (4): Not Assigned
ACPI: on
IOAPIC: on
PAE: on
Time offset: 0ms
RTC: local time
Hardw. virt.ext: on
Hardw. virt.ext exclusive: off
Nested Paging: on
Large Pages: on
VT-x VPID: on
State: powered off (since 2013-01-23T18:37:15.000000000)
Monitor count: 1
3D Acceleration: off
2D Video Acceleration: off
Teleporter Enabled: off
Teleporter Port: 0
Teleporter Address:
Teleporter Password:
Tracing Enabled: off
Allow Tracing to Access VM: off
Tracing Configuration:
Autostart Enabled: off
Autostart Delay: 0
Storage Controller Name (0): IDE Controller
Storage Controller Type (0): PIIX4
Storage Controller Instance Number (0): 0
Storage Controller Max Port Count (0): 2
Storage Controller Port Count (0): 2
Storage Controller Bootable (0): on
Storage Controller Name (1): SATA Controller
Storage Controller Type (1): IntelAhci
Storage Controller Instance Number (1): 0
Storage Controller Max Port Count (1): 30
Storage Controller Port Count (1): 1
Storage Controller Bootable (1): on
IDE Controller (0, 0): Empty
IDE Controller (1, 0): Empty
SATA Controller (0, 0): /Users/engineer/VirtualBox VMs/ubuntu-12.04/box-disk1.vmdk (UUID: 2874564c-eb13-4d6e-acde-d714844aaa1f)
NIC 1: MAC: 08002719D816, Attachment: NAT, Cable connected: on, Trace: off (file: none), Type: 82540EM, Reported speed: 0 Mbps, Boot priority: 0, Promisc Policy: deny, Bandwidth group: none
NIC 1 Settings: MTU: 0, Socket (send: 64, receive: 64), TCP Window (send:64, receive: 64)
NIC 2: disabled
NIC 3: disabled
NIC 4: disabled
NIC 5: disabled
NIC 6: disabled
NIC 7: disabled
NIC 8: disabled
Pointing Device: PS/2 Mouse
Keyboard Device: PS/2 Keyboard
UART 1: disabled
UART 2: disabled
LPT 1: disabled
LPT 2: disabled
Audio: disabled
Clipboard Mode: disabled
Drag'n'drop Mode: disabled
VRDE: disabled
USB: disabled
EHCI: disabled

USB Device Filters:

Available remote USB devices:

Currently Attached USB Devices:

Bandwidth groups:

Shared folders:

VRDE Connection: not active
Clients so far: 0

Guest:

Configured memory balloon size: 0 MB

DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0

INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::CheckGuestAdditions:0x00000100bc6ac8
INFO subprocess: Starting process: ["VBoxManage", "guestproperty", "get", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "/VirtualBox/GuestAdd/Version"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: Value: 4.2.6
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::MatchMACAddress:0x00000100bc6aa0
INFO interface: info: Matching MAC address for NAT networking...
[testbox] Matching MAC address for NAT networking...
INFO subprocess: Starting process: ["VBoxManage", "modifyvm", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--macaddress1", "080027B951E5"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x00000100940538
INFO base: VBoxManage path: VBoxManage
INFO subprocess: Starting process: ["VBoxManage", "--version"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: 4.2.6r82870
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG meta: Finding driver for VirtualBox version: 4.2.6
INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_2
INFO base: VBoxManage path: VBoxManage
INFO subprocess: Starting process: ["VBoxManage", "list", "hostonlyifs"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: Name: vboxnet0
GUID: 786f6276-656e-4074-8000-0a0027000000
DHCP: Disabled
IPAddress: 192.168.42.1
NetworkMask: 255.255.255.0
IPV6Address:
IPV6NetworkMaskPrefixLength: 0
HardwareAddress: 0a:00:27:00:00:00
MediumType: Ethernet
Status: Up
VBoxNetworkName: HostInterfaceNetworking-vboxnet0

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

DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #Vagrant::Action::Builtin::ConfigValidate:0x00000100940510
INFO warden: Calling action: #Vagrant::Action::Builtin::Call:0x000001009404e8
INFO runner: Running action: #Vagrant::Action::Builder:0x00000100cae760
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::IsRunning:0x00000100cac820
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="ubuntu-12.04"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/ubuntu-12.04/ubuntu-12.04.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/ubuntu-12.04/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/ubuntu-12.04/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-01-23T18:37:15.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/ubuntu-12.04/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO runner: Running action: #Vagrant::Action::Warden:0x00000100cbb4d8
INFO warden: Calling action: #Vagrant::Action::Builtin::Call:0x00000100cbb2d0
INFO runner: Running action: #Vagrant::Action::Builder:0x00000100be17d8
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::IsSaved:0x00000100bbe5f8
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO

@russellcardullo
Copy link
Author

DEBUG subprocess: stdout: name="ubuntu-12.04"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/ubuntu-12.04/ubuntu-12.04.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/ubuntu-12.04/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/ubuntu-12.04/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-01-23T18:37:15.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/ubuntu-12.04/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO runner: Running action: #Vagrant::Action::Warden:0x00000100a5dfd8
INFO warden: Calling action: #Vagrant::Action::Builtin::Call:0x00000100a5dec0
INFO runner: Running action: #Vagrant::Action::Builder:0x00000100858bc0
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::IsPaused:0x00000100854ed0
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="ubuntu-12.04"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/ubuntu-12.04/ubuntu-12.04.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/ubuntu-12.04/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/ubuntu-12.04/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-01-23T18:37:15.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/ubuntu-12.04/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO runner: Running action: #Vagrant::Action::Warden:0x00000100ba7b50
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::CheckAccessible:0x00000100ba7a88
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="ubuntu-12.04"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/ubuntu-12.04/ubuntu-12.04.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/ubuntu-12.04/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/ubuntu-12.04/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-01-23T18:37:15.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0":0
napFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-01-23T18:37:15.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #Vagrant::Action::Builtin::Provision:0x00000100c52a00
INFO warden: Calling action: #Vagrant::Action::Builtin::EnvSet:0x00000100c95d78
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::PrepareForwardedPortCollisionParams:0x00000100c95d50
INFO subprocess: Starting process: ["VBoxManage", "list", "vms"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: "chef_1358211975" {eb5892bc-9242-4c58-a029-4a24e3ed7bba}
"tracktastic_1360263600" {246ad679-2cc2-4748-bb20-027c8d62e210}
"tracktastic_1360284078" {157ec768-3475-4b90-aff9-d858405ab883}
"agora_1363038425" {e570af98-7acd-47d9-ac57-e103b4bdbb6f}
"nexus_1363200399" {914a843b-cb9a-42ec-bbc4-451c0e221aa1}
"vagrant_aws_exploration_1363373367" {486150c1-f3b7-4d5f-9fee-f5146b2d3af2}
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_2: read_forward_ports: uuid=eb5892bc-9242-4c58-a029-4a24e3ed7bba active_only=true
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "eb5892bc-9242-4c58-a029-4a24e3ed7bba", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="chef_1358211975"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="eb5892bc-9242-4c58-a029-4a24e3ed7bba"
CfgFile="/Users/engineer/VirtualBox VMs/chef_1358211975/chef_1358211975.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/chef_1358211975/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/chef_1358211975/Logs"
hardwareuuid="eb5892bc-9242-4c58-a029-4a24e3ed7bba"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="aborted"
VMStateChangeTime="2013-01-16T18:30:55.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/chef_1358211975/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="d17d1201-495f-4be8-b380-55e16e270feb"
natnet1="nat"
macaddress1="080027880CA6"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,,2222,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="v-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/Creatorious/chef"
SharedFolderNameMachineMapping2="v-csc-1"
SharedFolderPathMachineMapping2="/Users/engineer/workspace/Creatorious/chef/cookbooks"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_2: read_forward_ports: uuid=246ad679-2cc2-4748-bb20-027c8d62e210 active_only=true
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "246ad679-2cc2-4748-bb20-027c8d62e210", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="tracktastic_1360263600"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="246ad679-2cc2-4748-bb20-027c8d62e210"
CfgFile="/Users/engineer/VirtualBox VMs/tracktastic_1360263600/tracktastic_1360263600.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/tracktastic_1360263600/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/tracktastic_1360263600/Logs"
hardwareuuid="246ad679-2cc2-4748-bb20-027c8d62e210"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="aborted"
VMStateChangeTime="2013-02-20T23:40:50.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/tracktastic_1360263600/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="9e4f5956-4ce4-436a-a739-1b0264dfc1f5"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,,2200,,22"
hostonlyadapter2="vboxnet0"
macaddress2="080027532B2F"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="v-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/tracktastic"
SharedFolderNameMachineMapping2="v-csc-1"
SharedFolderPathMachineMapping2="/Users/engineer/workspace/tracktastic/chef/cookbooks"
SharedFolderNameMachineMapping3="v-csc-2"
SharedFolderPathMachineMapping3="/Users/engineer/workspace/tracktastic/chef/site-cookbooks"
SharedFolderNameMachineMapping4="v-csr-3"
SharedFolderPathMachineMapping4="/Users/engineer/workspace/tracktastic/chef/roles"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_2: read_forward_ports: uuid=157ec768-3475-4b90-aff9-d858405ab883 active_only=true
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "157ec768-3475-4b90-aff9-d858405ab883", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="tracktastic_1360284078"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="157ec768-3475-4b90-aff9-d858405ab883"
CfgFile="/Users/engineer/VirtualBox VMs/tracktastic_1360284078/tracktastic_1360284078.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/tracktastic_1360284078/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/tracktastic_1360284078/Logs"
hardwareuuid="157ec768-3475-4b90-aff9-d858405ab883"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-02-08T18:09:01.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/tracktastic_1360284078/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="c9ab9bbb-4b5d-44f8-8c32-e1b130657150"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,,2203,,22"
hostonlyadapter2="vboxnet0"
macaddress2="080027E31C5B"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="v-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/tracktastic"
SharedFolderNameMachineMapping2="v-csc-1"
SharedFolderPathMachineMapping2="/Users/engineer/workspace/tracktastic/chef/cookbooks"
SharedFolderNameMachineMapping3="v-csc-2"
SharedFolderPathMachineMapping3="/Users/engineer/workspace/tracktastic/chef/site-cookbooks"
SharedFolderNameMachineMapping4="v-csr-3"
SharedFolderPathMachineMapping4="/Users/engineer/workspace/tracktastic/chef/roles"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_2: read_forward_ports: uuid=e570af98-7acd-47d9-ac57-e103b4bdbb6f active_only=true
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "e570af98-7acd-47d9-ac57-e103b4bdbb6f", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="agora_1363038425"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="e570af98-7acd-47d9-ac57-e103b4bdbb6f"
CfgFile="/Users/engineer/VirtualBox VMs/agora_1363038425/agora_1363038425.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/agora_1363038425/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/agora_1363038425/Logs"
hardwareuuid="e570af98-7acd-47d9-ac57-e103b4bdbb6f"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="running"
VMStateChangeTime="2013-03-15T16:32:04.211000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/agora_1363038425/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="e080b0d4-b559-4f8f-b7bd-c9485e8e6bbb"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,,2222,,22"
hostonlyadapter2="vboxnet1"
macaddress2="080027295AF2"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
VideoMode="640,480,32"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="v-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/agora"
SharedFolderNameMachineMapping2="v-csc-1"
SharedFolderPathMachineMapping2="/Users/engineer/workspace/agora/chef/cookbooks"
SharedFolderNameMachineMapping3="v-csc-2"
SharedFolderPathMachineMapping3="/Users/engineer/workspace/agora/chef/site-cookbooks"
SharedFolderNameMachineMapping4="v-csr-3"
SharedFolderPathMachineMapping4="/Users/engineer/workspace/agora/chef/roles"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.2.6 r82870"
GuestAdditionsFacility_VirtualBox Base Driver=50,1363038434696
GuestAdditionsFacility_VirtualBox System Service=50,1363038437129
GuestAdditionsFacility_Seamless Mode=0,1363038434696
GuestAdditionsFacility_Graphics Mode=0,1363038434696
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_2: - [1, "ssh", 2222, 22]
DEBUG virtualbox_4_2: read_forward_ports: uuid=914a843b-cb9a-42ec-bbc4-451c0e221aa1 active_only=true
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "914a843b-cb9a-42ec-bbc4-451c0e221aa1", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="nexus_1363200399"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="914a843b-cb9a-42ec-bbc4-451c0e221aa1"
CfgFile="/Users/engineer/VirtualBox VMs/nexus_1363200399/nexus_1363200399.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/nexus_1363200399/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/nexus_1363200399/Logs"
hardwareuuid="914a843b-cb9a-42ec-bbc4-451c0e221aa1"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="running"
VMStateChangeTime="2013-03-15T16:32:04.218000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/nexus_1363200399/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="77070468-f5a2-4f89-ab6f-65652f3e9d82"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="7sh-7sh,tcp,,8081,,8081"
Forwarding(1)="ssh,tcp,,2200,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
VideoMode="640,480,32"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="v-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/nexus"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.2.6 r82870"
GuestAdditionsFacility_VirtualBox Base Driver=50,1363200408089
GuestAdditionsFacility_VirtualBox System Service=50,1363200410638
GuestAdditionsFacility_Seamless Mode=0,1363200408089
GuestAdditionsFacility_Graphics Mode=0,1363200408089
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_2: - [1, "7sh-7sh", 8081, 8081]
DEBUG virtualbox_4_2: - [1, "ssh", 2200, 22]
DEBUG virtualbox_4_2: read_forward_ports: uuid=486150c1-f3b7-4d5f-9fee-f5146b2d3af2 active_only=false
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="vagrant_aws_exploration_1363373367"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/vagrant_aws_exploration_1363373367.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-01-23T18:37:15.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #Vagrant::Action::Builtin::HandleForwardedPortCollisions:0x00000100c95d28
DEBUG handle_port_collisions: Detecting any forwarded port collisions...
INFO handle_port_collisions: Attempting to repair FP collision: 2222
INFO handle_port_collisions: Repaired FP collision: 2222 to 2201
INFO interface: info: Fixed port collision for 22 => 2222. Now on port 2201.
[testbox] Fixed port collision for 22 => 2222. Now on port 2201.
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::PruneNFSExports:0x00000100ced4d8
INFO subprocess: Starting process: ["VBoxManage", "list", "vms"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: "chef_1358211975" {eb5892bc-9242-4c58-a029-4a24e3ed7bba}
"tracktastic_1360263600" {246ad679-2cc2-4748-bb20-027c8d62e210}
"tracktastic_1360284078" {157ec768-3475-4b90-aff9-d858405ab883}
"agora_1363038425" {e570af98-7acd-47d9-ac57-e103b4bdbb6f}
"nexus_1363200399" {914a843b-cb9a-42ec-bbc4-451c0e221aa1}
"vagrant_aws_exploration_1363373367" {486150c1-f3b7-4d5f-9fee-f5146b2d3af2}
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #Vagrant::Action::Builtin::NFS:0x00000100ced488
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::PrepareNFSSettings:0x00000100cfdc98
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::ClearSharedFolders:0x00000100c9c1f0
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="vagrant_aws_exploration_1363373367"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/vagrant_aws_exploration_1363373367.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-01-23T18:37:15.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::ShareFolders:0x00000100c9c1a0
INFO interface: info: Creating shared folders metadata...
[testbox] Creating shared folders metadata...
INFO subprocess: Starting process: ["VBoxManage", "sharedfolder", "add", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--name", "vagrant-root", "--hostpath", "/Users/engineer/workspace/vagrant_aws_exploration"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO subprocess: Starting process: ["VBoxManage", "setextradata", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "VBoxInternal2/SharedFoldersEnableSymlinksCreate/vagrant-root", "1"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::ClearNetworkInterfaces:0x00000100c50f98
INFO interface: info: Clearing any previously set network interfaces...
[testbox] Clearing any previously set network interfaces...
INFO subprocess: Starting process: ["VBoxManage", "modifyvm", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--nic2", "none", "--nic3", "none", "--nic4", "none", "--nic5", "none", "--nic6", "none", "--nic7", "none", "--nic8", "none"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::Network:0x00000100c50f20
DEBUG network: Available slots for high-level adapters: #<Set: {2, 3, 4, 5, 6, 7, 8}>
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.
DEBUG network: Normalized configuration: {:auto_config=>false, :adapter=>1}
DEBUG network: Adapter configuration: {:adapter=>1, :type=>:nat}
INFO network: Enabling adapters...
INFO interface: info: Preparing network interfaces based on configuration...
[testbox] Preparing network interfaces based on configuration...
INFO subprocess: Starting process: ["VBoxManage", "modifyvm", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--nic1", "nat"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::ForwardPorts:0x00000100ba9130
INFO interface: info: Forwarding ports...
[testbox] Forwarding ports...
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="vagrant_aws_exploration_1363373367"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/vagrant_aws_exploration_1363373367.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="poweroff"
VMStateChangeTime="2013-01-23T18:37:15.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="vagrant-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/vagrant_aws_exploration"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO interface: info: -- 22 => 2201 (adapter 1)
[testbox] -- 22 => 2201 (adapter 1)
INFO subprocess: Starting process: ["VBoxManage", "modifyvm", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--natpf1", "ssh,tcp,,2201,,22"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
INFO warden: Calling action: #Vagrant::Action::Builtin::SetHostname:0x00000100ba9108
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::SaneDefaults:0x00000100ba90e0
INFO subprocess: Starting process: ["VBoxManage", "storagectl", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--name", "SATA Controller", "--hostiocache", "on"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO sanedefaults: Enabling the Host I/O cache on the SATA controller... (exit status = 0)
INFO sanedefaults: Automatically figuring out whether to enable/disable NAT DNS proxy...
INFO subprocess: Starting process: ["VBoxManage", "modifyvm", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--natdnsproxy1", "on"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO sanedefaults: Enable the NAT DNS proxy on adapter 1... (exit status = 0)
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::Customize:0x00000100a74788
INFO warden: Calling action: #VagrantPlugins::ProviderVirtualBox::Action::Boot:0x00000100a74670
INFO interface: info: Booting VM...
[testbox] Booting VM...
INFO subprocess: Starting process: ["VBoxManage", "startvm", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--type", "headless"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: Waiting for VM "486150c1-f3b7-4d5f-9fee-f5146b2d3af2" to power on...
VM "486150c1-f3b7-4d5f-9fee-f5146b2d3af2" has been successfully started.
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
INFO interface: info: Waiting for VM to boot. This can take a few minutes.
[testbox] Waiting for VM to boot. This can take a few minutes.
DEBUG ssh: Checking whether SSH is ready...
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="vagrant_aws_exploration_1363373367"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/vagrant_aws_exploration_1363373367.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="running"
VMStateChangeTime="2013-03-15T18:49:29.326000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,,2201,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
VideoMode="640,480,32"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="vagrant-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/vagrant_aws_exploration"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
GuestOSType="Ubuntu_64"
GuestAdditionsRunLevel=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_2: Searching for SSH port: 22
DEBUG virtualbox_4_2: read_forward_ports: uuid=486150c1-f3b7-4d5f-9fee-f5146b2d3af2 active_only=false
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="vagrant_aws_exploration_1363373367"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/vagrant_aws_exploration_1363373367.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="running"
VMStateChangeTime="2013-03-15T18:49:29.326000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,,2201,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
VideoMode="640,480,32"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="vagrant-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/vagrant_aws_exploration"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
GuestOSType="Ubuntu_64"
GuestAdditionsRunLevel=0
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_4_2: - [1, "ssh", 2201, 22]
DEBUG ssh: Checking key permissions: /Users/engineer/.vagrant.d/insecure_private_key
INFO ssh: Attempting SSH. Retries: 100. Timeout: 30
INFO ssh: Attempting to connect to SSH: 127.0.0.1:2201

DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2013-03-15T11:49:29.618670 #92297] DEBUG -- net.ssh.transport.session[82806e48]: establishing connection to 127.0.0.1:2201
D, [2013-03-15T11:49:29.620786 #92297] DEBUG -- net.ssh.transport.session[82806e48]: connection established
I, [2013-03-15T11:49:29.621100 #92297] INFO -- net.ssh.transport.server_version[82805e58]: negotiating protocol version
D, [2013-03-15T11:49:49.263905 #92297] DEBUG -- net.ssh.transport.server_version[82805e58]: remote is SSH-2.0-OpenSSH_5.9p1 Debian-5ubuntu1' D, [2013-03-15T11:49:49.264075 #92297] DEBUG -- net.ssh.transport.server_version[82805e58]: local isSSH-2.0-Ruby/Net::SSH_2.2.2 universal.x86_64-darwin12.2.1'
D, [2013-03-15T11:49:49.265245 #92297] DEBUG -- tcpsocket[828063f8]: read 984 bytes
D, [2013-03-15T11:49:49.265475 #92297] DEBUG -- tcpsocket[828063f8]: received packet nr 0 type 20 len 980
I, [2013-03-15T11:49:49.265646 #92297] INFO -- net.ssh.transport.algorithms[82808ce8]: got KEXINIT from server
I, [2013-03-15T11:49:49.266107 #92297] INFO -- net.ssh.transport.algorithms[82808ce8]: sending KEXINIT
D, [2013-03-15T11:49:49.266437 #92297] DEBUG -- tcpsocket[828063f8]: queueing packet nr 0 type 20 len 556
D, [2013-03-15T11:49:49.266559 #92297] DEBUG -- tcpsocket[828063f8]: sent 560 bytes
I, [2013-03-15T11:49:49.266640 #92297] INFO -- net.ssh.transport.algorithms[82808ce8]: negotiating algorithms
D, [2013-03-15T11:49:49.267380 #92297] DEBUG -- net.ssh.transport.algorithms[82808ce8]: negotiated:

  • kex: diffie-hellman-group-exchange-sha1
  • host_key: ssh-rsa
  • encryption_server: aes128-cbc
  • encryption_client: aes128-cbc
  • hmac_client: hmac-sha1
  • hmac_server: hmac-sha1
  • compression_client: none
  • compression_server: none
  • language_client:
  • language_server:
    D, [2013-03-15T11:49:49.267477 #92297] DEBUG -- net.ssh.transport.algorithms[82808ce8]: exchanging keys
    D, [2013-03-15T11:49:49.267920 #92297] DEBUG -- tcpsocket[828063f8]: queueing packet nr 1 type 34 len 20
    D, [2013-03-15T11:49:49.268069 #92297] DEBUG -- tcpsocket[828063f8]: sent 24 bytes
    D, [2013-03-15T11:49:49.271030 #92297] DEBUG -- tcpsocket[828063f8]: read 152 bytes
    D, [2013-03-15T11:49:49.271247 #92297] DEBUG -- tcpsocket[828063f8]: received packet nr 1 type 31 len 148
    D, [2013-03-15T11:49:49.274182 #92297] DEBUG -- tcpsocket[828063f8]: queueing packet nr 2 type 32 len 140
    D, [2013-03-15T11:49:49.274293 #92297] DEBUG -- tcpsocket[828063f8]: sent 144 bytes
    D, [2013-03-15T11:49:49.277322 #92297] DEBUG -- tcpsocket[828063f8]: read 720 bytes
    D, [2013-03-15T11:49:49.277545 #92297] DEBUG -- tcpsocket[828063f8]: received packet nr 2 type 33 len 700
    D, [2013-03-15T11:49:49.279358 #92297] DEBUG -- tcpsocket[828063f8]: queueing packet nr 3 type 21 len 20
    D, [2013-03-15T11:49:49.279476 #92297] DEBUG -- tcpsocket[828063f8]: sent 24 bytes
    D, [2013-03-15T11:49:49.279632 #92297] DEBUG -- tcpsocket[828063f8]: received packet nr 3 type 21 len 12
    D, [2013-03-15T11:49:49.280109 #92297] DEBUG -- net.ssh.authentication.session[828156a0]: beginning authentication of `ubuntu'
    D, [2013-03-15T11:49:49.280324 #92297] DEBUG -- tcpsocket[828063f8]: queueing packet nr 4 type 5 len 28
    D, [2013-03-15T11:49:49.280426 #92297] DEBUG -- tcpsocket[828063f8]: sent 52 bytes
    D, [2013-03-15T11:49:49.280825 #92297] DEBUG -- tcpsocket[828063f8]: read 52 bytes
    D, [2013-03-15T11:49:49.281000 #92297] DEBUG -- tcpsocket[828063f8]: received packet nr 4 type 6 len 28
    D, [2013-03-15T11:49:49.281168 #92297] DEBUG -- net.ssh.authentication.session[828156a0]: trying none
    D, [2013-03-15T11:49:49.281447 #92297] DEBUG -- net.ssh.authentication.session[828156a0]: Mechanism none was requested, but isn't a known type. Ignoring it.
    D, [2013-03-15T11:49:49.281520 #92297] DEBUG -- net.ssh.authentication.session[828156a0]: trying publickey
    D, [2013-03-15T11:49:49.281988 #92297] DEBUG -- net.ssh.authentication.agent[8281a90c]: connecting to ssh-agent
    D, [2013-03-15T11:49:49.282170 #92297] DEBUG -- net.ssh.authentication.agent[8281a90c]: sending agent request 1 len 61
    D, [2013-03-15T11:49:49.282301 #92297] DEBUG -- net.ssh.authentication.agent[8281a90c]: received agent packet 2 len 5
    D, [2013-03-15T11:49:49.282390 #92297] DEBUG -- net.ssh.authentication.agent[8281a90c]: sending agent request 11 len 0
    D, [2013-03-15T11:49:49.282584 #92297] DEBUG -- net.ssh.authentication.agent[8281a90c]: received agent packet 12 len 5
    D, [2013-03-15T11:49:49.282821 #92297] DEBUG -- net.ssh.authentication.methods.publickey[8281ab14]: trying publickey (dd:3b:b8:2e:85:04:06:e9:ab:ff:a8:0a:c0:04:6e:d6)
    D, [2013-03-15T11:49:49.283048 #92297] DEBUG -- tcpsocket[828063f8]: queueing packet nr 5 type 50 len 348
    D, [2013-03-15T11:49:49.283147 #92297] DEBUG -- tcpsocket[828063f8]: sent 372 bytes
    D, [2013-03-15T11:49:49.286332 #92297] DEBUG -- tcpsocket[828063f8]: read 68 bytes
    D, [2013-03-15T11:49:49.286482 #92297] DEBUG -- tcpsocket[828063f8]: received packet nr 5 type 51 len 44
    D, [2013-03-15T11:49:49.286625 #92297] DEBUG -- net.ssh.authentication.session[828156a0]: allowed methods: publickey,password
    D, [2013-03-15T11:49:49.286708 #92297] DEBUG -- net.ssh.authentication.session[828156a0]: trying password
    E, [2013-03-15T11:49:49.286813 #92297] ERROR -- net.ssh.authentication.session[828156a0]: all authorization methods failed (tried none, publickey, password)

DEBUG ssh: == Net-SSH connection debug-level log END ==
INFO ssh: SSH not up: #<Vagrant::Errors::SSHAuthenticationFailed: SSH authentication failed! This is typically caused by the public/private
keypair for the SSH user not being properly set on the guest VM. Please
verify that the guest VM is setup with the proper public key, and that
the private key path for Vagrant is setup properly as well.>
INFO subprocess: Starting process: ["VBoxManage", "showvminfo", "486150c1-f3b7-4d5f-9fee-f5146b2d3af2", "--machinereadable"]
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="vagrant_aws_exploration_1363373367"
groups="/"
ostype="Ubuntu (64 bit)"
UUID="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
CfgFile="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/vagrant_aws_exploration_1363373367.vbox"
SnapFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Snapshots"
LogFldr="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/Logs"
hardwareuuid="486150c1-f3b7-4d5f-9fee-f5146b2d3af2"
memory=384
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=1
synthcpu="off"
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
pae="on"
Time offset=0rtcuseutc="off"
hwvirtex="on"
hwvirtexexcl="off"
nestedpaging="on"
largepages="on"
vtxvpid="on"
VMState="running"
VMStateChangeTime="2013-03-15T18:49:29.326000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
storagecontrollername1="SATA Controller"
storagecontrollertype1="IntelAhci"
storagecontrollerinstance1="0"
storagecontrollermaxportcount1="30"
storagecontrollerportcount1="1"
storagecontrollerbootable1="on"
"IDE Controller-0-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="emptydrive"
"IDE Controller-IsEjected"="off"
"IDE Controller-1-1"="none"
"SATA Controller-0-0"="/Users/engineer/VirtualBox VMs/vagrant_aws_exploration_1363373367/box-disk1.vmdk"
"SATA Controller-ImageUUID-0-0"="2874564c-eb13-4d6e-acde-d714844aaa1f"
natnet1="nat"
macaddress1="080027B951E5"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,,2201,,22"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
lpt1="off"
lpt2="off"
audio="none"
clipboard="disabled"
draganddrop="disabled"
VideoMode="640,480,32"
vrde="off"
usb="off"
ehci="off"
SharedFolderNameMachineMapping1="vagrant-root"
SharedFolderPathMachineMapping1="/Users/engineer/workspace/vagrant_aws_exploration"
VRDEActiveConnection="off"
VRDEClients=0
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="4.2.6 r82870"
GuestAdditionsFacility_VirtualBox Base Driver=50,1363373376483
GuestAdditionsFacility_VirtualBox System Service=50,1363373378979
GuestAdditionsFacility_Seamless Mode=0,1363373376479
GuestAdditionsFacility_Graphics Mode=0,1363373376479
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000
DEBUG subprocess: Exit status: 0

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment