fnichol/chef-rvm issue #51

gistfile1.txt

Ubuntu 12.04

##  ubuntu@ubuntu:/tmp/chef-solo$ cat nodes/192.168.126.136.json 


{
	"authorization": {
      "sudo": {
        "groups": ["adm", "wheel"],
        "users": ["ubuntu"],
        "passwordless": true
      }
    },
	"run_list": ["role[bare-bones]", "role[web]"]
}


## ubuntu@ubuntu:/tmp/chef-solo$ cat roles/bare-bones.rb


name "bare-bones"
description "The base role for all systems"
run_list ["recipe[sudo]", "recipe[build-essential]", "recipe[subversion]", "recipe[rvm::system]"]
default_attributes "rvm" => { "default_ruby" => "ruby-1.9.3-p194",
	"rvmrc" => { 
      "rvm_project_rvmrc" =>  1,
      "rvm_gemset_create_on_use_flag" => 1,
      "rvm_trust_rvmrcs_flag" => 1
    }
   }


## chef-solo -l debug output


ubuntu@ubuntu:/tmp/chef-solo$ sudo -E chef-solo -c solo.rb -j nodes/192.168.126.136.json -l debug
[Tue, 01 May 2012 16:41:30 -0700] INFO: *** Chef 0.10.8 ***
[Tue, 01 May 2012 16:41:30 -0700] DEBUG: Building node object for ubuntu
[Tue, 01 May 2012 16:41:30 -0700] DEBUG: Extracting run list from JSON attributes provided on command line
[Tue, 01 May 2012 16:41:30 -0700] INFO: Setting the run_list to ["role[bare-bones]", "role[web]"] from JSON
[Tue, 01 May 2012 16:41:30 -0700] DEBUG: Applying attributes from json file
[Tue, 01 May 2012 16:41:30 -0700] DEBUG: Platform is ubuntu version 12.04
[Tue, 01 May 2012 16:41:30 -0700] INFO: Run List is [role[bare-bones], role[web]]
[Tue, 01 May 2012 16:41:30 -0700] INFO: Run List expands to [sudo, build-essential, subversion, rvm::system, apache2]
[Tue, 01 May 2012 16:41:30 -0700] INFO: Starting Chef Run for ubuntu
[Tue, 01 May 2012 16:41:30 -0700] INFO: Running start handlers
[Tue, 01 May 2012 16:41:30 -0700] INFO: Start handlers complete.
[Tue, 01 May 2012 16:41:30 -0700] DEBUG: No chefignore file found at /tmp/chef-solo/cookbooks/chefignore no files will be ignored
[Tue, 01 May 2012 16:41:30 -0700] DEBUG: No chefignore file found at /tmp/chef-solo/site-cookbooks/chefignore no files will be ignored
[Tue, 01 May 2012 16:41:30 -0700] DEBUG: Loading cookbook chef_solo_patches's library file: /tmp/chef-solo/cookbooks/chef_solo_patches/libraries/search_patch.rb
[Tue, 01 May 2012 16:41:30 -0700] DEBUG: Loading cookbook chef_solo_patches's library file: /tmp/chef-solo/cookbooks/chef_solo_patches/libraries/parser.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_shell_helpers.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_cache.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/gem_package_monkeypatch.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_environment_helpers.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_helpers.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_gemset_helpers.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_ruby_helpers.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/rvm_rubygems_package.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_recipe_helpers.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/rvm_chef_user_environment.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's library file: /tmp/chef-solo/cookbooks/rvm/libraries/rvm_shell_chef_wrapper.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's providers from /tmp/chef-solo/cookbooks/rvm/providers/default_ruby.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/providers/default_ruby.rb into a provider named rvm_default_ruby defined in Chef::Provider::RvmDefaultRuby
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's providers from /tmp/chef-solo/cookbooks/rvm/providers/gemset.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/providers/gemset.rb into a provider named rvm_gemset defined in Chef::Provider::RvmGemset
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's providers from /tmp/chef-solo/cookbooks/rvm/providers/shell.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/providers/shell.rb into a provider named rvm_shell defined in Chef::Provider::RvmShell
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's providers from /tmp/chef-solo/cookbooks/rvm/providers/ruby.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/providers/ruby.rb into a provider named rvm_ruby defined in Chef::Provider::RvmRuby
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's providers from /tmp/chef-solo/cookbooks/rvm/providers/global_gem.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/providers/global_gem.rb into a provider named rvm_global_gem defined in Chef::Provider::RvmGlobalGem
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's providers from /tmp/chef-solo/cookbooks/rvm/providers/wrapper.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/providers/wrapper.rb into a provider named rvm_wrapper defined in Chef::Provider::RvmWrapper
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's providers from /tmp/chef-solo/cookbooks/rvm/providers/environment.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/providers/environment.rb into a provider named rvm_environment defined in Chef::Provider::RvmEnvironment
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's resources from /tmp/chef-solo/cookbooks/rvm/resources/shell.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/resources/shell.rb into a resource named rvm_shell defined in Chef::Resource::RvmShell
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's resources from /tmp/chef-solo/cookbooks/rvm/resources/ruby.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/resources/ruby.rb into a resource named rvm_ruby defined in Chef::Resource::RvmRuby
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's resources from /tmp/chef-solo/cookbooks/rvm/resources/gemset.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/resources/gemset.rb into a resource named rvm_gemset defined in Chef::Resource::RvmGemset
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's resources from /tmp/chef-solo/cookbooks/rvm/resources/gem.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/resources/gem.rb into a resource named rvm_gem defined in Chef::Resource::RvmGem
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's resources from /tmp/chef-solo/cookbooks/rvm/resources/global_gem.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/resources/global_gem.rb into a resource named rvm_global_gem defined in Chef::Resource::RvmGlobalGem
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's resources from /tmp/chef-solo/cookbooks/rvm/resources/default_ruby.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/resources/default_ruby.rb into a resource named rvm_default_ruby defined in Chef::Resource::RvmDefaultRuby
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's resources from /tmp/chef-solo/cookbooks/rvm/resources/environment.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/resources/environment.rb into a resource named rvm_environment defined in Chef::Resource::RvmEnvironment
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook rvm's resources from /tmp/chef-solo/cookbooks/rvm/resources/wrapper.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loaded contents of /tmp/chef-solo/cookbooks/rvm/resources/wrapper.rb into a resource named rvm_wrapper defined in Chef::Resource::RvmWrapper
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Node ubuntu loading cookbook apache2's attribute file /tmp/chef-solo/cookbooks/apache2/attributes/default.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Node ubuntu loading cookbook subversion's attribute file /tmp/chef-solo/cookbooks/subversion/attributes/subversion.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Node ubuntu loading cookbook sudo's attribute file /tmp/chef-solo/cookbooks/sudo/attributes/default.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Node ubuntu loading cookbook rvm's attribute file /tmp/chef-solo/cookbooks/rvm/attributes/vagrant.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Node ubuntu loading cookbook rvm's attribute file /tmp/chef-solo/cookbooks/rvm/attributes/gem_package.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Node ubuntu loading cookbook rvm's attribute file /tmp/chef-solo/cookbooks/rvm/attributes/default.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook apache2's definitions from /tmp/chef-solo/cookbooks/apache2/definitions/web_app.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook apache2's definitions from /tmp/chef-solo/cookbooks/apache2/definitions/apache_conf.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook apache2's definitions from /tmp/chef-solo/cookbooks/apache2/definitions/apache_module.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading cookbook apache2's definitions from /tmp/chef-solo/cookbooks/apache2/definitions/apache_site.rb
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe sudo via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe default in cookbook sudo
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe build-essential via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe default in cookbook build-essential
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe subversion via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe default in cookbook subversion
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe subversion::client via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe client in cookbook subversion
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe rvm::system via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe system in cookbook rvm
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe rvm::system_install via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe system_install in cookbook rvm
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe rvm via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe default in cookbook rvm
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing gem_package[rvm] action install (rvm::default line 21)
NOTE: Gem.source_index is deprecated, use Specification. It will be removed on or after 2011-11-01.
Gem.source_index called from /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/provider/package/rubygems.rb:203.
NOTE: Gem::SourceIndex#search is deprecated with no replacement. It will be removed on or after 2011-11-01.
Gem::SourceIndex#search called from /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/provider/package/rubygems.rb:77.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: gem_package[rvm] found installed gem rvm version 1.11.3.3 matching rvm (>= 0)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: gem_package[rvm] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2 via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe default in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_status via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_status in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_alias via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_alias in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_auth_basic via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_auth_basic in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_authn_file via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_authn_file in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_authz_default via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_authz_default in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_authz_groupfile via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_authz_groupfile in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_authz_host via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_authz_host in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_authz_user via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_authz_user in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_autoindex via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_autoindex in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_dir via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_dir in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_env via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_env in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_mime via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_mime in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_negotiation via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_negotiation in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading Recipe apache2::mod_setenvif via include_recipe
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Found recipe mod_setenvif in cookbook apache2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: I am not loading apache2, because I have already seen it.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Setting service[apache2] to the state of the prior service[apache2]
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Loading from cookbook_path: /tmp/chef-solo/cookbooks, /tmp/chef-solo/site-cookbooks
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Converging node ubuntu
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[sudo] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[sudo] action upgrade (sudo::default line 20)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[sudo] checking package status for sudo
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy sudo)
sudo:
  Installed: 1.8.3p1-1ubuntu3
  Candidate: 1.8.3p1-1ubuntu3
  Version table:
 *** 1.8.3p1-1ubuntu3 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[sudo] current version is 1.8.3p1-1ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[sudo] candidate version is 1.8.3p1-1ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[sudo] is at the latest version - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing template[/etc/sudoers] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing template[/etc/sudoers] action create (sudo::default line 24)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Current content's checksum:  dfde289c12e70130708ff301ae1035ae97bde75a047ea656ba6ac884022de80a
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Rendered content's checksum: dfde289c12e70130708ff301ae1035ae97bde75a047ea656ba6ac884022de80a
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: template[/etc/sudoers] content has not changed.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[build-essential] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[build-essential] action install (build-essential::default line 23)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[build-essential] checking package status for build-essential
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy build-essential)
build-essential:
  Installed: 11.5ubuntu2
  Candidate: 11.5ubuntu2
  Version table:
 *** 11.5ubuntu2 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[build-essential] current version is 11.5ubuntu2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[build-essential] candidate version is 11.5ubuntu2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[build-essential] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[binutils-doc] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[binutils-doc] action install (build-essential::default line 23)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[binutils-doc] checking package status for binutils-doc
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy binutils-doc)
binutils-doc:
  Installed: 2.22-6ubuntu1
  Candidate: 2.22-6ubuntu1
  Version table:
 *** 2.22-6ubuntu1 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[binutils-doc] current version is 2.22-6ubuntu1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[binutils-doc] candidate version is 2.22-6ubuntu1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[binutils-doc] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[autoconf] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[autoconf] action install (build-essential::default line 35)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[autoconf] checking package status for autoconf
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy autoconf)
autoconf:
  Installed: 2.68-1ubuntu2
  Candidate: 2.68-1ubuntu2
  Version table:
 *** 2.68-1ubuntu2 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[autoconf] current version is 2.68-1ubuntu2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[autoconf] candidate version is 2.68-1ubuntu2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[autoconf] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[flex] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[flex] action install (build-essential::default line 39)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[flex] checking package status for flex
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy flex)
flex:
  Installed: 2.5.35-10ubuntu3
  Candidate: 2.5.35-10ubuntu3
  Version table:
 *** 2.5.35-10ubuntu3 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[flex] current version is 2.5.35-10ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[flex] candidate version is 2.5.35-10ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[flex] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[bison] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[bison] action install (build-essential::default line 43)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bison] checking package status for bison
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy bison)
bison:
  Installed: 1:2.5.dfsg-2.1
  Candidate: 1:2.5.dfsg-2.1
  Version table:
 *** 1:2.5.dfsg-2.1 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bison] current version is 1:2.5.dfsg-2.1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bison] candidate version is 1:2.5.dfsg-2.1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bison] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[subversion] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[subversion] action install (subversion::client line 20)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[subversion] checking package status for subversion
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy subversion)
subversion:
  Installed: 1.6.17dfsg-3ubuntu3
  Candidate: 1.6.17dfsg-3ubuntu3
  Version table:
 *** 1.6.17dfsg-3ubuntu3 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[subversion] current version is 1.6.17dfsg-3ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[subversion] candidate version is 1.6.17dfsg-3ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[subversion] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[subversion-tools] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[subversion-tools] action install (subversion::client line 38)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[subversion-tools] checking package status for subversion-tools
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy subversion-tools)
subversion-tools:
  Installed: 1.6.17dfsg-3ubuntu3
  Candidate: 1.6.17dfsg-3ubuntu3
  Version table:
 *** 1.6.17dfsg-3ubuntu3 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[subversion-tools] current version is 1.6.17dfsg-3ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[subversion-tools] candidate version is 1.6.17dfsg-3ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[subversion-tools] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[libsvn-perl] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[libsvn-perl] action install (subversion::client line 38)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[libsvn-perl] checking package status for libsvn-perl
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy libsvn-perl)
libsvn-perl:
  Installed: 1.6.17dfsg-3ubuntu3
  Candidate: 1.6.17dfsg-3ubuntu3
  Version table:
 *** 1.6.17dfsg-3ubuntu3 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[libsvn-perl] current version is 1.6.17dfsg-3ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[libsvn-perl] candidate version is 1.6.17dfsg-3ubuntu3
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[libsvn-perl] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing gem_package[rvm] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing gem_package[rvm] action nothing (rvm::default line 21)
NOTE: Gem.source_index is deprecated, use Specification. It will be removed on or after 2011-11-01.
Gem.source_index called from /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/provider/package/rubygems.rb:203.
NOTE: Gem::SourceIndex#search is deprecated with no replacement. It will be removed on or after 2011-11-01.
Gem::SourceIndex#search called from /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/provider/package/rubygems.rb:77.
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: gem_package[rvm] found installed gem rvm version 1.11.3.3 matching rvm (>= 0)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Doing nothing for gem_package[rvm]
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[sed] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[sed] action install (rvm::system_install line 44)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[sed] checking package status for sed
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy sed)
sed:
  Installed: 4.2.1-9
  Candidate: 4.2.1-9
  Version table:
 *** 4.2.1-9 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[sed] current version is 4.2.1-9
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[sed] candidate version is 4.2.1-9
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[sed] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[grep] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[grep] action install (rvm::system_install line 44)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[grep] checking package status for grep
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy grep)
grep:
  Installed: 2.10-1
  Candidate: 2.10-1
  Version table:
 *** 2.10-1 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[grep] current version is 2.10-1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[grep] candidate version is 2.10-1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[grep] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[tar] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[tar] action install (rvm::system_install line 44)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[tar] checking package status for tar
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy tar)
tar:
  Installed: 1.26-4ubuntu1
  Candidate: 1.26-4ubuntu1
  Version table:
 *** 1.26-4ubuntu1 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[tar] current version is 1.26-4ubuntu1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[tar] candidate version is 1.26-4ubuntu1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[tar] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[gzip] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[gzip] action install (rvm::system_install line 44)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[gzip] checking package status for gzip
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy gzip)
gzip:
  Installed: 1.4-1ubuntu2
  Candidate: 1.4-1ubuntu2
  Version table:
 *** 1.4-1ubuntu2 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[gzip] current version is 1.4-1ubuntu2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[gzip] candidate version is 1.4-1ubuntu2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[gzip] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[bzip2] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[bzip2] action install (rvm::system_install line 44)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bzip2] checking package status for bzip2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy bzip2)
