search

c10l / vagrant-butcher

Delete Chef client and node when destroying Vagrant VM
MIT License
124 stars 12 forks source link

Butcher doesn't copy pem file on Vagrant 1.6.2 with Windows guests #50

Closed dawilliams closed 10 years ago

dawilliams commented 10 years ago

When I run Vagrant up webserver for example I see the following log message. Saved client key to /Users/dwilliams/cookbook/.vagrant/butcher/state-client.pem but that file is not copied. The directory exists but the file is not copied.

Environment: Vagrant 1.6.2 Multi Machine VagrantFile

Vagrant Plugins vagrant-butcher 2.1.5 Chef 11.12.4 vagrant-omnibus 1.4.1

Host: Mac Mountain Lion Guest: Windows 2012 STD

Butcher Config in VagrantFile config.butcher.enabled = true config.butcher.guest_key_path = '/etc/chef/client.pem'

c10l commented 10 years ago

Hey @dawilliams, Thanks for reporting this, and sorry for taking so long to respond. I don't even know how to start testing this on a Windows guest (sorry, never had to run Chef on Windows), but I do have an idea as to why this is happening. First of all, is the Chef configuration on your guest located in /etc/chef/client.pem? I believe the default location in Windows is c:\chef\client.pem. Could you confirm that and try changing the value of config.butcher.guest_key_path and report back? I don't have a Windows guest to try this out unfortunately. Also if you could paste the output of VAGRANT_LOG=debug vagrant up there might be other useful information there. Thanks!

c10l commented 10 years ago

Also, if you don't mind testing it I have pushed a pre-release version to rubygems.

To install the pre0 version, run vagrant plugin install vagrant-butcher --plugin-prerelease --plugin-version 2.1.6.pre0.

This version gets rid of one of the potential sources of problems on Windows (the use of the cat command on the guest to get the key's contents).

If that, along with the change in config.butcher.guest_key_path work, then all I need is to find out how to poke the key from the correct default path on Windows. :)

dawilliams commented 10 years ago

@cassianoleal The client.pem is located in the C:\etc\chef directory. I changed config.butcher.guest_key_path = 'C:\etc\chef\client.pem' and that worked in getting it to copy the pem file to .vagrant/butcher/ directory. Since this is a multi machine setup the file name it copied was state-client.pem which is the defined machine name in the VagrantFile. Howerver it still doesn't appear to do anything when running vagrant destroy

c10l commented 10 years ago

Ok, at least some progress then :) I'll have a look into what might be happening that it doesn't get triggered during destroy. Could you please paste the output of vagrant destroy state --debug? Thanks!

dawilliams commented 10 years ago

