It chokes on some cookbooks...

[docwhat]

It is true: 'runit' is not a cookbook I probably would want to run on Windows... but sometimes extra cookbooks are uploaded due to dependencies.

If you have runit as a dependency (but not include_recipe) then you get output like this from kitchen converge:

>>>>>> ------Exception-------
>>>>>> Class: Kitchen::ActionFailed
>>>>>> Message: Failed to complete #converge action: [{:from=>"C:\\Users\\vagrant\\AppData\\Local\\Temp/winrm-upload-0.5348592853682338", :to=>"/tmp/kitchen/cookbooks/runit/files
/default/runsvdir", :message=>"{:data=>[{:stdout=>\"\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"    Directory: C:\\\\tmp\\\\kitchen\\\\cookbooks\\\\runit\\\\files\"}, {:stdout=
>\"\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"Mode                LastWriteTime     Length Name                              \"}, {:stdout=>\"\\r\\n\"},
 {:stdout=>\"----                -------------     ------ ----                              \"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"d----        11/12/2014   9:12 PM            d
efault                           \"}, {:stdout=>\"\\r\\n\"}, {:stderr=>\"#< CLIXML\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stderr=>\"<Objs Version=\\\"1.1.0.1\\
\" xmlns=\\\"http://schemas.microsoft.com/powershell/2004/04\\\"><S S=\\\"Error\\\">Get-Content : Cannot find path _x000D__x000A_</S><S S=\\\"Error\\\">'C:\\\\Users\\\\vagrant\\\
\AppData\\\\Local\\\\Temp\\\\winrm-upload-0.5348592853682338' because _x000D__x000A_</S><S S=\"}, {:stderr=>\"\\\"Error\\\">it does not exist._x000D__x000A_</S><S S=\\\"Error\\\"
>At line:12 char:28_x000D__x000A_</S><S S=\\\"Error\\\">+           $base64_string = Get-Content $tmp_file_path_x000D__x000A_</S><S S=\\\"Error\\\">+                            ~
~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S=\\\"Error\\\">    + CategoryInfo          : ObjectNotFound: (C:\\\\Users\\\\vagran...3485928536823 _x000D__x000A_</S><S S=\\\"Erro
r\\\">   38:String) [Get-Content], ItemNotFoundException_x000D__x000A_</S><S S=\\\"Error\\\">    + FullyQualifiedErrorId : PathNotFound,Microsoft.PowerShell.Commands.GetCo _x000D
__x000A_</S><S S=\\\"Error\\\">   ntentCommand_x000D__x000A_</S><S S=\\\"Error\\\"> _x000D__x000A_</S><S S=\\\"Error\\\">Exception calling \\\"FromBase64String\\\" with \\\"1\\\"
 argument(s): \\\"Value cannot be _x000D__x000A_</S><S S=\\\"Error\\\">null._x000D__x000A_</S><S S=\\\"Error\\\">Parameter name: s\\\"_x000D__x000A_</S><S S=\\\"Error\\\">At line
:13 char:11_x000D__x000A_</S><S S=\\\"Error\\\">+           $bytes = [System.Convert]::FromBase64String($base64_string)_x000D__x000A_</S><S S=\\\"Error\\\">+           ~~~~~~~~~~
~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S=\\\"Error\\\">    + CategoryInfo          : NotSpecified: (:) [], MethodInvocationException_x000D__x000A_<
/S><S S=\\\"Error\\\">    + FullyQualifiedErrorId : ArgumentNullException_x000D__x000A_</S><S S=\\\"Error\\\"> _x000D__x000A_</S><S S=\\\"Error\\\">Exception calling \\\"WriteAll
Bytes\\\" with \\\"2\\\" argument(s): \\\"Value cannot be null._x000D__x000A_</S><S S=\\\"Error\\\">Parameter name: bytes\\\"_x000D__x000A_</S><S S=\\\"Error\\\">At line:14 char:
11_x000D__x000A_</S><S S=\\\"Error\\\">+           [System.IO.File]::WriteAllBytes($dest_file_path, $bytes)_x000D__x000A_</S><S S=\\\"Error\\\">+           ~~~~~~~~~~~~~~~~~~~~~~
~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S=\\\"Error\\\">    + CategoryInfo          : NotSpecified: (:) [], MethodInvocationException_x000D__x000A_</S><S S=\\\"Err
or\\\">    + FullyQualifiedErrorId : ArgumentNullException_x000D__x000A_</S><S S=\\\"Error\\\"> _x000D__x000A_</S></Objs>\"}], :exitcode=>1}"}]
>>>>>> ----------------------
>>>>>> Please see .kitchen/logs/kitchen.log for more details
>>>>>> Also try running `kitchen diagnose --all` for configuration

I'm not entirely sure what's going on there.

ark v0.9.0 also does the same thing.

[docwhat]

I finally decoded one of the messages to see what windows was complaining
about...

This one was about the runit cookbook.

<?xml version="1.0"?>
<Objs xmlns="http://schemas.microsoft.com/powershell/2004/04" Version="1.1.0.1">
  <S S="Error">Get-Content : Cannot find path </S>
  <S S="Error">'C:\Users\vagrant\AppData\Local\Temp\winrm-upload-0.5930063830789549' because </S>
  <S S="Error">it does not exist.</S>
  <S S="Error">At line:12 char:28</S>
  <S S="Error">+           $base64_string = Get-Content $tmp_file_path</S>
  <S S="Error">+                            ~~~~~~~~~~~~~~~~~~~~~~~~~~</S>
  <S S="Error">    + CategoryInfo          : ObjectNotFound: (C:\Users\vagran...9300638307895 </S>
  <S S="Error">   49:String) [Get-Content], ItemNotFoundException</S>
  <S S="Error">    + FullyQualifiedErrorId : PathNotFound,Microsoft.PowerShell.Commands.GetCo </S>
  <S S="Error">   ntentCommand</S>
  <S S="Error"> </S>
  <S S="Error">Exception calling "FromBase64String" with "1" argument(s): "Value cannot be </S>
  <S S="Error">null.</S>
  <S S="Error">Parameter name: s"</S>
  <S S="Error">At line:13 char:11</S>
  <S S="Error">+           $bytes = [System.Convert]::FromBase64String($base64_string)</S>
  <S S="Error">+           ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~</S>
  <S S="Error">    + CategoryInfo          : NotSpecified: (:) [], MethodInvocationException</S>
  <S S="Error">    + FullyQualifiedErrorId : ArgumentNullException</S>
  <S S="Error"> </S>
  <S S="Error">Exception calling "WriteAllBytes" with "2" argument(s): "Value cannot be null.</S>
  <S S="Error">Parameter name: bytes"</S>
  <S S="Error">At line:14 char:11</S>
  <S S="Error">+           [System.IO.File]::WriteAllBytes($dest_file_path, $bytes)</S>
  <S S="Error">+           ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~</S>
  <S S="Error">    + CategoryInfo          : NotSpecified: (:) [], MethodInvocationException</S>
  <S S="Error">    + FullyQualifiedErrorId : ArgumentNullException</S>
  <S S="Error"> </S>
</Objs>

[afiune]

@docwhat Apologies for the late response. I would like to replicate this issue, is there a way you can share more output of the converge? I am wondering also what version of Windows are you deploying and the cookbook you are using.

[docwhat]

@afiune asked:

I would like to replicate this issue, is there a way you can share more output of the converge?

Unfortunately, it's been a while so I don't think I have the output anymore. Let me see if I can recreate it. If I don't reply by the 24th of December, ping me.

I am wondering also what version of Windows are you deploying and the cookbook you are using.

Windows Server 2012

[docwhat]

Here's similar output. I'm not sure it is identical...

-----> Starting Kitchen (v1.3.0)
-----> Creating <nxlog-windows>...
       Bringing machine 'default' up with 'virtualbox' provider...
       ==> default: Importing base box 'windows-2012-standard'...

Progress: 10%
Progress: 20%
Progress: 90%
       ==> default: Matching MAC address for NAT networking...
       ==> default: Setting the name of the VM: nxlog-windows_default_1419351340756_58906
       ==> default: Clearing any previously set forwarded ports...
       Skipping Berkshelf with --no-provision
       ==> default: Fixed port collision for 5985 => 55985. Now on port 2200.
       ==> default: Fixed port collision for 22 => 2222. Now on port 2201.
       ==> default: Clearing any previously set network interfaces...
       ==> default: Preparing network interfaces based on configuration...
           default: Adapter 1: nat
       ==> default: Forwarding ports...
           default: 5985 => 2200 (adapter 1)
           default: 22 => 2201 (adapter 1)
       ==> default: Running 'pre-boot' VM customizations...
       ==> default: Booting VM...
       ==> default: Waiting for machine to boot. This may take a few minutes...
       ==> default: Machine booted and ready!
       ==> default: Checking for guest additions in VM...
       ==> default: Setting hostname...
       ==> default: Mounting shared folders...
           default: /tmp/vagrant-cache => /Users/docwhat/.vagrant.d/cache/windows-2012-standard
       ==> default: Machine not provisioning because `--no-provision` is specified.
       Vagrant instance <nxlog-windows> created.
       Finished creating <nxlog-windows> (7m39.57s).
-----> Converging <nxlog-windows>...
       Preparing files for transfer
       Preparing dna.json
       Resolving cookbook dependencies with Berkshelf 3.2.2...
       Removing non-cookbook files before transfer
       Preparing validation.pem
       Preparing client.rb
-----> Chef Omnibus installation detected (true)
       Transferring files to <nxlog-windows>
       Concurrent threads set to :max_threads => 2
>>>>>> ------Exception-------
>>>>>> Class: Kitchen::ActionFailed
>>>>>> Message: Failed to complete #converge action: [{:from=>"C:\\Users\\vagrant\\AppData\\Local\\Temp/winrm-upload-0.4997351653335549", :to=>"/tmp/kitchen/cookbooks/runit/files/default/runsvdir", :message=>"{:data=>[{:stdout=>\"\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"    Directory: C:\\\\tmp\\\\kitchen\\\\cookbooks\\\\runit\\\\files\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"Mode                LastWriteTime     Length Name                              \"}, {:stdout=>\"\\r\\n----                -------------     ------ ----                              \\r\\nd----        12/23/2014   4:31 PM            default                           \\r\\n\"}, {:stderr=>\"#< CLIXML\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stdout=>\"\\r\\n\"}, {:stderr=>\"<Objs Version=\\\"1.1.0.1\\\" xmlns=\\\"http://schemas.microsoft.com/powershell/2004/04\\\"><S S=\\\"Error\\\">Get-Content : Cannot find path _x000D__x000A_</S><S S=\\\"Error\\\">'C:\\\\Users\\\\vagrant\\\\AppData\\\\Local\\\\Temp\\\\winrm-upload-0.4997351653335549' because _x000D__x000A_</S><S S=\"}, {:stderr=>\"\\\"Error\\\">it does not exist._x000D__x000A_</S><S S=\\\"Error\\\">At line:12 char:28_x000D__x000A_</S><S S=\\\"Error\\\">+           $base64_string = Get-Content $tmp_file_path_x000D__x000A_</S><S S=\\\"Error\\\">+                            ~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S=\\\"Error\\\">    + CategoryInfo          : ObjectNotFound: (C:\\\\Users\\\\vagran...9973516533355 _x000D__x000A_</S><S S=\\\"Error\\\">   49:String) [Get-Content], ItemNotFoundException_x000D__x000A_</S><S S=\\\"Error\\\">    + FullyQualifiedErrorId : PathNotFound,Microsoft.PowerShell.Commands.GetCo _x000D__x000A_</S><S S=\\\"Error\\\">   ntentCommand_x000D__x000A_</S><S S=\\\"Error\\\"> _x000D__x000A_</S><S S=\\\"Error\\\">Exception calling \\\"FromBase64String\\\" with \\\"1\\\" argument(s): \\\"Value cannot be _x000D__x000A_</S><S S=\\\"Error\\\">null._x000D__x000A_</S><S S=\\\"Error\\\">Parameter name: s\\\"_x000D__x000A_</S><S S=\\\"Error\\\">At line:13 char:11_x000D__x000A_</S><S S=\\\"Error\\\">+           $bytes = [System.Convert]::FromBase64String($base64_string)_x000D__x000A_</S><S S=\\\"Error\\\">+           ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S=\\\"Error\\\">    + CategoryInfo          : NotSpecified: (:) [], MethodInvocationException_x000D__x000A_</S><S S=\\\"Error\\\">    + FullyQualifiedErrorId : ArgumentNullException_x000D__x000A_</S><S S=\\\"Error\\\"> _x000D__x000A_</S><S S=\\\"Error\\\">Exception calling \\\"WriteAllBytes\\\" with \\\"2\\\" argument(s): \\\"Value cannot be null._x000D__x000A_</S><S S=\\\"Error\\\">Parameter name: bytes\\\"_x000D__x000A_</S><S S=\\\"Error\\\">At line:14 char:11_x000D__x000A_</S><S S=\\\"Error\\\">+           [System.IO.File]::WriteAllBytes($dest_file_path, $bytes)_x000D__x000A_</S><S S=\\\"Error\\\">+           ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~_x000D__x000A_</S><S S=\\\"Error\\\">    + CategoryInfo          : NotSpecified: (:) [], MethodInvocationException_x000D__x000A_</S><S S=\\\"Error\\\">    + FullyQualifiedErrorId : ArgumentNullException_x000D__x000A_</S><S S=\\\"Error\\\"> _x000D__x000A_</S></Objs>\"}], :exitcode=>1}"}]
>>>>>> ----------------------
>>>>>> Please see .kitchen/logs/kitchen.log for more details
>>>>>> Also try running `kitchen diagnose --all` for configuration

My (sanitized) metadata.rb:

depends 'logstash',      '>= 0.9'
depends 'rsyslog'
depends 'selinux'
depends 'yum'
depends 'windows'

My (sanitized) .kitchen.yml:

---
driver:
  name: vagrant

provisioner:
  name: chef_solo

platforms:
  - name: windows
    driver_config:
      box: windows-2012-standard
      box_url: http://example.com/vagrant/boxes/virtualbox/windows-2012-standard.box
      vm_hostname: 'nxlog'
      vagrantfile_erb: VagrantfileWinrm.erb
      # customize:
      #   memory: 1024
      #   cpus: 1
    transport:
      name: winrm
    provisioner:
      name: chef_zero

suites:
  - name: nxlog
    run_list:
      - recipe[ntp::default]
      - recipe[mycookbook::nxlog]
    attributes:
      kitchen:
        sawmill-hosts:
          - 192.168.101.16
    includes:
      windows

My (verbatim) VagrantfileWinrm.rb:

Vagrant.configure("2") do |c|
  c.vm.box = "<%= config[:box] %>"
  c.vm.box_url = "<%= config[:box_url] %>"

  # Ensure a modern version of Chef
  c.omnibus.chef_version = :latest

<% if config[:vm_hostname] %>
  c.vm.hostname = "<%= config[:vm_hostname] %>"
<% end %>

  c.vm.guest = :windows
  c.vm.communicator = "winrm"
<% if config[:username] %>
  c.winrm.username = "<%= config[:username] %>"
<% end %>
<% if config[:password] %>
  c.winrm.password = "<%= config[:password] %>"
<% end %>

<% Array(config[:network]).each do |opts| %>
  c.vm.network(:<%= opts[0] %>, <%= opts[1..-1].join(", ") %>)
<% end %>

  c.vm.synced_folder ".", "/vagrant", disabled: true
<% config[:synced_folders].each do |source, destination, options| %>
  c.vm.synced_folder "<%= source %>", "<%= destination %>", <%= options %>
<% end %>

  c.vm.provider :<%= config[:provider] %> do |p|
    p.gui = true
<% config[:customize].each do |key, value| %>
  <% case config[:provider]
     when "virtualbox" %>
    p.customize ["modifyvm", :id, "--<%= key %>", "<%= value %>"]
  <% when "rackspace", "softlayer" %>
    p.<%= key %> = "<%= value%>"
  <% when /^vmware_/ %>
    <% if key == :memory %>
      <% unless config[:customize].include?(:memsize) %>
    p.vmx["memsize"] = "<%= value %>"
      <% end %>
    <% else %>
    p.vmx["<%= key %>"] = "<%= value %>"
    <% end %>
  <% end %>
<% end %>
  end
end

[obazoud]

I got the same issue.