bzip2:
  Installed: 1.0.6-1
  Candidate: 1.0.6-1
  Version table:
 *** 1.0.6-1 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bzip2] current version is 1.0.6-1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bzip2] candidate version is 1.0.6-1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bzip2] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[bash] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[bash] action install (rvm::system_install line 44)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bash] checking package status for bash
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy bash)
bash:
  Installed: 4.2-2ubuntu2
  Candidate: 4.2-2ubuntu2
  Version table:
 *** 4.2-2ubuntu2 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bash] current version is 4.2-2ubuntu2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bash] candidate version is 4.2-2ubuntu2
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[bash] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[curl] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[curl] action install (rvm::system_install line 44)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[curl] checking package status for curl
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy curl)
curl:
  Installed: 7.22.0-3ubuntu4
  Candidate: 7.22.0-3ubuntu4
  Version table:
 *** 7.22.0-3ubuntu4 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[curl] current version is 7.22.0-3ubuntu4
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[curl] candidate version is 7.22.0-3ubuntu4
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[curl] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing package[git-core] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing package[git-core] action install (rvm::system_install line 44)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[git-core] checking package status for git-core
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(apt-cache policy git-core)
git-core:
  Installed: 1:1.7.9.5-1
  Candidate: 1:1.7.9.5-1
  Version table:
 *** 1:1.7.9.5-1 0
        500 http://us.archive.ubuntu.com/ubuntu/ precise/main amd64 Packages
        100 /var/lib/dpkg/status
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[git-core] current version is 1:1.7.9.5-1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[git-core] candidate version is 1:1.7.9.5-1
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: package[git-core] is already installed - nothing to do
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing template[/etc/rvmrc] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing template[/etc/rvmrc] action create (rvm::system_install line 135)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Skipping file /tmp/chef-solo/site-cookbooks/rvm/templates/vagrant-chef-solo-wrapper.erb, as it isn't in any of the proper directories (platform-version, platform or default)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: You probably need to move /tmp/chef-solo/site-cookbooks/rvm/templates/vagrant-chef-solo-wrapper.erb into the 'default' sub-directory
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Skipping file /tmp/chef-solo/site-cookbooks/rvm/templates/rvmrc.erb, as it isn't in any of the proper directories (platform-version, platform or default)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: You probably need to move /tmp/chef-solo/site-cookbooks/rvm/templates/rvmrc.erb into the 'default' sub-directory
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Current content's checksum:  c7f218df521751e534c07e5ea2a9c50414bb39b9a459a5a5dfc0d07dbdb26285
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Rendered content's checksum: 5acab945458410b889ba86afd85f9e88a79d8f9b3cd20dadf5b693866e5777af
[Tue, 01 May 2012 16:41:31 -0700] INFO: template[/etc/rvmrc] backed up to /var/chef/backup/etc/rvmrc.chef-20120501164131
[Tue, 01 May 2012 16:41:31 -0700] INFO: template[/etc/rvmrc] removed backup at /var/chef/backup/./etc/rvmrc.chef-20120501152510
[Tue, 01 May 2012 16:41:31 -0700] INFO: template[/etc/rvmrc] mode changed to 644
[Tue, 01 May 2012 16:41:31 -0700] INFO: template[/etc/rvmrc] updated content
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing execute[install system-wide RVM] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing execute[install system-wide RVM] action run (rvm::system_install line 69)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: sh(bash -c "source /etc/profile.d/rvm.sh && type rvm | head -1 | grep -q '^rvm is a function$'")
[Tue, 01 May 2012 16:41:31 -0700] INFO: execute[install system-wide RVM] sh(            bash -c "bash               <( curl -Ls https://rvm.beginrescueend.com/install/rvm )"
)
[Tue, 01 May 2012 16:41:31 -0700] INFO: execute[install system-wide RVM] ran successfully
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing execute[upgrade system-wide RVM to none] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing execute[upgrade system-wide RVM to none] action run (rvm::system_install line 105)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Skipping execute[upgrade system-wide RVM to none] due to only_if ruby block
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Processing rvm_default_ruby[ruby-1.9.3-p194] on ubuntu
[Tue, 01 May 2012 16:41:31 -0700] INFO: Processing rvm_default_ruby[ruby-1.9.3-p194] action create (rvm::system line 32)
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Fetching canonical RVM string for: ruby-1.9.3-p194 (system)
[Tue, 01 May 2012 16:41:31 -0700] ERROR: rvm_default_ruby[ruby-1.9.3-p194] (rvm::system line 32) has had an error
[Tue, 01 May 2012 16:41:31 -0700] ERROR: rvm_default_ruby[ruby-1.9.3-p194] (/tmp/chef-solo/cookbooks/rvm/recipes/system.rb:32:in `from_file') had an error:
rvm_default_ruby[ruby-1.9.3-p194] (rvm::system line 32) had an error: NoMethodError: private method `chomp' called for nil:NilClass
/tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:77:in `canonical_ruby_string'
/tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:50:in `fetch'
/tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_helpers.rb:55:in `normalize_ruby_string'
/tmp/chef-solo/cookbooks/rvm/providers/default_ruby.rb:26:in `load_current_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource.rb:439:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:45:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `each'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:76:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/client.rb:312:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/client.rb:160:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:192:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:183:in `loop'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:183:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application.rb:67:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/chef-solo:25
/usr/bin/chef-solo:19:in `load'
/usr/bin/chef-solo:19
[Tue, 01 May 2012 16:41:31 -0700] ERROR: Running exception handlers
[Tue, 01 May 2012 16:41:31 -0700] ERROR: Exception handlers complete
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: Re-raising exception: NoMethodError - rvm_default_ruby[ruby-1.9.3-p194] (rvm::system line 32) had an error: NoMethodError: private method `chomp' called for nil:NilClass
/tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:77:in `canonical_ruby_string'
  /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:50:in `fetch'
  /tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_helpers.rb:55:in `normalize_ruby_string'
  /tmp/chef-solo/cookbooks/rvm/providers/default_ruby.rb:26:in `load_current_resource'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource.rb:439:in `run_action'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:45:in `run_action'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `converge'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `each'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `converge'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:76:in `converge'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/client.rb:312:in `converge'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/client.rb:160:in `run'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:192:in `run_application'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:183:in `loop'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:183:in `run_application'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application.rb:67:in `run'
  /usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/chef-solo:25
  /usr/bin/chef-solo:19:in `load'
  /usr/bin/chef-solo:19
[Tue, 01 May 2012 16:41:31 -0700] FATAL: Stacktrace dumped to /tmp/chef-solo/chef-stacktrace.out
[Tue, 01 May 2012 16:41:31 -0700] DEBUG: NoMethodError: rvm_default_ruby[ruby-1.9.3-p194] (rvm::system line 32) had an error: NoMethodError: private method `chomp' called for nil:NilClass
/tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:77:in `canonical_ruby_string'
/tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_cache.rb:50:in `fetch'
/tmp/chef-solo/cookbooks/rvm/libraries/chef_rvm_string_helpers.rb:55:in `normalize_ruby_string'
/tmp/chef-solo/cookbooks/rvm/providers/default_ruby.rb:26:in `load_current_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource.rb:439:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:45:in `run_action'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `each'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:81:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection.rb:94:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/resource_collection.rb:92:in `execute_each_resource'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/runner.rb:76:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/client.rb:312:in `converge'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/client.rb:160:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:192:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:183:in `loop'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application/solo.rb:183:in `run_application'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/../lib/chef/application.rb:67:in `run'
/usr/lib/ruby/gems/1.8/gems/chef-0.10.8/bin/chef-solo:25
/usr/bin/chef-solo:19:in `load'
/usr/bin/chef-solo:19
[Tue, 01 May 2012 16:41:31 -0700] FATAL: NoMethodError: rvm_default_ruby[ruby-1.9.3-p194] (rvm::system line 32) had an error: NoMethodError: private method `chomp' called for nil:NilClass
ubuntu@ubuntu:/tmp/chef-solo$