INFO global: Vagrant version: 1.6.2 INFO global: Ruby version: 2.0.0 INFO global: RubyGems version: 2.0.14 INFO global: VAGRANT_EXECUTABLE="/Applications/Vagrant/bin/../embedded/gems/gems/vagrant-1.6.2/bin/vagrant" INFO global: VAGRANT_INSTALLER_EMBEDDED_DIR="/Applications/Vagrant/bin/../embedded" INFO global: VAGRANT_INSTALLER_VERSION="2" INFO global: VAGRANT_DETECTED_OS="Darwin" INFO global: VAGRANT_INSTALLER_ENV="1" INFO global: VAGRANT_INTERNAL_BUNDLERIZED="1" INFO global: VAGRANT_LOG="debug" INFO global: Plugins: INFO global: - addressable = 2.3.6 INFO global: - buff-extensions = 0.5.0 INFO global: - hashie = 2.1.1 INFO global: - varia_model = 0.3.2 INFO global: - buff-config = 0.4.0 INFO global: - buff-ignore = 1.1.1 INFO global: - buff-ruby_engine = 0.1.0 INFO global: - buff-shell_out = 0.1.1 INFO global: - bundler = 1.6.2 INFO global: - timers = 1.1.0 INFO global: - celluloid = 0.15.2 INFO global: - nio4r = 1.0.0 INFO global: - celluloid-io = 0.15.0 INFO global: - json = 1.8.1 INFO global: - mixlib-log = 1.6.0 INFO global: - rack = 1.5.2 INFO global: - chef-zero = 2.0.2 INFO global: - diff-lcs = 1.2.5 INFO global: - erubis = 2.7.0 INFO global: - highline = 1.6.21 INFO global: - mime-types = 1.25.1 INFO global: - mixlib-authentication = 1.3.0 INFO global: - mixlib-cli = 1.5.0 INFO global: - mixlib-config = 2.1.0 INFO global: - mixlib-shellout = 1.4.0 INFO global: - net-ssh = 2.9.1 INFO global: - net-ssh-gateway = 1.2.0 INFO global: - net-ssh-multi = 1.2.0 INFO global: - ipaddress = 0.8.0 INFO global: - systemu = 2.5.2 INFO global: - yajl-ruby = 1.2.0 INFO global: - ohai = 7.0.4 INFO global: - coderay = 1.1.0 INFO global: - method_source = 0.8.2 INFO global: - slop = 3.5.0 INFO global: - pry = 0.9.12.6 INFO global: - rest-client = 1.6.7 INFO global: - chef = 11.12.4 INFO global: - dep-selector-libgecode = 1.0.0 INFO global: - ffi = 1.9.3 INFO global: - dep_selector = 1.0.3 INFO global: - multipart-post = 1.2.0 INFO global: - faraday = 0.8.9 INFO global: - net-http-persistent = 2.9.4 INFO global: - retryable = 1.3.5 INFO global: - semverse = 1.1.0 INFO global: - solve = 1.2.0 INFO global: - ridley = 2.5.1 INFO global: - vagrant-butcher = 2.1.5 INFO global: - vagrant-login = 1.0.1 INFO global: - vagrant-omnibus = 1.4.1 INFO global: - vagrant-share = 1.0.1 DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/box/plugin.rb INFO manager: Registered plugin: box command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/destroy/plugin.rb INFO manager: Registered plugin: destroy command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/global-status/plugin.rb INFO manager: Registered plugin: global-status command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/halt/plugin.rb INFO manager: Registered plugin: halt command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/help/plugin.rb INFO manager: Registered plugin: help command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/init/plugin.rb INFO manager: Registered plugin: init command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/list-commands/plugin.rb INFO manager: Registered plugin: list-commands command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/package/plugin.rb INFO manager: Registered plugin: package command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/plugin/plugin.rb INFO manager: Registered plugin: plugin command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/provision/plugin.rb INFO manager: Registered plugin: provision command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/rdp/plugin.rb INFO manager: Registered plugin: rdp command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/reload/plugin.rb INFO manager: Registered plugin: reload command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/resume/plugin.rb INFO manager: Registered plugin: resume command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/ssh/plugin.rb INFO manager: Registered plugin: ssh command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/ssh_config/plugin.rb INFO manager: Registered plugin: ssh-config command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/status/plugin.rb INFO manager: Registered plugin: status command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/suspend/plugin.rb INFO manager: Registered plugin: suspend command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/up/plugin.rb INFO manager: Registered plugin: up command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/commands/version/plugin.rb INFO manager: Registered plugin: version command DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/communicators/ssh/plugin.rb INFO manager: Registered plugin: ssh communicator DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/communicators/winrm/plugin.rb INFO manager: Registered plugin: winrm communicator DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/arch/plugin.rb INFO manager: Registered plugin: Arch guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/coreos/plugin.rb INFO manager: Registered plugin: CoreOS guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/darwin/plugin.rb INFO manager: Registered plugin: Darwin guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/debian/plugin.rb INFO manager: Registered plugin: Debian guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/esxi/plugin.rb INFO manager: Registered plugin: ESXi guest. DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/fedora/plugin.rb INFO manager: Registered plugin: Fedora guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/freebsd/plugin.rb INFO manager: Registered plugin: FreeBSD guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/funtoo/plugin.rb INFO manager: Registered plugin: Funtoo guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/gentoo/plugin.rb INFO manager: Registered plugin: Gentoo guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/linux/plugin.rb INFO manager: Registered plugin: Linux guest. DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/mint/plugin.rb INFO manager: Registered plugin: Mint guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/netbsd/plugin.rb INFO manager: Registered plugin: NetBSD guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/omnios/plugin.rb INFO manager: Registered plugin: OmniOS guest. DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/openbsd/plugin.rb INFO manager: Registered plugin: OpenBSD guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/pld/plugin.rb INFO manager: Registered plugin: PLD Linux guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/redhat/plugin.rb INFO manager: Registered plugin: RedHat guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/smartos/plugin.rb INFO manager: Registered plugin: SmartOS guest. DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/solaris/plugin.rb INFO manager: Registered plugin: Solaris guest. DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/solaris11/plugin.rb INFO manager: Registered plugin: Solaris 11 guest. DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/suse/plugin.rb INFO manager: Registered plugin: SUSE guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/tinycore/plugin.rb INFO manager: Registered plugin: TinyCore Linux guest. DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/ubuntu/plugin.rb INFO manager: Registered plugin: Ubuntu guest DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/guests/windows/plugin.rb INFO manager: Registered plugin: Windows guest. DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/arch/plugin.rb INFO manager: Registered plugin: Arch host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/bsd/plugin.rb INFO manager: Registered plugin: BSD host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/darwin/plugin.rb INFO manager: Registered plugin: Mac OS X host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/freebsd/plugin.rb INFO manager: Registered plugin: FreeBSD host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/gentoo/plugin.rb INFO manager: Registered plugin: Gentoo host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/linux/plugin.rb INFO manager: Registered plugin: Linux host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/null/plugin.rb INFO manager: Registered plugin: null host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/opensuse/plugin.rb INFO manager: Registered plugin: OpenSUSE host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/redhat/plugin.rb INFO manager: Registered plugin: Red Hat host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/slackware/plugin.rb INFO manager: Registered plugin: Slackware host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/hosts/windows/plugin.rb INFO manager: Registered plugin: Windows host DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/kernel_v1/plugin.rb INFO manager: Registered plugin: kernel DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/kernel_v2/plugin.rb INFO manager: Registered plugin: kernel DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/docker/plugin.rb INFO manager: Registered plugin: docker-provider DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/hyperv/plugin.rb INFO manager: Registered plugin: Hyper-V provider DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/virtualbox/plugin.rb INFO manager: Registered plugin: VirtualBox provider DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/ansible/plugin.rb INFO manager: Registered plugin: ansible DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/cfengine/plugin.rb INFO manager: Registered plugin: CFEngine Provisioner DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/chef/plugin.rb INFO manager: Registered plugin: chef DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/docker/plugin.rb INFO manager: Registered plugin: docker DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/file/plugin.rb INFO manager: Registered plugin: file DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/puppet/plugin.rb INFO manager: Registered plugin: puppet DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/salt/plugin.rb INFO manager: Registered plugin: salt DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/provisioners/shell/plugin.rb INFO manager: Registered plugin: shell DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/synced_folders/nfs/plugin.rb INFO manager: Registered plugin: NFS synced folders DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/synced_folders/rsync/plugin.rb INFO manager: Registered plugin: RSync synced folders DEBUG global: Loading core plugin: /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/synced_folders/smb/plugin.rb INFO manager: Registered plugin: SMB synced folders INFO global: Loading plugins! INFO manager: Registered plugin: vagrant-login INFO manager: Registered plugin: vagrant-share INFO manager: Registered plugin: vagrant-butcher INFO manager: Registered plugin: vagrant-omnibus INFO vagrant: vagrant invoked: ["destroy", "state", "--debug", "--force"] DEBUG vagrant: Creating Vagrant environment INFO environment: Environment initialized (#Vagrant::Environment:0x000001026b4920) INFO environment: - cwd: /Users/dwilliams/repositories/ops-orig-qa-cookbook INFO environment: Home path: /Users/dwilliams/.vagrant.d INFO environment: Local data path: /Users/dwilliams/repositories/ops-orig-qa-cookbook/.vagrant DEBUG environment: Creating: /Users/dwilliams/repositories/ops-orig-qa-cookbook/.vagrant INFO environment: Running hook: environment_plugins_loaded INFO runner: Preparing hooks for middleware sequence... INFO runner: 2 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x0000010315abe0 INFO environment: Running hook: environment_load INFO runner: Preparing hooks for middleware sequence... INFO runner: 2 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x000001032b36b8 INFO cli: CLI: [] "destroy" ["state", "--force"] DEBUG cli: Invoking command class: VagrantPlugins::CommandDestroy::Command ["state", "--force"] DEBUG command: 'Destroy' each target VM... DEBUG command: Getting target VMs for command. Arguments: DEBUG command: -- names: ["state"] DEBUG command: -- options: {:reverse=>true} DEBUG command: Finding machine that match name: state INFO command: Active machine found with name state. Using provider: virtualbox INFO environment: Getting machine: state (virtualbox) INFO environment: Uncached load of machine. INFO loader: Set :root = #Pathname:/Users/dwilliams/repositories/ops-orig-qa-cookbook/Vagrantfile DEBUG loader: Populating proc cache for #Pathname:/Users/dwilliams/repositories/ops-orig-qa-cookbook/Vagrantfile DEBUG loader: Load procs for pathname: /Users/dwilliams/repositories/ops-orig-qa-cookbook/Vagrantfile INFO loader: Loading configuration in order: [:home, :root] DEBUG loader: Loading from: root (evaluating) DEBUG loader: Configuration loaded successfully, finalizing and returning INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "--version"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: 4.3.10r93012 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG meta: Finding driver for VirtualBox version: 4.3.10 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO base: VBoxManage path: VBoxManage INFO loader: Set "2167304960_machine_state" = [["2", #Proc:0x0000010275dfc0@/Users/dwilliams/repositories/ops-orig-qa-cookbook/Vagrantfile:72]] DEBUG loader: Populating proc cache for ["2", #Proc:0x0000010275dfc0@/Users/dwilliams/repositories/ops-orig-qa-cookbook/Vagrantfile:72] INFO loader: Loading configuration in order: [:home, :root, "2167304960_machine_state"] DEBUG loader: Loading from: root (cache) DEBUG loader: Loading from: 2167304960_machine_state (evaluating) DEBUG provisioner: Provisioner defined: shell DEBUG provisioner: Provisioner defined: chef_client DEBUG loader: Configuration loaded successfully, finalizing and returning INFO box_collection: Box found: win_2012_std (virtualbox) INFO loader: Set :"2156395580_win_2012_std_virtualbox" = #Pathname:/Users/dwilliams/.vagrant.d/boxes/win_2012_std/0/virtualbox/Vagrantfile DEBUG loader: Populating proc cache for #Pathname:/Users/dwilliams/.vagrant.d/boxes/win_2012_std/0/virtualbox/Vagrantfile DEBUG loader: Load procs for pathname: /Users/dwilliams/.vagrant.d/boxes/win_2012_std/0/virtualbox/Vagrantfile INFO loader: Loading configuration in order: [:"2156395580_win_2012_std_virtualbox", :home, :root, "2167304960_machine_state"] DEBUG loader: Loading from: 2156395580_win_2012_std_virtualbox (evaluating) DEBUG loader: Loading from: 2156395580_win_2012_std_virtualbox (evaluating) DEBUG loader: Loading from: root (cache) DEBUG loader: Loading from: 2167304960_machine_state (cache) DEBUG loader: Configuration loaded successfully, finalizing and returning INFO loader: Set :"2167304960_vm_state_win_2012_std_virtualbox" = [["2", #Proc:0x000001024397b8]] DEBUG loader: Populating proc cache for ["2", #Proc:0x000001024397b8] INFO loader: Loading configuration in order: [:"2156395580_win_2012_std_virtualbox", :home, :root, "2167304960_machine_state", :"2167304960_vm_state_win_2012_std_virtualbox"] DEBUG loader: Loading from: 2156395580_win_2012_std_virtualbox (cache) DEBUG loader: Loading from: 2156395580_win_2012_std_virtualbox (cache) DEBUG loader: Loading from: root (cache) DEBUG loader: Loading from: 2167304960_machine_state (cache) DEBUG loader: Loading from: 2167304960_vm_state_win_2012_std_virtualbox (evaluating) DEBUG loader: Configuration loaded successfully, finalizing and returning INFO machine: Initializing machine: state INFO machine: - Provider: VagrantPlugins::ProviderVirtualBox::Provider INFO machine: - Box: #Vagrant::Box:0x00000103262ec0 INFO machine: - Data dir: /Users/dwilliams/repositories/ops-orig-qa-cookbook/.vagrant/machines/state/virtualbox DEBUG virtualbox: Instantiating the driver for machine ID: "2e647091-6783-4c42-b26c-6e9083c3d80d" INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "--version"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: 4.3.10r93012 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG meta: Finding driver for VirtualBox version: 4.3.10 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "showvminfo", "2e647091-6783-4c42-b26c-6e9083c3d80d"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: Name: ops-orig-qa-cookbook_state_1403011460962_5473 Groups: / Guest OS: Windows 2012 (64 bit) UUID: 2e647091-6783-4c42-b26c-6e9083c3d80d Config file: /Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.vbox Snapshot folder: /Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Snapshots Log folder: /Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Logs Hardware UUID: 2e647091-6783-4c42-b26c-6e9083c3d80d Memory size: 2048MB Page Fusion: off VRAM size: 8MB CPU exec cap: 100% HPET: off Chipset: piix3 Firmware: BIOS Number of CPUs: 2 PAE: on Long Mode: on Synthetic CPU: off CPUID overrides: None Boot menu mode: message and menu Boot Device (1): HardDisk Boot Device (2): DVD Boot Device (3): Not Assigned Boot Device (4): Not Assigned ACPI: on IOAPIC: on Time offset: 0ms RTC: UTC Hardw. virt.ext: on Nested Paging: on Large Pages: on VT-x VPID: on VT-x unr. exec.: on State: running (since 2014-06-17T14:30:46.478000000) Monitor count: 1 3D Acceleration: off 2D Video Acceleration: off Teleporter Enabled: off Teleporter Port: 0 Teleporter Address: Teleporter Password: Tracing Enabled: off Allow Tracing to Access VM: off Tracing Configuration: Autostart Enabled: off Autostart Delay: 0 Default Frontend: Storage Controller Name (0): IDE Controller Storage Controller Type (0): PIIX4 Storage Controller Instance Number (0): 0 Storage Controller Max Port Count (0): 2 Storage Controller Port Count (0): 2 Storage Controller Bootable (0): on Storage Controller Name (1): Floppy Controller Storage Controller Type (1): I82078 Storage Controller Instance Number (1): 0 Storage Controller Max Port Count (1): 1 Storage Controller Port Count (1): 1 Storage Controller Bootable (1): on IDE Controller (0, 0): /Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/packer-virtualbox-iso-disk1.vmdk (UUID: de93971c-6021-4711-83b1-573fd9ee5c96) NIC 1: MAC: 080027385705, Attachment: NAT, Cable connected: on, Trace: off (file: none), Type: 82540EM, Reported speed: 0 Mbps, Boot priority: 0, Promisc Policy: deny, Bandwidth group: none NIC 1 Settings: MTU: 0, Socket (send: 64, receive: 64), TCP Window (send:64, receive: 64) NIC 1 Rule(0): name = tcp3389, protocol = tcp, host ip = , host port = 3389, guest ip = , guest port = 3389 NIC 1 Rule(1): name = winrm, protocol = tcp, host ip = , host port = 5985, guest ip = , guest port = 5985 NIC 2: disabled NIC 3: disabled NIC 4: disabled NIC 5: disabled NIC 6: disabled NIC 7: disabled NIC 8: disabled Pointing Device: PS/2 Mouse Keyboard Device: PS/2 Keyboard UART 1: disabled UART 2: disabled LPT 1: disabled LPT 2: disabled Audio: disabled Clipboard Mode: disabled Drag'n'drop Mode: disabled Session type: gui Video mode: 800x600x32 at 0,0 VRDE: disabled USB: disabled EHCI: disabled

USB Device Filters:

Available remote USB devices: Currently Attached USB Devices: Bandwidth groups: Shared folders: Name: 'vagrant', Host path: '/Users/dwilliams/repositories/ops-orig-qa-cookbook' (machine mapping), writable VRDE Connection: not active Clients so far: 0 Video capturing: not active Capture screens: 0 Capture file: /Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.webm Capture dimensions: 1024x768 Capture rate: 512 kbps Capture FPS: 25 Guest: Configured memory balloon size: 0 MB OS type: Windows8_64 Additions run level: 3 Additions version: 4.3.10 r93012 Guest Facilities: Facility "VirtualBox Base Driver": active/running (last update: 2014/06/17 13:24:33 UTC) Facility "VirtualBox System Service": active/running (last update: 2014/06/17 13:25:28 UTC) Facility "VirtualBox Desktop Integration": active/running (last update: 2014/06/17 13:25:01 UTC) Facility "Seamless Mode": active/running (last update: 2014/06/17 13:25:28 UTC) Facility "Graphics Mode": active/running (last update: 2014/06/17 13:25:55 UTC) DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999 DEBUG subprocess: Exit status: 0 DEBUG machine: Eager loading WinRM communicator to avoid GH-3390 INFO winrm: Initializing WinRMCommunicator INFO command: With machine: state (#, @name="stderr", @level=0, @formatter=#, @out=#IO:>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @machine=#, @driver=#, @name="stderr", @level=0, @formatter=#, @out=#IO:>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @level=1, @trace=false>, @interrupted=false, @vboxmanage_path="VBoxManage", @uuid="2e647091-6783-4c42-b26c-6e9083c3d80d", @version="4.3.10", @driver=#, @name="stderr", @level=0, @formatter=#, @out=#IO:>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @interrupted=false, @vboxmanage_path="VBoxManage", @uuid="2e647091-6783-4c42-b26c-6e9083c3d80d">>, @cap_logger=#, @name="stderr", @level=0, @formatter=#, @out=#IO:>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @cap_host_chain=[[:virtualbox, #<#Class:0x00000100946528:0x000001012887f8>]], @cap_args=[#], @cap_caps={:docker=>##Proc:0x000001010553f0@/Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/docker/plugin.rb:54}, @results_cache={}>, :hyperv=>##Proc:0x000001010f9bf8@/Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/hyperv/plugin.rb:25}, @results_cache={}>, :virtualbox=>##Proc:0x000001048092b0@/Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/virtualbox/plugin.rb:27, :nic_mac_addresses=>#Proc:0x00000104809210@/Applications/Vagrant/embedded/gems/gems/vagrant-1.6.2/plugins/providers/virtualbox/plugin.rb:32, :public_address=>#Proc:0x00000101105228@/Applications/Vagrant/embedded/gems/gems/vagrant-share-1.0.1/lib/vagrant-share.rb:39}, @results_cache={}>}>) INFO machine: Calling action: destroy on provider VirtualBox (2e647091-6783-4c42-b26c-6e9083c3d80d) DEBUG environment: Attempting to acquire process-lock: machine-action-9e833adbfe4026765d40f0cfcd24ecc4 DEBUG environment: Attempting to acquire process-lock: dotlock INFO environment: Acquired process lock: dotlock INFO environment: Released process lock: dotlock INFO environment: Acquired process lock: machine-action-9e833adbfe4026765d40f0cfcd24ecc4 INFO host: Autodetecting host type for [#] DEBUG host: Trying: arch DEBUG host: Trying: darwin INFO host: Detected: darwin! INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x00000103162138 INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x000001014fd830 INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "--version"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: 4.3.10r93012 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG meta: Finding driver for VirtualBox version: 4.3.10 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "list", "hostonlyifs"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling IN action: #Vagrant::Action::Builtin::Call:0x000001014fd808 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x00000104838920 INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000104841f70 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "showvminfo", "2e647091-6783-4c42-b26c-6e9083c3d80d", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ops-orig-qa-cookbook_state_1403011460962_5473" groups="/" ostype="Windows 2012 (64 bit)" UUID="2e647091-6783-4c42-b26c-6e9083c3d80d" CfgFile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.vbox" SnapFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Snapshots" LogFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Logs" hardwareuuid="2e647091-6783-4c42-b26c-6e9083c3d80d" memory=2048 pagefusion="off" vram=8 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" synthcpu="off" bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" Time offset=0rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" VMState="running" VMStateChangeTime="2014-06-17T14:30:46.478000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE Controller" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="Floppy Controller" storagecontrollertype1="I82078" storagecontrollerinstance1="0" storagecontrollermaxportcount1="1" storagecontrollerportcount1="1" storagecontrollerbootable1="on" "IDE Controller-0-0"="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/packer-virtualbox-iso-disk1.vmdk" "IDE Controller-ImageUUID-0-0"="de93971c-6021-4711-83b1-573fd9ee5c96" "IDE Controller-0-1"="none" "IDE Controller-1-0"="none" "IDE Controller-1-1"="none" "Floppy Controller-0-0"="none" "Floppy Controller-0-1"="none" natnet1="nat" macaddress1="080027385705" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp3389,tcp,,3389,,3389" Forwarding(1)="winrm,tcp,,5985,,5985" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" lpt1="off" lpt2="off" audio="none" clipboard="disabled" draganddrop="disabled" SessionType="gui" VideoMode="800,600,32"@0,0 vrde="off" usb="off" ehci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/dwilliams/repositories/ops-orig-qa-cookbook" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Windows8_64" GuestAdditionsRunLevel=3 GuestAdditionsVersion="4.3.10 r93012" GuestAdditionsFacility_VirtualBox Base Driver=50,1403011473305 GuestAdditionsFacility_VirtualBox System Service=50,1403011528526 GuestAdditionsFacility_VirtualBox Desktop Integration=50,1403011501729 GuestAdditionsFacility_Seamless Mode=50,1403011528526 GuestAdditionsFacility_Graphics Mode=50,1403011555724 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::Created:0x00000104841f70 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Warden:0x0000010254ffa8 INFO warden: Calling IN action: # INFO warden: Calling IN action: #Vagrant::Action::Builtin::Call:0x0000010254fda0 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x0000010686b4e0 INFO warden: Calling IN action: #Vagrant::Action::Builtin::DestroyConfirm:0x00000106878d48 INFO warden: Calling OUT action: #Vagrant::Action::Builtin::DestroyConfirm:0x00000106878d48 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Warden:0x0000010151f4f8 INFO warden: Calling IN action: # INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::CheckAccessible:0x0000010151f430 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "showvminfo", "2e647091-6783-4c42-b26c-6e9083c3d80d", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ops-orig-qa-cookbook_state_1403011460962_5473" groups="/" ostype="Windows 2012 (64 bit)" UUID="2e647091-6783-4c42-b26c-6e9083c3d80d" CfgFile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.vbox" SnapFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Snapshots" LogFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Logs" hardwareuuid="2e647091-6783-4c42-b26c-6e9083c3d80d" memory=2048 pagefusion="off" vram=8 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" synthcpu="off" bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" Time offset=0rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" VMState="running" VMStateChangeTime="2014-06-17T14:30:46.478000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE Controller" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="Floppy Controller" storagecontrollertype1="I82078" storagecontrollerinstance1="0" storagecontrollermaxportcount1="1" storagecontrollerportcount1="1" storagecontrollerbootable1="on" "IDE Controller-0-0"="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/packer-virtualbox-iso-disk1.vmdk" "IDE Controller-ImageUUID-0-0"="de93971c-6021-4711-83b1-573fd9ee5c96" "IDE Controller-0-1"="none" "IDE Controller-1-0"="none" "IDE Controller-1-1"="none" "Floppy Controller-0-0"="none" "Floppy Controller-0-1"="none" natnet1="nat" macaddress1="080027385705" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp3389,tcp,,3389,,3389" Forwarding(1)="winrm,tcp,,5985,,5985" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" lpt1="off" lpt2="off" audio="none" clipboard="disabled" draganddrop="disabled" SessionType="gui" VideoMode="800,600,32"@0,0 vrde="off" usb="off" ehci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/dwilliams/repositories/ops-orig-qa-cookbook" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Windows8_64" GuestAdditionsRunLevel=3 GuestAdditionsVersion="4.3.10 r93012" GuestAdditionsFacility_VirtualBox Base Driver=50,1403011473305 GuestAdditionsFacility_VirtualBox System Service=50,1403011528526 GuestAdditionsFacility_VirtualBox Desktop Integration=50,1403011501729 GuestAdditionsFacility_Seamless Mode=50,1403011528526 GuestAdditionsFacility_Graphics Mode=50,1403011555724 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling IN action: #Vagrant::Action::Builtin::EnvSet:0x0000010151f408 INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x0000010151f3e0 INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "--version"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: 4.3.10r93012 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG meta: Finding driver for VirtualBox version: 4.3.10 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "list", "hostonlyifs"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling IN action: #Vagrant::Action::Builtin::Call:0x0000010151f3b8 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x000001031b0180 INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::Created:0x000001031da980 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "showvminfo", "2e647091-6783-4c42-b26c-6e9083c3d80d", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ops-orig-qa-cookbook_state_1403011460962_5473" groups="/" ostype="Windows 2012 (64 bit)" UUID="2e647091-6783-4c42-b26c-6e9083c3d80d" CfgFile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.vbox" SnapFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Snapshots" LogFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Logs" hardwareuuid="2e647091-6783-4c42-b26c-6e9083c3d80d" memory=2048 pagefusion="off" vram=8 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" synthcpu="off" bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" Time offset=0rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" VMState="running" VMStateChangeTime="2014-06-17T14:30:46.478000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE Controller" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="Floppy Controller" storagecontrollertype1="I82078" storagecontrollerinstance1="0" storagecontrollermaxportcount1="1" storagecontrollerportcount1="1" storagecontrollerbootable1="on" "IDE Controller-0-0"="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/packer-virtualbox-iso-disk1.vmdk" "IDE Controller-ImageUUID-0-0"="de93971c-6021-4711-83b1-573fd9ee5c96" "IDE Controller-0-1"="none" "IDE Controller-1-0"="none" "IDE Controller-1-1"="none" "Floppy Controller-0-0"="none" "Floppy Controller-0-1"="none" natnet1="nat" macaddress1="080027385705" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp3389,tcp,,3389,,3389" Forwarding(1)="winrm,tcp,,5985,,5985" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" lpt1="off" lpt2="off" audio="none" clipboard="disabled" draganddrop="disabled" SessionType="gui" VideoMode="800,600,32"@0,0 vrde="off" usb="off" ehci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/dwilliams/repositories/ops-orig-qa-cookbook" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Windows8_64" GuestAdditionsRunLevel=3 GuestAdditionsVersion="4.3.10 r93012" GuestAdditionsFacility_VirtualBox Base Driver=50,1403011473305 GuestAdditionsFacility_VirtualBox System Service=50,1403011528526 GuestAdditionsFacility_VirtualBox Desktop Integration=50,1403011501729 GuestAdditionsFacility_Seamless Mode=50,1403011528526 GuestAdditionsFacility_Graphics Mode=50,1403011555724 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::Created:0x000001031da980 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Warden:0x0000010256dee0 INFO warden: Calling IN action: # INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::CheckAccessible:0x0000010256de18 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "showvminfo", "2e647091-6783-4c42-b26c-6e9083c3d80d", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ops-orig-qa-cookbook_state_1403011460962_5473" groups="/" ostype="Windows 2012 (64 bit)" UUID="2e647091-6783-4c42-b26c-6e9083c3d80d" CfgFile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.vbox" SnapFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Snapshots" LogFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Logs" hardwareuuid="2e647091-6783-4c42-b26c-6e9083c3d80d" memory=2048 pagefusion="off" vram=8 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" synthcpu="off" bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" Time offset=0rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" VMState="running" VMStateChangeTime="2014-06-17T14:30:46.478000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE Controller" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="Floppy Controller" storagecontrollertype1="I82078" storagecontrollerinstance1="0" storagecontrollermaxportcount1="1" storagecontrollerportcount1="1" storagecontrollerbootable1="on" "IDE Controller-0-0"="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/packer-virtualbox-iso-disk1.vmdk" "IDE Controller-ImageUUID-0-0"="de93971c-6021-4711-83b1-573fd9ee5c96" "IDE Controller-0-1"="none" "IDE Controller-1-0"="none" "IDE Controller-1-1"="none" "Floppy Controller-0-0"="none" "Floppy Controller-0-1"="none" natnet1="nat" macaddress1="080027385705" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp3389,tcp,,3389,,3389" Forwarding(1)="winrm,tcp,,5985,,5985" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" lpt1="off" lpt2="off" audio="none" clipboard="disabled" draganddrop="disabled" SessionType="gui" VideoMode="800,600,32"@0,0 vrde="off" usb="off" ehci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/dwilliams/repositories/ops-orig-qa-cookbook" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Windows8_64" GuestAdditionsRunLevel=3 GuestAdditionsVersion="4.3.10 r93012" GuestAdditionsFacility_VirtualBox Base Driver=50,1403011473305 GuestAdditionsFacility_VirtualBox System Service=50,1403011528526 GuestAdditionsFacility_VirtualBox Desktop Integration=50,1403011501729 GuestAdditionsFacility_Seamless Mode=50,1403011528526 GuestAdditionsFacility_Graphics Mode=50,1403011555724 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::DiscardState:0x0000010256ddf0 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "showvminfo", "2e647091-6783-4c42-b26c-6e9083c3d80d", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ops-orig-qa-cookbook_state_1403011460962_5473" groups="/" ostype="Windows 2012 (64 bit)" UUID="2e647091-6783-4c42-b26c-6e9083c3d80d" CfgFile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.vbox" SnapFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Snapshots" LogFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Logs" hardwareuuid="2e647091-6783-4c42-b26c-6e9083c3d80d" memory=2048 pagefusion="off" vram=8 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" synthcpu="off" bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" Time offset=0rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" VMState="running" VMStateChangeTime="2014-06-17T14:30:46.478000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE Controller" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="Floppy Controller" storagecontrollertype1="I82078" storagecontrollerinstance1="0" storagecontrollermaxportcount1="1" storagecontrollerportcount1="1" storagecontrollerbootable1="on" "IDE Controller-0-0"="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/packer-virtualbox-iso-disk1.vmdk" "IDE Controller-ImageUUID-0-0"="de93971c-6021-4711-83b1-573fd9ee5c96" "IDE Controller-0-1"="none" "IDE Controller-1-0"="none" "IDE Controller-1-1"="none" "Floppy Controller-0-0"="none" "Floppy Controller-0-1"="none" natnet1="nat" macaddress1="080027385705" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp3389,tcp,,3389,,3389" Forwarding(1)="winrm,tcp,,5985,,5985" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" lpt1="off" lpt2="off" audio="none" clipboard="disabled" draganddrop="disabled" SessionType="gui" VideoMode="800,600,32"@0,0 vrde="off" usb="off" ehci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/dwilliams/repositories/ops-orig-qa-cookbook" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Windows8_64" GuestAdditionsRunLevel=3 GuestAdditionsVersion="4.3.10 r93012" GuestAdditionsFacility_VirtualBox Base Driver=50,1403011473305 GuestAdditionsFacility_VirtualBox System Service=50,1403011528526 GuestAdditionsFacility_VirtualBox Desktop Integration=50,1403011501729 GuestAdditionsFacility_Seamless Mode=50,1403011528526 GuestAdditionsFacility_Graphics Mode=50,1403011555724 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling IN action: #Vagrant::Action::Builtin::Call:0x0000010256ddc8 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x0000010158cc88 INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::IsPaused:0x00000101594fc8 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "showvminfo", "2e647091-6783-4c42-b26c-6e9083c3d80d", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ops-orig-qa-cookbook_state_1403011460962_5473" groups="/" ostype="Windows 2012 (64 bit)" UUID="2e647091-6783-4c42-b26c-6e9083c3d80d" CfgFile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.vbox" SnapFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Snapshots" LogFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Logs" hardwareuuid="2e647091-6783-4c42-b26c-6e9083c3d80d" memory=2048 pagefusion="off" vram=8 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" synthcpu="off" bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" Time offset=0rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" VMState="running" VMStateChangeTime="2014-06-17T14:30:46.478000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE Controller" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="Floppy Controller" storagecontrollertype1="I82078" storagecontrollerinstance1="0" storagecontrollermaxportcount1="1" storagecontrollerportcount1="1" storagecontrollerbootable1="on" "IDE Controller-0-0"="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/packer-virtualbox-iso-disk1.vmdk" "IDE Controller-ImageUUID-0-0"="de93971c-6021-4711-83b1-573fd9ee5c96" "IDE Controller-0-1"="none" "IDE Controller-1-0"="none" "IDE Controller-1-1"="none" "Floppy Controller-0-0"="none" "Floppy Controller-0-1"="none" natnet1="nat" macaddress1="080027385705" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp3389,tcp,,3389,,3389" Forwarding(1)="winrm,tcp,,5985,,5985" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" lpt1="off" lpt2="off" audio="none" clipboard="disabled" draganddrop="disabled" SessionType="gui" VideoMode="800,600,32"@0,0 vrde="off" usb="off" ehci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/dwilliams/repositories/ops-orig-qa-cookbook" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Windows8_64" GuestAdditionsRunLevel=3 GuestAdditionsVersion="4.3.10 r93012" GuestAdditionsFacility_VirtualBox Base Driver=50,1403011473305 GuestAdditionsFacility_VirtualBox System Service=50,1403011528526 GuestAdditionsFacility_VirtualBox Desktop Integration=50,1403011501729 GuestAdditionsFacility_Seamless Mode=50,1403011528526 GuestAdditionsFacility_Graphics Mode=50,1403011555724 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999 DEBUG subprocess: Exit status: 0 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::IsPaused:0x00000101594fc8 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Warden:0x00000101438710 INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: #Vagrant::Action::Builtin::Call:0x0000010256dd00 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x000001016801f8 INFO warden: Calling IN action: #Vagrant::Action::Builtin::GracefulHalt:0x00000101689910 INFO warden: Calling OUT action: #Vagrant::Action::Builtin::GracefulHalt:0x00000101689910 INFO runner: Preparing hooks for middleware sequence... INFO runner: 3 hooks defined. INFO runner: Running action: #Vagrant::Action::Warden:0x000001016a2820 INFO warden: Calling IN action: # INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::ForcedHalt:0x000001016a27a8 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "showvminfo", "2e647091-6783-4c42-b26c-6e9083c3d80d", "--machinereadable"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: name="ops-orig-qa-cookbook_state_1403011460962_5473" groups="/" ostype="Windows 2012 (64 bit)" UUID="2e647091-6783-4c42-b26c-6e9083c3d80d" CfgFile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.vbox" SnapFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Snapshots" LogFldr="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/Logs" hardwareuuid="2e647091-6783-4c42-b26c-6e9083c3d80d" memory=2048 pagefusion="off" vram=8 cpuexecutioncap=100 hpet="off" chipset="piix3" firmware="BIOS" cpus=2 pae="on" longmode="on" synthcpu="off" bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" Time offset=0rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" VMState="running" VMStateChangeTime="2014-06-17T14:30:46.478000000" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" storagecontrollername0="IDE Controller" storagecontrollertype0="PIIX4" storagecontrollerinstance0="0" storagecontrollermaxportcount0="2" storagecontrollerportcount0="2" storagecontrollerbootable0="on" storagecontrollername1="Floppy Controller" storagecontrollertype1="I82078" storagecontrollerinstance1="0" storagecontrollermaxportcount1="1" storagecontrollerportcount1="1" storagecontrollerbootable1="on" "IDE Controller-0-0"="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/packer-virtualbox-iso-disk1.vmdk" "IDE Controller-ImageUUID-0-0"="de93971c-6021-4711-83b1-573fd9ee5c96" "IDE Controller-0-1"="none" "IDE Controller-1-0"="none" "IDE Controller-1-1"="none" "Floppy Controller-0-0"="none" "Floppy Controller-0-1"="none" natnet1="nat" macaddress1="080027385705" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp3389,tcp,,3389,,3389" Forwarding(1)="winrm,tcp,,5985,,5985" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" lpt1="off" lpt2="off" audio="none" clipboard="disabled" draganddrop="disabled" SessionType="gui" VideoMode="800,600,32"@0,0 vrde="off" usb="off" ehci="off" SharedFolderNameMachineMapping1="vagrant" SharedFolderPathMachineMapping1="/Users/dwilliams/repositories/ops-orig-qa-cookbook" VRDEActiveConnection="off" VRDEClients=0 vcpenabled="off" vcpscreens=0 vcpfile="/Users/dwilliams/VirtualBox VMs/ops-orig-qa-cookbook_state_1403011460962_5473/ops-orig-qa-cookbook_state_1403011460962_5473.webm" vcpwidth=1024 vcpheight=768 vcprate=512 vcpfps=25 GuestMemoryBalloon=0 GuestOSType="Windows8_64" GuestAdditionsRunLevel=3 GuestAdditionsVersion="4.3.10 r93012" GuestAdditionsFacility_VirtualBox Base Driver=50,1403011473305 GuestAdditionsFacility_VirtualBox System Service=50,1403011528526 GuestAdditionsFacility_VirtualBox Desktop Integration=50,1403011501729 GuestAdditionsFacility_Seamless Mode=50,1403011528526 GuestAdditionsFacility_Graphics Mode=50,1403011555724 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO interface: info: Forcing shutdown of VM... INFO interface: info: ==> state: Forcing shutdown of VM... ==> state: Forcing shutdown of VM... INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "controlvm", "2e647091-6783-4c42-b26c-6e9083c3d80d", "poweroff"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stderr: 0%... DEBUG subprocess: stderr: 10%...20%... DEBUG subprocess: stderr: 30%...40%...50%... DEBUG subprocess: stderr: 60%...70%...80%...90%... DEBUG subprocess: stderr: 100% DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling IN action: # INFO warden: Calling IN action: # INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::Destroy:0x0000010151f2f0 INFO interface: info: Destroying VM and associated drives... INFO interface: info: ==> state: Destroying VM and associated drives... ==> state: Destroying VM and associated drives... INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "unregistervm", "2e647091-6783-4c42-b26c-6e9083c3d80d", "--delete"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stderr: 0%...10%...20%...30%... DEBUG subprocess: stderr: 40%...50%...60%...70%...80%...90%... DEBUG subprocess: stderr: 100% DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO machine: New machine ID: nil DEBUG virtualbox: Instantiating the driver for machine ID: nil INFO base: VBoxManage path: VBoxManage INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "--version"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: 4.3.10r93012 DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 DEBUG meta: Finding driver for VirtualBox version: 4.3.10 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3 INFO base: VBoxManage path: VBoxManage INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::CleanMachineFolder:0x0000010151f2c8 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "list", "systemproperties"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: stdout: API version: 4_3 Minimum guest RAM size: 4 Megabytes Maximum guest RAM size: 2097152 Megabytes Minimum video RAM size: 1 Megabytes Maximum video RAM size: 256 Megabytes Maximum guest monitor count: 64 Minimum guest CPU count: 1 Maximum guest CPU count: 32 Virtual disk limit (info): 2199022206976 Bytes Maximum Serial Port count: 2 Maximum Parallel Port count: 2 Maximum Boot Position: 4 Maximum PIIX3 Network Adapter count: 8 Maximum ICH9 Network Adapter count: 36 Maximum PIIX3 IDE Controllers: 1 Maximum ICH9 IDE Controllers: 1 Maximum IDE Port count: 2 Maximum Devices per IDE Port: 2 Maximum PIIX3 SATA Controllers: 1 Maximum ICH9 SATA Controllers: 8 Maximum SATA Port count: 30 Maximum Devices per SATA Port: 1 Maximum PIIX3 SCSI Controllers: 1 Maximum ICH9 SCSI Controllers: 8 Maximum SCSI Port count: 16 Maximum Devices per SCSI Port: 1 Maximum SAS PIIX3 Controllers: 1 Maximum SAS ICH9 Controllers: 8 Maximum SAS Port count: 8 Maximum Devices per SAS Port: 1 Maximum PIIX3 Floppy Controllers:1 Maximum ICH9 Floppy Controllers: 1 Maximum Floppy Port count: 1 Maximum Devices per Floppy Port: 2 Default machine folder: /Users/dwilliams/VirtualBox VMs Exclusive HW virtualization use: off Default hard disk format: VDI VRDE auth library: VBoxAuth Webservice auth. library: VBoxAuth Remote desktop ExtPack: Log history count: 3 Default frontend: Autostart database path: Default Guest Additions ISO: /Applications/VirtualBox.app/Contents/MacOS/VBoxGuestAdditions.iso DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::DestroyUnusedNetworkInterfaces:0x0000010151f278 INFO warden: Calling IN action: #Vagrant::Action::Builtin::ProvisionerCleanup:0x00000101576348 INFO warden: Calling IN action: #VagrantPlugins::ProviderVirtualBox::Action::PrepareNFSValidIds:0x000001015b50c0 INFO subprocess: Starting process: ["/usr/bin/VBoxManage", "list", "vms"] DEBUG subprocess: Command not in installer, not touching env vars. DEBUG subprocess: Selecting on IO DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 32000 DEBUG subprocess: Exit status: 0 INFO warden: Calling IN action: #VagrantPlugins::SyncedFolderNFS::ActionCleanup:0x00000100a45b40 DEBUG host: Searching for cap: nfs_prune DEBUG host: Checking in: darwin DEBUG host: Checking in: bsd DEBUG host: Found cap: nfs_prune in bsd INFO nfs: NFS pruning. Valid IDs: [] DEBUG host: Searching for cap: nfs_prune DEBUG host: Checking in: darwin DEBUG host: Checking in: bsd DEBUG host: Found cap: nfs_prune in bsd INFO host: Execute capability: nfs_prune [#, #, @name="stderr", @level=0, @formatter=#, @out=#IO:>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @opts={}, @prefix=:state, @ui=#, @name="stderr", @level=0, @formatter=#, @out=#IO:>], @additive=true, @name="vagrant", @path="", @parent=#, @level=1, @trace=false>, @level=1, @trace=false>, @opts={:color=>:default}, @lock=#Mutex:0x000001026f6a28>>, []](darwin) INFO warden: Calling IN action: #Vagrant::Action::Builtin::SyncedFolderCleanup:0x0000010143f4c0 INFO synced_folder_cleanup: Invoking synced folder cleanup for: virtualbox 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: #Vagrant::Action::Builtin::SyncedFolderCleanup:0x0000010143f4c0 INFO warden: Calling OUT action: #VagrantPlugins::SyncedFolderNFS::ActionCleanup:0x00000100a45b40 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::PrepareNFSValidIds:0x000001015b50c0 INFO interface: info: Running cleanup tasks for 'shell' provisioner... INFO interface: info: ==> state: Running cleanup tasks for 'shell' provisioner... ==> state: Running cleanup tasks for 'shell' provisioner... INFO interface: info: Running cleanup tasks for 'chef_client' provisioner... INFO interface: info: ==> state: Running cleanup tasks for 'chef_client' provisioner... ==> state: Running cleanup tasks for 'chef_client' provisioner... INFO warden: Calling OUT action: #Vagrant::Action::Builtin::ProvisionerCleanup:0x00000101576348 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::DestroyUnusedNetworkInterfaces:0x0000010151f278 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::CleanMachineFolder:0x0000010151f2c8 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::Destroy:0x0000010151f2f0 INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::ForcedHalt:0x000001016a27a8 INFO warden: Calling OUT action: # INFO warden: Calling OUT action: #Vagrant::Action::Builtin::Call:0x0000010256dd00 INFO warden: Calling OUT action: # INFO warden: Calling OUT action: # INFO warden: Calling OUT action: #Vagrant::Action::Builtin::Call:0x0000010256ddc8 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::DiscardState:0x0000010256ddf0 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::CheckAccessible:0x0000010256de18 INFO warden: Calling OUT action: # INFO warden: Calling OUT action: #Vagrant::Action::Builtin::Call:0x0000010151f3b8 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x0000010151f3e0 INFO warden: Calling OUT action: #Vagrant::Action::Builtin::EnvSet:0x0000010151f408 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::CheckAccessible:0x0000010151f430 INFO warden: Calling OUT action: # INFO warden: Calling OUT action: #Vagrant::Action::Builtin::Call:0x0000010254fda0 INFO warden: Calling OUT action: # INFO warden: Calling OUT action: #Vagrant::Action::Builtin::Call:0x000001014fd808 INFO warden: Calling OUT action: #VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x000001014fd830 INFO environment: Released process lock: machine-action-9e833adbfe4026765d40f0cfcd24ecc4 DEBUG environment: Attempting to acquire process-lock: dotlock 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: 2 hooks defined. INFO runner: Running action: #Vagrant::Action::Builder:0x0000010482b838
c10l commented 10 years ago

I've created #53 to track the current issue. I'm closing this one now as the original bug has been solved in 2.1.6.pre0.

c10l commented 10 years ago

Hey @dawilliams

Would you mind trying out 2.6.1.pre1? I've made some changes and I'm expecting one of two things:

Appreciate your help!

dawilliams commented 10 years ago

@cassianoleal

How do I get the gem? I didn't see it under gem list

c10l commented 10 years ago

Ah, sorry... Just run:

vagrant plugin install vagrant-butcher --plugin-version 2.1.6.pre1

dawilliams commented 10 years ago

Thanks. I installed it and got the following error with the vagrant up command

/.vagrant.d/gems/gems/vagrant-butcher-2.1.6.pre1/lib/vagrant-butcher/config.rb:14:in <class:Config>': undefined methodguest_capability' for Vagrant::Butcher::Config:Class (NoMethodError) from /Users/dwilliams/.vagrant.d/gems/gems/vagrant-butcher-2.1.6.pre1/lib/vagrant-butcher/config.rb:3:in <module:Butcher>' from /Users/dwilliams/.vagrant.d/gems/gems/vagrant-butcher-2.1.6.pre1/lib/vagrant-butcher/config.rb:2:inmodule:Vagrant' from /Users/dwilliams/.vagrant.d/gems/gems/vagrant-butcher-2.1.6.pre1/lib/vagrant-butcher/config.rb:1:in <top (required)>' from /Users/dwilliams/.vagrant.d/gems/gems/vagrant-butcher-2.1.6.pre1/lib/vagrant-butcher/plugin.rb:26:inblock in class:Plugin' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/registry.rb:27:in call' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/registry.rb:27:inget' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/registry.rb:48:in block in each' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/registry.rb:47:ineach' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/registry.rb:47:in each' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/config/v2/loader.rb:57:inmerge' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/config/loader.rb:149:in block (2 levels) in load' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/config/loader.rb:97:ineach' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/config/loader.rb:97:in block in load' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/config/loader.rb:94:ineach' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/config/loader.rb:94:in load' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/vagrantfile.rb:28:ininitialize' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/environment.rb:574:in new' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/environment.rb:574:invagrantfile' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/environment.rb:359:in host' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/environment.rb:168:inblock in action_runner' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/runner.rb:33:in call' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/runner.rb:33:inrun' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/environment.rb:346:in hook' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/environment.rb:556:inunload' from /Applications/Vagrant/bin/../embedded/gems/gems/vagrant-1.6.3/bin/vagrant:169:in ensure in <main>' from /Applications/Vagrant/bin/../embedded/gems/gems/vagrant-1.6.3/bin/vagrant:169:in

'

c10l commented 10 years ago

Thanks! I believe I have a fix for butcher never running when you destroy a VM. The only thing that's missing is to set different default paths depending on the guest's OS. :)

c10l commented 10 years ago

@dawilliams Could you please try vagrant plugin install vagrant-butcher --plugin-version 2.1.6.pre3?

You still have to set config.butcher.guest_key_path on the Vagrantfile, but otherwise it should work now.

Thanks!

dawilliams commented 10 years ago

@cassianoleal The vagrant plugin command can't find the gem. I got the following:

vagrant plugin install vagrant-butcher --plugin-version 2.1.6.pre2

The plugin 'vagrant-butcher' could not be installed because it could not be found. Please double check the name and try again.

squaresurf commented 10 years ago

@dawilliams It looks like you installed pre2 not pre3.

dawilliams commented 10 years ago

@squaresurf sorry, I was looking at the email sent to me.

@cassianoleal here is the command and error I got on running the vagrant destroy command

vagrant destroy state -f /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/hook.rb:40:in before': wrong number of arguments (1 for 2+) (ArgumentError) from /Users/dwilliams/.vagrant.d/gems/gems/vagrant-butcher-2.1.6.pre3/lib/vagrant-butcher/plugin.rb:21:inblock in class:Plugin' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/runner.rb:42:in call' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/runner.rb:42:inblock (2 levels) in run' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/runner.rb:41:in tap' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/runner.rb:41:inblock in run' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/runner.rb:40:in map' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/action/runner.rb:40:inrun' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/machine.rb:196:in action_raw' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/machine.rb:173:inblock in action' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/environment.rb:434:in lock' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/machine.rb:161:incall' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/machine.rb:161:in action' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/plugins/commands/destroy/command.rb:31:inblock in execute' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/plugin/v2/command.rb:226:in block in with_target_vms' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/plugin/v2/command.rb:220:ineach' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/plugin/v2/command.rb:220:in with_target_vms' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/plugins/commands/destroy/command.rb:30:inexecute' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/cli.rb:42:in execute' from /Applications/Vagrant/embedded/gems/gems/vagrant-1.6.3/lib/vagrant/environment.rb:252:incli' from /Applications/Vagrant/bin/../embedded/gems/gems/vagrant-1.6.3/bin/vagrant:166:in `

'

c10l commented 10 years ago

Ok, I think now I've nailed it. The problem is that since I don't have a Windows basebox to test I need your help here again. Please try with

vagrant plugin install vagrant-butcher --plugin-version 2.2.0.pre0

Any ideas where or how I can acquire a Windows basebox easily?

Much appreciated! :smile:

dawilliams commented 10 years ago

@cassianoleal No problem at all! I'll try it now. I use packer and the packer-windows repo to make my base boxes. The problem is they are only good for 180 days before the license ends.

dawilliams commented 10 years ago

It works!!!! Thank you!

c10l commented 10 years ago

Brilliant! I intend to publish one more pre-release version with the default path to the client.pem depending on the OS. I'll have a look at packer-windows (thanks for the links), but it would be good if you could help me test that as well when it comes out. :)

Thanks very much!

c10l commented 10 years ago

@dawilliams Would you mind making a last test for me please?

I've implemented different defaults for Windows and *nix. If you can, remove the butcher.guest_key_path entries from your Vagrantfile, install the latest pre-release

vagrant plugin install vagrant-butcher --plugin-version 2.2.0.pre1

and let me know if it works. It if does, this is the release version! :)

Many thanks!

dawilliams commented 10 years ago

@cassianoleal it works!

c10l commented 10 years ago

Thanks a lot, I'll release it soon! :)